2026-05-08 14:12:46.588708 | Job console starting 2026-05-08 14:12:46.606121 | Updating git repos 2026-05-08 14:12:46.680197 | Cloning repos into workspace 2026-05-08 14:12:46.795594 | Restoring repo states 2026-05-08 14:12:46.853945 | Merging changes 2026-05-08 14:12:47.547219 | Checking out repos 2026-05-08 14:12:47.616003 | Preparing playbooks 2026-05-08 14:12:49.188778 | Running Ansible setup 2026-05-08 14:12:55.543199 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 14:12:56.892671 | 2026-05-08 14:12:56.892811 | PLAY [Base pre] 2026-05-08 14:12:56.926626 | 2026-05-08 14:12:56.926775 | TASK [Setup log path fact] 2026-05-08 14:12:56.955200 | debian-bookworm | ok 2026-05-08 14:12:56.982994 | 2026-05-08 14:12:56.983138 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 14:12:57.040319 | debian-bookworm | ok 2026-05-08 14:12:57.064678 | 2026-05-08 14:12:57.064802 | TASK [emit-job-header : Print job information] 2026-05-08 14:12:57.133375 | # Job Information 2026-05-08 14:12:57.133542 | Ansible Version: 2.16.14 2026-05-08 14:12:57.133576 | Job: python-black 2026-05-08 14:12:57.133609 | Pipeline: check 2026-05-08 14:12:57.133633 | Executor: 521e9411259a 2026-05-08 14:12:57.133654 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/897 2026-05-08 14:12:57.133677 | Event ID: f67b42d0-4ae7-11f1-81d9-0fb1b9d5d394 2026-05-08 14:12:57.138544 | 2026-05-08 14:12:57.138652 | LOOP [emit-job-header : Print node information] 2026-05-08 14:12:57.302152 | debian-bookworm | ok: 2026-05-08 14:12:57.302344 | debian-bookworm | # Node Information 2026-05-08 14:12:57.302377 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 14:12:57.302402 | debian-bookworm | Hostname: debian 2026-05-08 14:12:57.302423 | debian-bookworm | Username: zuul 2026-05-08 14:12:57.302444 | debian-bookworm | Distro: Debian 12.13 2026-05-08 14:12:57.302468 | debian-bookworm | Provider: regiocloud-a 2026-05-08 14:12:57.302489 | debian-bookworm | Region: 2026-05-08 14:12:57.302510 | debian-bookworm | Label: debian-bookworm 2026-05-08 14:12:57.302529 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 14:12:57.302548 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe84:9679 2026-05-08 14:12:57.313595 | 2026-05-08 14:12:57.313704 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 14:12:58.405381 | debian-bookworm -> localhost | changed 2026-05-08 14:12:58.411274 | 2026-05-08 14:12:58.411369 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 14:13:00.222644 | debian-bookworm -> localhost | changed 2026-05-08 14:13:00.231307 | 2026-05-08 14:13:00.231399 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 14:13:00.863680 | debian-bookworm -> localhost | ok 2026-05-08 14:13:00.868731 | 2026-05-08 14:13:00.868821 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 14:13:00.907579 | debian-bookworm | ok 2026-05-08 14:13:00.936622 | debian-bookworm | included: /var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 14:13:00.958054 | 2026-05-08 14:13:00.958155 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 14:13:03.741798 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 14:13:03.741994 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/6e3e2225ad7c453382869e903156503d_id_rsa 2026-05-08 14:13:03.742030 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/6e3e2225ad7c453382869e903156503d_id_rsa.pub 2026-05-08 14:13:03.742057 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 14:13:03.742080 | debian-bookworm -> localhost | SHA256:pJUseUrmT5kizjZN+Uu8fd5CWzzhTslAA7umOxHK7Dc zuul-build-sshkey 2026-05-08 14:13:03.742111 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 14:13:03.742134 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 14:13:03.742155 | debian-bookworm -> localhost | | .. | 2026-05-08 14:13:03.742208 | debian-bookworm -> localhost | | o . .o | 2026-05-08 14:13:03.742240 | debian-bookworm -> localhost | | = * .. . | 2026-05-08 14:13:03.742262 | debian-bookworm -> localhost | | + O.o .. . | 2026-05-08 14:13:03.742283 | debian-bookworm -> localhost | | .oB.S.o = o | 2026-05-08 14:13:03.742308 | debian-bookworm -> localhost | | o ++*.o . O | 2026-05-08 14:13:03.742329 | debian-bookworm -> localhost | | =.. *. . = . | 2026-05-08 14:13:03.742349 | debian-bookworm -> localhost | | . ...E= +.. | 2026-05-08 14:13:03.742370 | debian-bookworm -> localhost | | .+o.o... | 2026-05-08 14:13:03.742389 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 14:13:03.742439 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.760616 2026-05-08 14:13:03.748576 | 2026-05-08 14:13:03.748670 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 14:13:03.780877 | debian-bookworm | ok 2026-05-08 14:13:03.791190 | debian-bookworm | included: /var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 14:13:03.799914 | 2026-05-08 14:13:03.799996 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 14:13:03.813339 | debian-bookworm | skipping: Conditional result was False 2026-05-08 14:13:03.818805 | 2026-05-08 14:13:03.818946 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 14:13:04.413634 | debian-bookworm | changed 2026-05-08 14:13:04.418798 | 2026-05-08 14:13:04.418901 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 14:13:04.707588 | debian-bookworm | ok 2026-05-08 14:13:04.712865 | 2026-05-08 14:13:04.712958 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 14:13:05.450483 | debian-bookworm | changed 2026-05-08 14:13:05.456997 | 2026-05-08 14:13:05.457100 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 14:13:06.162090 | debian-bookworm | changed 2026-05-08 14:13:06.169017 | 2026-05-08 14:13:06.169126 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 14:13:06.202347 | debian-bookworm | skipping: Conditional result was False 2026-05-08 14:13:06.208391 | 2026-05-08 14:13:06.208497 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 14:13:06.669854 | debian-bookworm -> localhost | changed 2026-05-08 14:13:06.680250 | 2026-05-08 14:13:06.680362 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 14:13:07.020025 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/6e3e2225ad7c453382869e903156503d_id_rsa (zuul-build-sshkey) 2026-05-08 14:13:07.020266 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014707 2026-05-08 14:13:07.035707 | 2026-05-08 14:13:07.035811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 14:13:07.508856 | debian-bookworm | ok 2026-05-08 14:13:07.517866 | 2026-05-08 14:13:07.517979 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 14:13:07.561221 | debian-bookworm | skipping: Conditional result was False 2026-05-08 14:13:07.571381 | 2026-05-08 14:13:07.571494 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 14:13:08.016013 | debian-bookworm | ok 2026-05-08 14:13:08.035278 | 2026-05-08 14:13:08.035390 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 14:13:08.063258 | debian-bookworm | ok 2026-05-08 14:13:08.068125 | 2026-05-08 14:13:08.068224 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 14:13:08.357519 | debian-bookworm -> localhost | ok 2026-05-08 14:13:08.362711 | 2026-05-08 14:13:08.362792 | TASK [validate-host : Collect information about the host] 2026-05-08 14:13:09.615986 | debian-bookworm | ok 2026-05-08 14:13:09.629301 | 2026-05-08 14:13:09.629395 | TASK [validate-host : Sanitize hostname] 2026-05-08 14:13:09.816138 | debian-bookworm | ok 2026-05-08 14:13:09.848608 | 2026-05-08 14:13:09.848706 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 14:13:10.664272 | debian-bookworm -> localhost | changed 2026-05-08 14:13:10.668928 | 2026-05-08 14:13:10.669012 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 14:13:11.052358 | debian-bookworm | ok 2026-05-08 14:13:11.057716 | 2026-05-08 14:13:11.057839 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 14:13:11.850353 | debian-bookworm -> localhost | changed 2026-05-08 14:13:11.862019 | 2026-05-08 14:13:11.862127 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 14:13:12.152451 | debian-bookworm | ok 2026-05-08 14:13:12.157753 | 2026-05-08 14:13:12.157892 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 14:13:12.931363 | debian-bookworm | changed: 2026-05-08 14:13:12.931605 | debian-bookworm | cd+++++++++ src/ 2026-05-08 14:13:12.931645 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 14:13:12.931674 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 14:13:12.931699 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-08 14:13:12.931722 | debian-bookworm | Containerfile 2026-05-08 14:13:12.931918 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/logs" 2026-05-08 14:13:39.634365 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/artifacts" 2026-05-08 14:13:40.057540 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/6e3e2225ad7c453382869e903156503d/work/docs" 2026-05-08 14:13:40.079960 | 2026-05-08 14:13:40.080107 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 14:13:40.993324 | debian-bookworm | changed: 2026-05-08 14:13:40.993575 | debian-bookworm | .d..t...... ./ 2026-05-08 14:13:40.993612 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 14:13:40.993641 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 14:13:40.993667 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 14:13:40.993709 | debian-bookworm | changed: All items complete 2026-05-08 14:13:40.993734 | 2026-05-08 14:13:41.583951 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 14:13:42.151251 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 14:13:42.170495 | 2026-05-08 14:13:42.170640 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 14:13:42.699448 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011490 2026-05-08 14:13:43.002282 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009835 2026-05-08 14:13:43.015830 | 2026-05-08 14:13:43.015959 | PLAY RECAP 2026-05-08 14:13:43.016021 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-08 14:13:43.016050 | 2026-05-08 14:13:43.183381 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 14:13:43.185228 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 14:13:43.929666 | 2026-05-08 14:13:43.929843 | PLAY [Base post] 2026-05-08 14:13:43.944193 | 2026-05-08 14:13:43.944355 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 14:13:44.516625 | debian-bookworm | changed 2026-05-08 14:13:44.526249 | 2026-05-08 14:13:44.526396 | PLAY RECAP 2026-05-08 14:13:44.526464 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 14:13:44.526525 | 2026-05-08 14:13:44.667772 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 14:13:44.668708 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 14:13:45.509799 | 2026-05-08 14:13:45.509972 | PLAY [Base post-logs] 2026-05-08 14:13:45.520959 | 2026-05-08 14:13:45.521139 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 14:13:46.122396 | localhost | changed 2026-05-08 14:13:46.132975 | 2026-05-08 14:13:46.133214 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 14:13:46.169400 | localhost | ok 2026-05-08 14:13:46.172690 | 2026-05-08 14:13:46.172801 | TASK [Set zuul-log-path fact] 2026-05-08 14:13:46.188173 | localhost | ok 2026-05-08 14:13:46.196373 | 2026-05-08 14:13:46.196501 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 14:13:46.221736 | localhost | ok 2026-05-08 14:13:46.224929 | 2026-05-08 14:13:46.225041 | TASK [upload-logs : Create log directories] 2026-05-08 14:13:46.833985 | localhost | changed 2026-05-08 14:13:46.839650 | 2026-05-08 14:13:46.839816 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 14:13:47.509663 | localhost -> localhost | ok: Runtime: 0:00:00.005380 2026-05-08 14:13:47.514080 | 2026-05-08 14:13:47.514222 | TASK [upload-logs : Upload logs to log server] 2026-05-08 14:13:48.118318 | localhost | Output suppressed because no_log was given 2026-05-08 14:13:48.120359 | 2026-05-08 14:13:48.120470 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 14:13:48.173904 | localhost | skipping: Conditional result was False 2026-05-08 14:13:48.180096 | localhost | skipping: Conditional result was False 2026-05-08 14:13:48.187535 | 2026-05-08 14:13:48.187659 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 14:13:48.263964 | localhost | skipping: Conditional result was False 2026-05-08 14:13:48.264913 | 2026-05-08 14:13:48.269559 | localhost | skipping: Conditional result was False 2026-05-08 14:13:48.279167 | 2026-05-08 14:13:48.279304 | LOOP [upload-logs : Upload console log and json output]