2026-08-30 10:38:22.574147 | Job console starting 2026-08-30 10:38:22.588071 | Updating git repos 2026-08-30 10:38:22.699258 | Cloning repos into workspace 2026-08-30 10:38:22.869816 | Restoring repo states 2026-08-30 10:38:22.912447 | Merging changes 2026-08-30 10:38:23.954432 | Checking out repos 2026-08-30 10:38:24.194100 | Preparing playbooks 2026-08-30 10:38:27.084101 | Running Ansible setup 2026-08-30 10:38:33.053386 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-30 10:38:34.528354 | 2026-08-30 10:38:34.528538 | PLAY [Base pre] 2026-08-30 10:38:34.563065 | 2026-08-30 10:38:34.563241 | TASK [Setup log path fact] 2026-08-30 10:38:34.603088 | debian-bookworm | ok 2026-08-30 10:38:34.624926 | 2026-08-30 10:38:34.625084 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 10:38:34.672128 | debian-bookworm | ok 2026-08-30 10:38:34.698462 | 2026-08-30 10:38:34.698599 | TASK [emit-job-header : Print job information] 2026-08-30 10:38:34.794504 | # Job Information 2026-08-30 10:38:34.794675 | Ansible Version: 2.16.14 2026-08-30 10:38:34.794709 | Job: python-osism-test-setup 2026-08-30 10:38:34.794767 | Pipeline: check 2026-08-30 10:38:34.794791 | Executor: 521e9411259a 2026-08-30 10:38:34.794812 | Triggered by: https://github.com/osism/python-osism/pull/2647 2026-08-30 10:38:34.802939 | Event ID: e45c6ea0-a45e-11f1-978c-68e38cc8e3a8 2026-08-30 10:38:34.807456 | 2026-08-30 10:38:34.807549 | LOOP [emit-job-header : Print node information] 2026-08-30 10:38:34.999577 | debian-bookworm | ok: 2026-08-30 10:38:34.999783 | debian-bookworm | # Node Information 2026-08-30 10:38:34.999819 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-30 10:38:34.999844 | debian-bookworm | Hostname: debian 2026-08-30 10:38:34.999867 | debian-bookworm | Username: zuul 2026-08-30 10:38:34.999888 | debian-bookworm | Distro: Debian 12.15 2026-08-30 10:38:34.999911 | debian-bookworm | Provider: regiocloud-a 2026-08-30 10:38:34.999933 | debian-bookworm | Region: 2026-08-30 10:38:34.999954 | debian-bookworm | Label: debian-bookworm 2026-08-30 10:38:34.999974 | debian-bookworm | Product Name: OpenStack Nova 2026-08-30 10:38:34.999994 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7e:418d 2026-08-30 10:38:35.011060 | 2026-08-30 10:38:35.011180 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-30 10:38:36.098806 | debian-bookworm -> localhost | changed 2026-08-30 10:38:36.104915 | 2026-08-30 10:38:36.105007 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-30 10:38:37.964706 | debian-bookworm -> localhost | changed 2026-08-30 10:38:37.973454 | 2026-08-30 10:38:37.973544 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-30 10:38:38.744582 | debian-bookworm -> localhost | ok 2026-08-30 10:38:38.750609 | 2026-08-30 10:38:38.750706 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-30 10:38:38.806064 | debian-bookworm | ok 2026-08-30 10:38:38.850691 | debian-bookworm | included: /var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-30 10:38:38.857613 | 2026-08-30 10:38:38.857727 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-30 10:38:41.276662 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-30 10:38:41.277997 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/ead6b9aa747348ab81978b9bdc204659_id_rsa 2026-08-30 10:38:41.278061 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/ead6b9aa747348ab81978b9bdc204659_id_rsa.pub 2026-08-30 10:38:41.278090 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-30 10:38:41.278116 | debian-bookworm -> localhost | SHA256:eXEE7yM8hbHE65Gwx3g5wL2n884GdcZZ48mJ15G5IvI zuul-build-sshkey 2026-08-30 10:38:41.278139 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-30 10:38:41.278173 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-30 10:38:41.278195 | debian-bookworm -> localhost | | . o+.. o| 2026-08-30 10:38:41.278217 | debian-bookworm -> localhost | | +.o* =.| 2026-08-30 10:38:41.278238 | debian-bookworm -> localhost | | *+=+.+oB| 2026-08-30 10:38:41.278257 | debian-bookworm -> localhost | | o+@*oo=B.| 2026-08-30 10:38:41.278277 | debian-bookworm -> localhost | | S+B*+oo | 2026-08-30 10:38:41.278302 | debian-bookworm -> localhost | | .=E . | 2026-08-30 10:38:41.278323 | debian-bookworm -> localhost | | + | 2026-08-30 10:38:41.278342 | debian-bookworm -> localhost | | .o | 2026-08-30 10:38:41.278362 | debian-bookworm -> localhost | | oo | 2026-08-30 10:38:41.278382 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-30 10:38:41.278433 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.514939 2026-08-30 10:38:41.287817 | 2026-08-30 10:38:41.287987 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-30 10:38:41.315531 | debian-bookworm | ok 2026-08-30 10:38:41.325200 | debian-bookworm | included: /var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-30 10:38:41.332068 | 2026-08-30 10:38:41.332157 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-30 10:38:41.344985 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:38:41.349601 | 2026-08-30 10:38:41.349674 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-30 10:38:42.029279 | debian-bookworm | changed 2026-08-30 10:38:42.034633 | 2026-08-30 10:38:42.034733 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-30 10:38:42.369582 | debian-bookworm | ok 2026-08-30 10:38:42.376528 | 2026-08-30 10:38:42.376631 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-30 10:38:43.054352 | debian-bookworm | changed 2026-08-30 10:38:43.059843 | 2026-08-30 10:38:43.059942 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-30 10:38:43.744288 | debian-bookworm | changed 2026-08-30 10:38:43.749684 | 2026-08-30 10:38:43.749788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-30 10:38:43.798972 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:38:43.807187 | 2026-08-30 10:38:43.807301 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-30 10:38:44.801822 | debian-bookworm -> localhost | changed 2026-08-30 10:38:44.813140 | 2026-08-30 10:38:44.813254 | TASK [add-build-sshkey : Add back temp key] 2026-08-30 10:38:45.367603 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/ead6b9aa747348ab81978b9bdc204659_id_rsa (zuul-build-sshkey) 2026-08-30 10:38:45.367841 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012286 2026-08-30 10:38:45.375844 | 2026-08-30 10:38:45.375947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-30 10:38:45.949357 | debian-bookworm | ok 2026-08-30 10:38:45.955406 | 2026-08-30 10:38:45.955507 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-30 10:38:45.978858 | debian-bookworm | skipping: Conditional result was False 2026-08-30 10:38:45.988870 | 2026-08-30 10:38:45.988976 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-30 10:38:46.448498 | debian-bookworm | ok 2026-08-30 10:38:46.462990 | 2026-08-30 10:38:46.463092 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-30 10:38:46.501794 | debian-bookworm | ok 2026-08-30 10:38:46.507017 | 2026-08-30 10:38:46.507103 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-30 10:38:47.249880 | debian-bookworm -> localhost | ok 2026-08-30 10:38:47.257079 | 2026-08-30 10:38:47.257213 | TASK [validate-host : Collect information about the host] 2026-08-30 10:38:48.465331 | debian-bookworm | ok 2026-08-30 10:38:48.489850 | 2026-08-30 10:38:48.489950 | TASK [validate-host : Sanitize hostname] 2026-08-30 10:38:48.691344 | debian-bookworm | ok 2026-08-30 10:38:48.700364 | 2026-08-30 10:38:48.700473 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-30 10:38:49.639468 | debian-bookworm -> localhost | changed 2026-08-30 10:38:49.644313 | 2026-08-30 10:38:49.644394 | TASK [validate-host : Collect information about zuul worker] 2026-08-30 10:38:50.182030 | debian-bookworm | ok 2026-08-30 10:38:50.189471 | 2026-08-30 10:38:50.189571 | TASK [validate-host : Write out all zuul information for each host] 2026-08-30 10:38:50.913863 | debian-bookworm -> localhost | changed 2026-08-30 10:38:50.937186 | 2026-08-30 10:38:50.937295 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-30 10:38:51.229456 | debian-bookworm | ok 2026-08-30 10:38:51.236942 | 2026-08-30 10:38:51.237046 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-30 10:38:53.417053 | debian-bookworm | changed: 2026-08-30 10:38:53.417238 | debian-bookworm | cd+++++++++ src/ 2026-08-30 10:38:53.417272 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-30 10:38:53.417297 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-30 10:38:53.417318 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-30 10:38:53.417339 | debian-bookworm | Containerfile 2026-08-30 10:38:53.417468 | debian-bookworm | Containerfile 2026-08-30 10:38:53.441143 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/logs" 2026-08-30 10:41:38.643538 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/artifacts" 2026-08-30 10:41:38.979751 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ead6b9aa747348ab81978b9bdc204659/work/docs" 2026-08-30 10:41:38.993139 | 2026-08-30 10:41:38.993271 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-30 10:41:39.847983 | debian-bookworm | changed: 2026-08-30 10:41:39.848238 | debian-bookworm | .d..t...... ./ 2026-08-30 10:41:39.848275 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-30 10:41:39.848299 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-30 10:41:39.848320 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-30 10:41:39.848340 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-30 10:41:39.848360 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-30 10:41:39.848405 | debian-bookworm | changed: All items complete 2026-08-30 10:41:39.848431 | 2026-08-30 10:41:40.467574 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 10:41:41.127656 | debian-bookworm | changed: .d..t...... ./ 2026-08-30 10:41:41.148107 | 2026-08-30 10:41:41.148314 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-30 10:41:41.711459 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007318 2026-08-30 10:41:42.006747 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008143 2026-08-30 10:41:42.019749 | 2026-08-30 10:41:42.020202 | PLAY RECAP 2026-08-30 10:41:42.020290 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-30 10:41:42.020318 | 2026-08-30 10:41:42.200349 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-30 10:41:42.201346 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 10:41:43.102026 | 2026-08-30 10:41:43.102820 | PLAY [Base post] 2026-08-30 10:41:43.123919 | 2026-08-30 10:41:43.124131 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-30 10:41:43.983597 | debian-bookworm | changed 2026-08-30 10:41:43.991660 | 2026-08-30 10:41:43.991782 | PLAY RECAP 2026-08-30 10:41:43.991847 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-30 10:41:43.991909 | 2026-08-30 10:41:44.147900 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-30 10:41:44.149769 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-30 10:41:45.099276 | 2026-08-30 10:41:45.099454 | PLAY [Base post-logs] 2026-08-30 10:41:45.115845 | 2026-08-30 10:41:45.116070 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-30 10:41:45.931124 | localhost | changed 2026-08-30 10:41:45.941922 | 2026-08-30 10:41:45.942130 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-30 10:41:45.968832 | localhost | ok 2026-08-30 10:41:45.972198 | 2026-08-30 10:41:45.972307 | TASK [Set zuul-log-path fact] 2026-08-30 10:41:45.988872 | localhost | ok 2026-08-30 10:41:46.015469 | 2026-08-30 10:41:46.015738 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-30 10:41:46.045134 | localhost | ok 2026-08-30 10:41:46.050554 | 2026-08-30 10:41:46.050737 | TASK [upload-logs : Create log directories] 2026-08-30 10:41:46.636279 | localhost | changed 2026-08-30 10:41:46.640043 | 2026-08-30 10:41:46.640173 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-30 10:41:47.226238 | localhost -> localhost | ok: Runtime: 0:00:00.005195 2026-08-30 10:41:47.231424 | 2026-08-30 10:41:47.231572 | TASK [upload-logs : Upload logs to log server] 2026-08-30 10:41:47.886033 | localhost | Output suppressed because no_log was given 2026-08-30 10:41:47.890366 | 2026-08-30 10:41:47.890595 | LOOP [upload-logs : Compress console log and json output] 2026-08-30 10:41:47.970115 | localhost | skipping: Conditional result was False 2026-08-30 10:41:47.978599 | localhost | skipping: Conditional result was False 2026-08-30 10:41:47.992237 | 2026-08-30 10:41:47.992384 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-30 10:41:48.040024 | localhost | skipping: Conditional result was False 2026-08-30 10:41:48.040325 | 2026-08-30 10:41:48.045944 | localhost | skipping: Conditional result was False 2026-08-30 10:41:48.053571 | 2026-08-30 10:41:48.053716 | LOOP [upload-logs : Upload console log and json output]