2026-06-19 16:52:55.012344 | Job console starting 2026-06-19 16:52:55.040466 | Updating git repos 2026-06-19 16:52:55.094522 | Cloning repos into workspace 2026-06-19 16:52:55.166028 | Restoring repo states 2026-06-19 16:52:55.176012 | Merging changes 2026-06-19 16:52:55.796826 | Checking out repos 2026-06-19 16:52:55.829425 | Preparing playbooks 2026-06-19 16:52:56.667525 | Running Ansible setup 2026-06-19 16:53:02.815775 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-19 16:53:04.091295 | 2026-06-19 16:53:04.091423 | PLAY [Base pre] 2026-06-19 16:53:04.112038 | 2026-06-19 16:53:04.112171 | TASK [Setup log path fact] 2026-06-19 16:53:04.130072 | debian-bookworm | ok 2026-06-19 16:53:04.147214 | 2026-06-19 16:53:04.147374 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-19 16:53:04.205758 | debian-bookworm | ok 2026-06-19 16:53:04.217656 | 2026-06-19 16:53:04.217757 | TASK [emit-job-header : Print job information] 2026-06-19 16:53:04.256194 | # Job Information 2026-06-19 16:53:04.256334 | Ansible Version: 2.16.14 2026-06-19 16:53:04.256364 | Job: python-black 2026-06-19 16:53:04.256393 | Pipeline: check 2026-06-19 16:53:04.256461 | Executor: 521e9411259a 2026-06-19 16:53:04.256483 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1227 2026-06-19 16:53:04.256502 | Event ID: 2a7d8e20-6bff-11f1-8a39-c7868d3e1a15 2026-06-19 16:53:04.261006 | 2026-06-19 16:53:04.261118 | LOOP [emit-job-header : Print node information] 2026-06-19 16:53:04.504704 | debian-bookworm | ok: 2026-06-19 16:53:04.504925 | debian-bookworm | # Node Information 2026-06-19 16:53:04.504958 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-19 16:53:04.504979 | debian-bookworm | Hostname: debian 2026-06-19 16:53:04.504997 | debian-bookworm | Username: zuul 2026-06-19 16:53:04.505015 | debian-bookworm | Distro: Debian 12.14 2026-06-19 16:53:04.505034 | debian-bookworm | Provider: regiocloud-a 2026-06-19 16:53:04.505063 | debian-bookworm | Region: 2026-06-19 16:53:04.505081 | debian-bookworm | Label: debian-bookworm 2026-06-19 16:53:04.505098 | debian-bookworm | Product Name: OpenStack Nova 2026-06-19 16:53:04.505114 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb9:1270 2026-06-19 16:53:04.525996 | 2026-06-19 16:53:04.526127 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-19 16:53:05.269866 | debian-bookworm -> localhost | changed 2026-06-19 16:53:05.276827 | 2026-06-19 16:53:05.276932 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-19 16:53:06.236468 | debian-bookworm -> localhost | changed 2026-06-19 16:53:06.246031 | 2026-06-19 16:53:06.246160 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-19 16:53:06.506770 | debian-bookworm -> localhost | ok 2026-06-19 16:53:06.518544 | 2026-06-19 16:53:06.518715 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-19 16:53:06.540028 | debian-bookworm | ok 2026-06-19 16:53:06.554764 | debian-bookworm | included: /var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-19 16:53:06.561908 | 2026-06-19 16:53:06.561988 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-19 16:53:07.763327 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-19 16:53:07.763524 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/38870e4d9f154582ad3009d5de4074cb_id_rsa 2026-06-19 16:53:07.763562 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/38870e4d9f154582ad3009d5de4074cb_id_rsa.pub 2026-06-19 16:53:07.763589 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-19 16:53:07.763614 | debian-bookworm -> localhost | SHA256:QbQjTm37NG3wjtAsVDjvI6w3j0N4JUXsuqRUap9vMVE zuul-build-sshkey 2026-06-19 16:53:07.763637 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-19 16:53:07.763667 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-19 16:53:07.763689 | debian-bookworm -> localhost | | .o+o | 2026-06-19 16:53:07.763710 | debian-bookworm -> localhost | | oooo E | 2026-06-19 16:53:07.763730 | debian-bookworm -> localhost | | o B=.. | 2026-06-19 16:53:07.763750 | debian-bookworm -> localhost | | o +o*=+ | 2026-06-19 16:53:07.763770 | debian-bookworm -> localhost | | .=S==.+ | 2026-06-19 16:53:07.763794 | debian-bookworm -> localhost | | = B=== | 2026-06-19 16:53:07.763814 | debian-bookworm -> localhost | | o B +o+. | 2026-06-19 16:53:07.763835 | debian-bookworm -> localhost | | o B.. | 2026-06-19 16:53:07.763855 | debian-bookworm -> localhost | | ..*o | 2026-06-19 16:53:07.763876 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-19 16:53:07.763923 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.745940 2026-06-19 16:53:07.770641 | 2026-06-19 16:53:07.770827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-19 16:53:07.800511 | debian-bookworm | ok 2026-06-19 16:53:07.812579 | debian-bookworm | included: /var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-19 16:53:07.823722 | 2026-06-19 16:53:07.823816 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-19 16:53:07.848203 | debian-bookworm | skipping: Conditional result was False 2026-06-19 16:53:07.855930 | 2026-06-19 16:53:07.856067 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-19 16:53:08.665266 | debian-bookworm | changed 2026-06-19 16:53:08.673949 | 2026-06-19 16:53:08.674091 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-19 16:53:08.940266 | debian-bookworm | ok 2026-06-19 16:53:08.948890 | 2026-06-19 16:53:08.949019 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-19 16:53:09.660885 | debian-bookworm | changed 2026-06-19 16:53:09.667797 | 2026-06-19 16:53:09.667907 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-19 16:53:10.364633 | debian-bookworm | changed 2026-06-19 16:53:10.370536 | 2026-06-19 16:53:10.370629 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-19 16:53:10.393995 | debian-bookworm | skipping: Conditional result was False 2026-06-19 16:53:10.400316 | 2026-06-19 16:53:10.400416 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-19 16:53:11.025657 | debian-bookworm -> localhost | changed 2026-06-19 16:53:11.042643 | 2026-06-19 16:53:11.042786 | TASK [add-build-sshkey : Add back temp key] 2026-06-19 16:53:11.539747 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/38870e4d9f154582ad3009d5de4074cb_id_rsa (zuul-build-sshkey) 2026-06-19 16:53:11.540172 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016023 2026-06-19 16:53:11.554260 | 2026-06-19 16:53:11.554730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-19 16:53:12.092105 | debian-bookworm | ok 2026-06-19 16:53:12.099280 | 2026-06-19 16:53:12.099414 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-19 16:53:12.137466 | debian-bookworm | skipping: Conditional result was False 2026-06-19 16:53:12.156979 | 2026-06-19 16:53:12.157150 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-19 16:53:12.713757 | debian-bookworm | ok 2026-06-19 16:53:12.726747 | 2026-06-19 16:53:12.726903 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-19 16:53:12.768088 | debian-bookworm | ok 2026-06-19 16:53:12.774711 | 2026-06-19 16:53:12.774895 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-19 16:53:13.097061 | debian-bookworm -> localhost | ok 2026-06-19 16:53:13.104462 | 2026-06-19 16:53:13.104589 | TASK [validate-host : Collect information about the host] 2026-06-19 16:53:14.353112 | debian-bookworm | ok 2026-06-19 16:53:14.375551 | 2026-06-19 16:53:14.375702 | TASK [validate-host : Sanitize hostname] 2026-06-19 16:53:14.548825 | debian-bookworm | ok 2026-06-19 16:53:14.553825 | 2026-06-19 16:53:14.553940 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-19 16:53:15.363871 | debian-bookworm -> localhost | changed 2026-06-19 16:53:15.373840 | 2026-06-19 16:53:15.373992 | TASK [validate-host : Collect information about zuul worker] 2026-06-19 16:53:15.849089 | debian-bookworm | ok 2026-06-19 16:53:15.854411 | 2026-06-19 16:53:15.854541 | TASK [validate-host : Write out all zuul information for each host] 2026-06-19 16:53:16.586335 | debian-bookworm -> localhost | changed 2026-06-19 16:53:16.601634 | 2026-06-19 16:53:16.601793 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-19 16:53:16.893148 | debian-bookworm | ok 2026-06-19 16:53:16.900842 | 2026-06-19 16:53:16.900983 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-19 16:53:17.884749 | debian-bookworm | changed: 2026-06-19 16:53:17.885361 | debian-bookworm | cd+++++++++ src/ 2026-06-19 16:53:17.885519 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-19 16:53:17.885566 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-19 16:53:17.885606 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-19 16:53:17.885642 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/logs" 2026-06-19 16:54:35.307163 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/artifacts" 2026-06-19 16:54:36.019419 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/38870e4d9f154582ad3009d5de4074cb/work/docs" 2026-06-19 16:54:36.041015 | 2026-06-19 16:54:36.041757 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-19 16:54:36.964765 | debian-bookworm | changed: 2026-06-19 16:54:36.965011 | debian-bookworm | .d..t...... ./ 2026-06-19 16:54:36.965050 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-19 16:54:36.965074 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-19 16:54:36.965095 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-19 16:54:36.965116 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-19 16:54:36.965136 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-19 16:54:36.965176 | debian-bookworm | changed: All items complete 2026-06-19 16:54:36.965202 | 2026-06-19 16:54:37.514138 | debian-bookworm | changed: .d..t...... ./ 2026-06-19 16:54:38.248674 | debian-bookworm | changed: .d..t...... ./ 2026-06-19 16:54:38.270419 | 2026-06-19 16:54:38.270540 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-19 16:54:38.987021 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005175 2026-06-19 16:54:39.252638 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.005246 2026-06-19 16:54:39.261980 | 2026-06-19 16:54:39.262058 | PLAY RECAP 2026-06-19 16:54:39.262099 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-19 16:54:39.262120 | 2026-06-19 16:54:39.361419 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-19 16:54:39.362209 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-19 16:54:40.040104 | 2026-06-19 16:54:40.040254 | PLAY [Base post] 2026-06-19 16:54:40.053216 | 2026-06-19 16:54:40.053345 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-19 16:54:40.599660 | debian-bookworm | changed 2026-06-19 16:54:40.606426 | 2026-06-19 16:54:40.606539 | PLAY RECAP 2026-06-19 16:54:40.606599 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-19 16:54:40.606660 | 2026-06-19 16:54:40.739613 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-19 16:54:40.740421 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-19 16:54:41.548963 | 2026-06-19 16:54:41.549108 | PLAY [Base post-logs] 2026-06-19 16:54:41.569173 | 2026-06-19 16:54:41.569313 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-19 16:54:42.048997 | localhost | changed 2026-06-19 16:54:42.058673 | 2026-06-19 16:54:42.058804 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-19 16:54:42.085656 | localhost | ok 2026-06-19 16:54:42.088895 | 2026-06-19 16:54:42.088997 | TASK [Set zuul-log-path fact] 2026-06-19 16:54:42.103173 | localhost | ok 2026-06-19 16:54:42.111569 | 2026-06-19 16:54:42.111675 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-19 16:54:42.136014 | localhost | ok 2026-06-19 16:54:42.139440 | 2026-06-19 16:54:42.139529 | TASK [upload-logs : Create log directories] 2026-06-19 16:54:42.624466 | localhost | changed 2026-06-19 16:54:42.630203 | 2026-06-19 16:54:42.630370 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-19 16:54:43.185474 | localhost -> localhost | ok: Runtime: 0:00:00.013746 2026-06-19 16:54:43.189656 | 2026-06-19 16:54:43.189761 | TASK [upload-logs : Upload logs to log server] 2026-06-19 16:54:43.789519 | localhost | Output suppressed because no_log was given 2026-06-19 16:54:43.791570 | 2026-06-19 16:54:43.791666 | LOOP [upload-logs : Compress console log and json output] 2026-06-19 16:54:43.966650 | localhost | skipping: Conditional result was False 2026-06-19 16:54:43.974007 | localhost | skipping: Conditional result was False 2026-06-19 16:54:43.979177 | 2026-06-19 16:54:43.979301 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-19 16:54:44.078452 | localhost | skipping: Conditional result was False 2026-06-19 16:54:44.078726 | 2026-06-19 16:54:44.092242 | localhost | skipping: Conditional result was False 2026-06-19 16:54:44.096350 | 2026-06-19 16:54:44.096488 | LOOP [upload-logs : Upload console log and json output]