2026-07-12 03:23:39.617096 | Job console starting 2026-07-12 03:23:39.644379 | Updating git repos 2026-07-12 03:23:39.681390 | Cloning repos into workspace 2026-07-12 03:23:39.727032 | Restoring repo states 2026-07-12 03:23:39.741469 | Merging changes 2026-07-12 03:23:39.741494 | Checking out repos 2026-07-12 03:23:39.781133 | Preparing playbooks 2026-07-12 03:23:41.048570 | Running Ansible setup 2026-07-12 03:23:47.322571 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-12 03:23:48.723333 | 2026-07-12 03:23:48.723485 | PLAY [Base pre] 2026-07-12 03:23:48.743652 | 2026-07-12 03:23:48.743787 | TASK [Setup log path fact] 2026-07-12 03:23:48.778238 | debian-bookworm | ok 2026-07-12 03:23:48.803223 | 2026-07-12 03:23:48.803385 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-12 03:23:48.853191 | debian-bookworm | ok 2026-07-12 03:23:48.866106 | 2026-07-12 03:23:48.866228 | TASK [emit-job-header : Print job information] 2026-07-12 03:23:48.921336 | # Job Information 2026-07-12 03:23:48.921519 | Ansible Version: 2.16.14 2026-07-12 03:23:48.921554 | Job: python-black 2026-07-12 03:23:48.921588 | Pipeline: periodic-daily 2026-07-12 03:23:48.921611 | Executor: 521e9411259a 2026-07-12 03:23:48.921632 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-12 03:23:48.921654 | Event ID: d8f7a06bdc96445297be78bc7e400fce 2026-07-12 03:23:48.926821 | 2026-07-12 03:23:48.926957 | LOOP [emit-job-header : Print node information] 2026-07-12 03:23:49.039744 | debian-bookworm | ok: 2026-07-12 03:23:49.039989 | debian-bookworm | # Node Information 2026-07-12 03:23:49.040042 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-12 03:23:49.040075 | debian-bookworm | Hostname: debian 2026-07-12 03:23:49.040103 | debian-bookworm | Username: zuul 2026-07-12 03:23:49.040129 | debian-bookworm | Distro: Debian 12.14 2026-07-12 03:23:49.040162 | debian-bookworm | Provider: regiocloud-a 2026-07-12 03:23:49.040188 | debian-bookworm | Region: 2026-07-12 03:23:49.040213 | debian-bookworm | Label: debian-bookworm 2026-07-12 03:23:49.040239 | debian-bookworm | Product Name: OpenStack Nova 2026-07-12 03:23:49.040272 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe47:f6d1 2026-07-12 03:23:49.055920 | 2026-07-12 03:23:49.056043 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-12 03:23:49.517689 | debian-bookworm -> localhost | changed 2026-07-12 03:23:49.533373 | 2026-07-12 03:23:49.533496 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-12 03:23:51.469818 | debian-bookworm -> localhost | changed 2026-07-12 03:23:51.482759 | 2026-07-12 03:23:51.482882 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-12 03:23:52.440111 | debian-bookworm -> localhost | ok 2026-07-12 03:23:52.446453 | 2026-07-12 03:23:52.446557 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-12 03:23:52.488589 | debian-bookworm | ok 2026-07-12 03:23:52.534498 | debian-bookworm | included: /var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-12 03:23:52.559435 | 2026-07-12 03:23:52.559544 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-12 03:23:54.090433 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-12 03:23:54.090647 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/9e3518090d154e6d87a0368a35570786_id_rsa 2026-07-12 03:23:54.090684 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/9e3518090d154e6d87a0368a35570786_id_rsa.pub 2026-07-12 03:23:54.090710 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-12 03:23:54.090734 | debian-bookworm -> localhost | SHA256:7iKx/G3myaohW3sPfMb7vdmZW6lRTYC2RlKdsghXi/w zuul-build-sshkey 2026-07-12 03:23:54.090756 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-12 03:23:54.090789 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-12 03:23:54.090811 | debian-bookworm -> localhost | | ooo.. | 2026-07-12 03:23:54.090855 | debian-bookworm -> localhost | | ..o.=.o. | 2026-07-12 03:23:54.090879 | debian-bookworm -> localhost | | oo=.+ .| 2026-07-12 03:23:54.090899 | debian-bookworm -> localhost | | ..+ ..| 2026-07-12 03:23:54.090920 | debian-bookworm -> localhost | | S .E ..| 2026-07-12 03:23:54.090945 | debian-bookworm -> localhost | | .. o . .| 2026-07-12 03:23:54.090966 | debian-bookworm -> localhost | | ..ooo = . ..| 2026-07-12 03:23:54.090986 | debian-bookworm -> localhost | | ++ooBoo . oo+ | 2026-07-12 03:23:54.091007 | debian-bookworm -> localhost | | . o=oBO.. +o=. | 2026-07-12 03:23:54.091027 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-12 03:23:54.091077 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.650752 2026-07-12 03:23:54.098384 | 2026-07-12 03:23:54.098482 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-12 03:23:54.129300 | debian-bookworm | ok 2026-07-12 03:23:54.149785 | debian-bookworm | included: /var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-12 03:23:54.167761 | 2026-07-12 03:23:54.167871 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-12 03:23:54.191429 | debian-bookworm | skipping: Conditional result was False 2026-07-12 03:23:54.197905 | 2026-07-12 03:23:54.198002 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-12 03:23:54.830468 | debian-bookworm | changed 2026-07-12 03:23:54.845997 | 2026-07-12 03:23:54.846107 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-12 03:23:55.140639 | debian-bookworm | ok 2026-07-12 03:23:55.148222 | 2026-07-12 03:23:55.148330 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-12 03:23:55.810635 | debian-bookworm | changed 2026-07-12 03:23:55.817531 | 2026-07-12 03:23:55.817613 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-12 03:23:56.460815 | debian-bookworm | changed 2026-07-12 03:23:56.472093 | 2026-07-12 03:23:56.472195 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-12 03:23:56.519248 | debian-bookworm | skipping: Conditional result was False 2026-07-12 03:23:56.527854 | 2026-07-12 03:23:56.527959 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-12 03:23:57.293605 | debian-bookworm -> localhost | changed 2026-07-12 03:23:57.304311 | 2026-07-12 03:23:57.304418 | TASK [add-build-sshkey : Add back temp key] 2026-07-12 03:23:57.914417 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/9e3518090d154e6d87a0368a35570786_id_rsa (zuul-build-sshkey) 2026-07-12 03:23:57.914656 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021347 2026-07-12 03:23:57.922518 | 2026-07-12 03:23:57.922614 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-12 03:23:58.329913 | debian-bookworm | ok 2026-07-12 03:23:58.352504 | 2026-07-12 03:23:58.352622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-12 03:23:58.406704 | debian-bookworm | skipping: Conditional result was False 2026-07-12 03:23:58.417802 | 2026-07-12 03:23:58.417946 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-12 03:23:58.921573 | debian-bookworm | ok 2026-07-12 03:23:58.938575 | 2026-07-12 03:23:58.938698 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-12 03:23:58.985545 | debian-bookworm | ok 2026-07-12 03:23:58.996160 | 2026-07-12 03:23:58.996277 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-12 03:23:59.299335 | debian-bookworm -> localhost | ok 2026-07-12 03:23:59.305859 | 2026-07-12 03:23:59.305958 | TASK [validate-host : Collect information about the host] 2026-07-12 03:24:00.428927 | debian-bookworm | ok 2026-07-12 03:24:00.448707 | 2026-07-12 03:24:00.448810 | TASK [validate-host : Sanitize hostname] 2026-07-12 03:24:00.635581 | debian-bookworm | ok 2026-07-12 03:24:00.640065 | 2026-07-12 03:24:00.640153 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-12 03:24:01.373065 | debian-bookworm -> localhost | changed 2026-07-12 03:24:01.379411 | 2026-07-12 03:24:01.379513 | TASK [validate-host : Collect information about zuul worker] 2026-07-12 03:24:01.874166 | debian-bookworm | ok 2026-07-12 03:24:01.908150 | 2026-07-12 03:24:01.908297 | TASK [validate-host : Write out all zuul information for each host] 2026-07-12 03:24:02.831989 | debian-bookworm -> localhost | changed 2026-07-12 03:24:02.841771 | 2026-07-12 03:24:02.841885 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-12 03:24:03.116175 | debian-bookworm | ok 2026-07-12 03:24:03.124796 | 2026-07-12 03:24:03.124894 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-12 03:24:03.957657 | debian-bookworm | changed: 2026-07-12 03:24:03.957880 | debian-bookworm | cd+++++++++ src/ 2026-07-12 03:24:03.957924 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-12 03:24:03.957955 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-12 03:24:03.957983 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-12 03:24:03.958008 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/logs" 2026-07-12 03:25:07.822176 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/artifacts" 2026-07-12 03:25:08.688540 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9e3518090d154e6d87a0368a35570786/work/docs" 2026-07-12 03:25:08.743135 | 2026-07-12 03:25:08.743323 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-12 03:25:10.072851 | debian-bookworm | changed: 2026-07-12 03:25:10.073145 | debian-bookworm | .d..t...... ./ 2026-07-12 03:25:10.073178 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-12 03:25:10.073199 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-12 03:25:10.073217 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-12 03:25:10.073236 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-12 03:25:10.073253 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-12 03:25:10.073307 | debian-bookworm | changed: All items complete 2026-07-12 03:25:10.073328 | 2026-07-12 03:25:11.384914 | debian-bookworm | changed: .d..t...... ./ 2026-07-12 03:25:12.088927 | debian-bookworm | changed: .d..t...... ./ 2026-07-12 03:25:12.109497 | 2026-07-12 03:25:12.109604 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-12 03:25:12.149840 | debian-bookworm | skipping: Conditional result was False 2026-07-12 03:25:12.163348 | debian-bookworm | skipping: Conditional result was False 2026-07-12 03:25:12.183380 | 2026-07-12 03:25:12.183477 | PLAY RECAP 2026-07-12 03:25:12.183529 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-12 03:25:12.183554 | 2026-07-12 03:25:12.351150 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-12 03:25:12.353870 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-12 03:25:13.192438 | 2026-07-12 03:25:13.192578 | PLAY [Base post] 2026-07-12 03:25:13.239406 | 2026-07-12 03:25:13.239546 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-12 03:25:14.214209 | debian-bookworm | changed 2026-07-12 03:25:14.219902 | 2026-07-12 03:25:14.219983 | PLAY RECAP 2026-07-12 03:25:14.220033 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-12 03:25:14.220084 | 2026-07-12 03:25:14.540550 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-12 03:25:14.541879 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-12 03:25:15.459721 | 2026-07-12 03:25:15.459848 | PLAY [Base post-logs] 2026-07-12 03:25:15.469808 | 2026-07-12 03:25:15.469905 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-12 03:25:15.865778 | localhost | changed 2026-07-12 03:25:15.874491 | 2026-07-12 03:25:15.874618 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-12 03:25:15.899025 | localhost | ok 2026-07-12 03:25:15.901845 | 2026-07-12 03:25:15.901929 | TASK [Set zuul-log-path fact] 2026-07-12 03:25:15.941416 | localhost | ok 2026-07-12 03:25:15.948505 | 2026-07-12 03:25:15.948598 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-12 03:25:15.985047 | localhost | ok 2026-07-12 03:25:15.990541 | 2026-07-12 03:25:15.990641 | TASK [upload-logs : Create log directories] 2026-07-12 03:25:17.209620 | localhost | changed 2026-07-12 03:25:17.212362 | 2026-07-12 03:25:17.212461 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-12 03:25:17.897950 | localhost -> localhost | ok: Runtime: 0:00:00.014987 2026-07-12 03:25:17.913847 | 2026-07-12 03:25:17.913969 | TASK [upload-logs : Upload logs to log server] 2026-07-12 03:25:18.767241 | localhost | Output suppressed because no_log was given 2026-07-12 03:25:18.768977 | 2026-07-12 03:25:18.769068 | LOOP [upload-logs : Compress console log and json output] 2026-07-12 03:25:18.831216 | localhost | skipping: Conditional result was False 2026-07-12 03:25:18.849151 | localhost | skipping: Conditional result was False 2026-07-12 03:25:18.856420 | 2026-07-12 03:25:18.856536 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-12 03:25:18.992095 | localhost | skipping: Conditional result was False 2026-07-12 03:25:18.992374 | 2026-07-12 03:25:19.011380 | localhost | skipping: Conditional result was False 2026-07-12 03:25:19.017989 | 2026-07-12 03:25:19.018095 | LOOP [upload-logs : Upload console log and json output]