2026-05-06 03:16:07.780731 | Job console starting 2026-05-06 03:16:07.808241 | Updating git repos 2026-05-06 03:16:07.860188 | Cloning repos into workspace 2026-05-06 03:16:08.013009 | Restoring repo states 2026-05-06 03:16:08.045283 | Merging changes 2026-05-06 03:16:08.045306 | Checking out repos 2026-05-06 03:16:08.088946 | Preparing playbooks 2026-05-06 03:16:09.488717 | Running Ansible setup 2026-05-06 03:16:15.555288 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-06 03:16:16.901876 | 2026-05-06 03:16:16.902058 | PLAY [Base pre] 2026-05-06 03:16:16.945068 | 2026-05-06 03:16:16.945240 | TASK [Setup log path fact] 2026-05-06 03:16:16.995867 | debian-bookworm | ok 2026-05-06 03:16:17.042159 | 2026-05-06 03:16:17.049848 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 03:16:17.152123 | debian-bookworm | ok 2026-05-06 03:16:17.183225 | 2026-05-06 03:16:17.183410 | TASK [emit-job-header : Print job information] 2026-05-06 03:16:17.314316 | # Job Information 2026-05-06 03:16:17.314539 | Ansible Version: 2.16.14 2026-05-06 03:16:17.314577 | Job: python-black 2026-05-06 03:16:17.314609 | Pipeline: periodic-daily 2026-05-06 03:16:17.314632 | Executor: 521e9411259a 2026-05-06 03:16:17.314653 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-06 03:16:17.314678 | Event ID: d039b17f07384ead90a5cc9b84568654 2026-05-06 03:16:17.320519 | 2026-05-06 03:16:17.320662 | LOOP [emit-job-header : Print node information] 2026-05-06 03:16:17.505387 | debian-bookworm | ok: 2026-05-06 03:16:17.505685 | debian-bookworm | # Node Information 2026-05-06 03:16:17.505724 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-06 03:16:17.505750 | debian-bookworm | Hostname: debian 2026-05-06 03:16:17.505772 | debian-bookworm | Username: zuul 2026-05-06 03:16:17.505792 | debian-bookworm | Distro: Debian 12.13 2026-05-06 03:16:17.505815 | debian-bookworm | Provider: regiocloud-a 2026-05-06 03:16:17.505836 | debian-bookworm | Region: 2026-05-06 03:16:17.505857 | debian-bookworm | Label: debian-bookworm 2026-05-06 03:16:17.505877 | debian-bookworm | Product Name: OpenStack Nova 2026-05-06 03:16:17.505896 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1d:3857 2026-05-06 03:16:17.525722 | 2026-05-06 03:16:17.525872 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-06 03:16:19.107527 | debian-bookworm -> localhost | changed 2026-05-06 03:16:19.114522 | 2026-05-06 03:16:19.114634 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-06 03:16:21.188865 | debian-bookworm -> localhost | changed 2026-05-06 03:16:21.221424 | 2026-05-06 03:16:21.221578 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-06 03:16:22.303916 | debian-bookworm -> localhost | ok 2026-05-06 03:16:22.314584 | 2026-05-06 03:16:22.314708 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-06 03:16:22.339253 | debian-bookworm | ok 2026-05-06 03:16:22.353627 | debian-bookworm | included: /var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-06 03:16:22.360946 | 2026-05-06 03:16:22.361036 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-06 03:16:24.136285 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-06 03:16:24.136461 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/2d999e82c8ea4bfbbabf4dad00701117_id_rsa 2026-05-06 03:16:24.136491 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/2d999e82c8ea4bfbbabf4dad00701117_id_rsa.pub 2026-05-06 03:16:24.136526 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-06 03:16:24.136546 | debian-bookworm -> localhost | SHA256:TFe+TqHehXA6NlZPQwXVL2HUBYtpwAx1OdP5UEaoqYw zuul-build-sshkey 2026-05-06 03:16:24.136565 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-06 03:16:24.136593 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-06 03:16:24.136611 | debian-bookworm -> localhost | | .=o o+=@X| 2026-05-06 03:16:24.136629 | debian-bookworm -> localhost | | o=++Boo| 2026-05-06 03:16:24.136646 | debian-bookworm -> localhost | | . o O*++.| 2026-05-06 03:16:24.136661 | debian-bookworm -> localhost | | o . Bo*..o| 2026-05-06 03:16:24.136677 | debian-bookworm -> localhost | | SoB.+ o. | 2026-05-06 03:16:24.136697 | debian-bookworm -> localhost | | E+o* . | 2026-05-06 03:16:24.136713 | debian-bookworm -> localhost | | . o | 2026-05-06 03:16:24.136729 | debian-bookworm -> localhost | | | 2026-05-06 03:16:24.136746 | debian-bookworm -> localhost | | | 2026-05-06 03:16:24.136762 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-06 03:16:24.136805 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.665677 2026-05-06 03:16:24.141851 | 2026-05-06 03:16:24.141936 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-06 03:16:24.178461 | debian-bookworm | ok 2026-05-06 03:16:24.187396 | debian-bookworm | included: /var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-06 03:16:24.202308 | 2026-05-06 03:16:24.202405 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-06 03:16:24.255436 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:16:24.261774 | 2026-05-06 03:16:24.261870 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-06 03:16:24.922225 | debian-bookworm | changed 2026-05-06 03:16:24.929893 | 2026-05-06 03:16:24.930000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-06 03:16:25.227906 | debian-bookworm | ok 2026-05-06 03:16:25.240279 | 2026-05-06 03:16:25.240391 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-06 03:16:26.013990 | debian-bookworm | changed 2026-05-06 03:16:26.020609 | 2026-05-06 03:16:26.020717 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-06 03:16:26.723941 | debian-bookworm | changed 2026-05-06 03:16:26.729315 | 2026-05-06 03:16:26.729415 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-06 03:16:26.774084 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:16:26.780365 | 2026-05-06 03:16:26.780468 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-06 03:16:27.404897 | debian-bookworm -> localhost | changed 2026-05-06 03:16:27.418063 | 2026-05-06 03:16:27.418175 | TASK [add-build-sshkey : Add back temp key] 2026-05-06 03:16:27.798784 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/2d999e82c8ea4bfbbabf4dad00701117_id_rsa (zuul-build-sshkey) 2026-05-06 03:16:27.799108 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010463 2026-05-06 03:16:27.807259 | 2026-05-06 03:16:27.807360 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-06 03:16:28.577778 | debian-bookworm | ok 2026-05-06 03:16:28.592064 | 2026-05-06 03:16:28.592182 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-06 03:16:28.666078 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:16:28.678209 | 2026-05-06 03:16:28.678318 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-06 03:16:29.182212 | debian-bookworm | ok 2026-05-06 03:16:29.230048 | 2026-05-06 03:16:29.230165 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-06 03:16:29.278940 | debian-bookworm | ok 2026-05-06 03:16:29.287611 | 2026-05-06 03:16:29.287712 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-06 03:16:30.031696 | debian-bookworm -> localhost | ok 2026-05-06 03:16:30.037870 | 2026-05-06 03:16:30.037964 | TASK [validate-host : Collect information about the host] 2026-05-06 03:16:31.864076 | debian-bookworm | ok 2026-05-06 03:16:31.882527 | 2026-05-06 03:16:31.882673 | TASK [validate-host : Sanitize hostname] 2026-05-06 03:16:32.054281 | debian-bookworm | ok 2026-05-06 03:16:32.129311 | 2026-05-06 03:16:32.139652 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-06 03:16:32.962277 | debian-bookworm -> localhost | changed 2026-05-06 03:16:32.967786 | 2026-05-06 03:16:32.967884 | TASK [validate-host : Collect information about zuul worker] 2026-05-06 03:16:33.460899 | debian-bookworm | ok 2026-05-06 03:16:33.474789 | 2026-05-06 03:16:33.474916 | TASK [validate-host : Write out all zuul information for each host] 2026-05-06 03:16:34.231542 | debian-bookworm -> localhost | changed 2026-05-06 03:16:34.241128 | 2026-05-06 03:16:34.241229 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-06 03:16:34.502744 | debian-bookworm | ok 2026-05-06 03:16:34.508331 | 2026-05-06 03:16:34.508436 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-06 03:16:35.407336 | debian-bookworm | changed: 2026-05-06 03:16:35.407483 | debian-bookworm | cd+++++++++ src/ 2026-05-06 03:16:35.407523 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-06 03:16:35.407545 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-06 03:16:35.407564 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-06 03:16:35.407583 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/logs" 2026-05-06 03:17:02.782346 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/artifacts" 2026-05-06 03:17:03.151664 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2d999e82c8ea4bfbbabf4dad00701117/work/docs" 2026-05-06 03:17:03.166973 | 2026-05-06 03:17:03.167119 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-06 03:17:04.474128 | debian-bookworm | changed: 2026-05-06 03:17:04.474364 | debian-bookworm | .d..t...... ./ 2026-05-06 03:17:04.474402 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-06 03:17:04.474432 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-06 03:17:04.474459 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-06 03:17:04.474538 | debian-bookworm | changed: All items complete 2026-05-06 03:17:04.474568 | 2026-05-06 03:17:05.174700 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 03:17:05.945668 | debian-bookworm | changed: .d..t...... ./ 2026-05-06 03:17:05.979303 | 2026-05-06 03:17:05.979481 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-06 03:17:06.008577 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:17:06.013944 | debian-bookworm | skipping: Conditional result was False 2026-05-06 03:17:06.024335 | 2026-05-06 03:17:06.024460 | PLAY RECAP 2026-05-06 03:17:06.024548 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-06 03:17:06.024578 | 2026-05-06 03:17:06.221235 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-06 03:17:06.223819 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 03:17:07.205466 | 2026-05-06 03:17:07.205681 | PLAY [Base post] 2026-05-06 03:17:07.237050 | 2026-05-06 03:17:07.237220 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-06 03:17:07.929772 | debian-bookworm | changed 2026-05-06 03:17:07.936766 | 2026-05-06 03:17:07.936888 | PLAY RECAP 2026-05-06 03:17:07.936956 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-06 03:17:07.937019 | 2026-05-06 03:17:08.229270 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-06 03:17:08.230183 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-06 03:17:09.278308 | 2026-05-06 03:17:09.278485 | PLAY [Base post-logs] 2026-05-06 03:17:09.290004 | 2026-05-06 03:17:09.290176 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-06 03:17:10.061895 | localhost | changed 2026-05-06 03:17:10.077348 | 2026-05-06 03:17:10.077628 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-06 03:17:10.130485 | localhost | ok 2026-05-06 03:17:10.134433 | 2026-05-06 03:17:10.134594 | TASK [Set zuul-log-path fact] 2026-05-06 03:17:10.171284 | localhost | ok 2026-05-06 03:17:10.182544 | 2026-05-06 03:17:10.182696 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-06 03:17:10.241642 | localhost | ok 2026-05-06 03:17:10.244987 | 2026-05-06 03:17:10.245102 | TASK [upload-logs : Create log directories] 2026-05-06 03:17:10.875253 | localhost | changed 2026-05-06 03:17:10.877547 | 2026-05-06 03:17:10.877619 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-06 03:17:11.363092 | localhost -> localhost | ok: Runtime: 0:00:00.018312 2026-05-06 03:17:11.366621 | 2026-05-06 03:17:11.366722 | TASK [upload-logs : Upload logs to log server] 2026-05-06 03:17:12.004112 | localhost | Output suppressed because no_log was given 2026-05-06 03:17:12.006187 | 2026-05-06 03:17:12.006285 | LOOP [upload-logs : Compress console log and json output] 2026-05-06 03:17:12.062324 | localhost | skipping: Conditional result was False 2026-05-06 03:17:12.070619 | localhost | skipping: Conditional result was False 2026-05-06 03:17:12.083786 | 2026-05-06 03:17:12.084026 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-06 03:17:12.134890 | localhost | skipping: Conditional result was False 2026-05-06 03:17:12.135116 | 2026-05-06 03:17:12.142883 | localhost | skipping: Conditional result was False 2026-05-06 03:17:12.150786 | 2026-05-06 03:17:12.150888 | LOOP [upload-logs : Upload console log and json output]