2026-09-05 13:17:32.006273 | Job console starting 2026-09-05 13:17:32.026395 | Updating git repos 2026-09-05 13:17:32.052798 | Cloning repos into workspace 2026-09-05 13:17:32.122585 | Restoring repo states 2026-09-05 13:17:32.128392 | Merging changes 2026-09-05 13:17:32.760655 | Checking out repos 2026-09-05 13:17:32.816004 | Preparing playbooks 2026-09-05 13:17:34.090266 | Running Ansible setup 2026-09-05 13:17:40.238979 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-05 13:17:41.906817 | 2026-09-05 13:17:41.906962 | PLAY [Base pre] 2026-09-05 13:17:41.938209 | 2026-09-05 13:17:41.938334 | TASK [Setup log path fact] 2026-09-05 13:17:41.985463 | debian-bookworm | ok 2026-09-05 13:17:42.005348 | 2026-09-05 13:17:42.005514 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 13:17:42.033461 | debian-bookworm | ok 2026-09-05 13:17:42.043092 | 2026-09-05 13:17:42.043184 | TASK [emit-job-header : Print job information] 2026-09-05 13:17:42.112326 | # Job Information 2026-09-05 13:17:42.112481 | Ansible Version: 2.16.14 2026-09-05 13:17:42.112525 | Job: python-black 2026-09-05 13:17:42.112559 | Pipeline: check 2026-09-05 13:17:42.112582 | Executor: 521e9411259a 2026-09-05 13:17:42.112603 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1269 2026-09-05 13:17:42.112627 | Event ID: 2161f8c0-a92c-11f1-97a7-ed80153455eb 2026-09-05 13:17:42.117457 | 2026-09-05 13:17:42.117556 | LOOP [emit-job-header : Print node information] 2026-09-05 13:17:42.274526 | debian-bookworm | ok: 2026-09-05 13:17:42.274678 | debian-bookworm | # Node Information 2026-09-05 13:17:42.274705 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-05 13:17:42.274726 | debian-bookworm | Hostname: debian 2026-09-05 13:17:42.274744 | debian-bookworm | Username: zuul 2026-09-05 13:17:42.274761 | debian-bookworm | Distro: Debian 12.15 2026-09-05 13:17:42.274826 | debian-bookworm | Provider: regiocloud-a 2026-09-05 13:17:42.274859 | debian-bookworm | Region: 2026-09-05 13:17:42.274878 | debian-bookworm | Label: debian-bookworm 2026-09-05 13:17:42.274894 | debian-bookworm | Product Name: OpenStack Nova 2026-09-05 13:17:42.274910 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9a:304 2026-09-05 13:17:42.292368 | 2026-09-05 13:17:42.292454 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-05 13:17:43.008687 | debian-bookworm -> localhost | changed 2026-09-05 13:17:43.014250 | 2026-09-05 13:17:43.014334 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-05 13:17:44.701964 | debian-bookworm -> localhost | changed 2026-09-05 13:17:44.711279 | 2026-09-05 13:17:44.711366 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-05 13:17:45.215100 | debian-bookworm -> localhost | ok 2026-09-05 13:17:45.221264 | 2026-09-05 13:17:45.221359 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-05 13:17:45.266133 | debian-bookworm | ok 2026-09-05 13:17:45.311015 | debian-bookworm | included: /var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-05 13:17:45.329420 | 2026-09-05 13:17:45.329537 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-05 13:17:47.245312 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-05 13:17:47.245489 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/810dc848b0e94c7d9b97709e2b33486b_id_rsa 2026-09-05 13:17:47.245532 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/810dc848b0e94c7d9b97709e2b33486b_id_rsa.pub 2026-09-05 13:17:47.245554 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-05 13:17:47.245574 | debian-bookworm -> localhost | SHA256:C/jUeFhhk3KUHZYC/V9WeIT4mEwPx9B2hNln+mWQrkU zuul-build-sshkey 2026-09-05 13:17:47.245592 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-05 13:17:47.245621 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-05 13:17:47.245639 | debian-bookworm -> localhost | | .+=+oo.= Xo| 2026-09-05 13:17:47.245656 | debian-bookworm -> localhost | | ..*+o + E B| 2026-09-05 13:17:47.245673 | debian-bookworm -> localhost | | o.o o @ B.| 2026-09-05 13:17:47.245689 | debian-bookworm -> localhost | | . = . + O o| 2026-09-05 13:17:47.245704 | debian-bookworm -> localhost | | . = S . = o.| 2026-09-05 13:17:47.245723 | debian-bookworm -> localhost | | o o . o .| 2026-09-05 13:17:47.245739 | debian-bookworm -> localhost | | . . | 2026-09-05 13:17:47.245755 | debian-bookworm -> localhost | | | 2026-09-05 13:17:47.245772 | debian-bookworm -> localhost | | | 2026-09-05 13:17:47.245788 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-05 13:17:47.245824 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.095559 2026-09-05 13:17:47.251270 | 2026-09-05 13:17:47.251356 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-05 13:17:47.278315 | debian-bookworm | ok 2026-09-05 13:17:47.287897 | debian-bookworm | included: /var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-05 13:17:47.296719 | 2026-09-05 13:17:47.296798 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-05 13:17:47.330952 | debian-bookworm | skipping: Conditional result was False 2026-09-05 13:17:47.335868 | 2026-09-05 13:17:47.335940 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-05 13:17:48.013006 | debian-bookworm | changed 2026-09-05 13:17:48.018035 | 2026-09-05 13:17:48.018112 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-05 13:17:48.274899 | debian-bookworm | ok 2026-09-05 13:17:48.288138 | 2026-09-05 13:17:48.288234 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-05 13:17:49.114401 | debian-bookworm | changed 2026-09-05 13:17:49.120254 | 2026-09-05 13:17:49.120338 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-05 13:17:49.794872 | debian-bookworm | changed 2026-09-05 13:17:49.834243 | 2026-09-05 13:17:49.834357 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-05 13:17:49.879448 | debian-bookworm | skipping: Conditional result was False 2026-09-05 13:17:49.886226 | 2026-09-05 13:17:49.886342 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-05 13:17:50.985614 | debian-bookworm -> localhost | changed 2026-09-05 13:17:51.002828 | 2026-09-05 13:17:51.003041 | TASK [add-build-sshkey : Add back temp key] 2026-09-05 13:17:51.799156 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/810dc848b0e94c7d9b97709e2b33486b_id_rsa (zuul-build-sshkey) 2026-09-05 13:17:51.799338 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017166 2026-09-05 13:17:51.805465 | 2026-09-05 13:17:51.805567 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-05 13:17:52.412354 | debian-bookworm | ok 2026-09-05 13:17:52.423570 | 2026-09-05 13:17:52.423664 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-05 13:17:52.456348 | debian-bookworm | skipping: Conditional result was False 2026-09-05 13:17:52.464615 | 2026-09-05 13:17:52.464697 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-05 13:17:52.944836 | debian-bookworm | ok 2026-09-05 13:17:52.954748 | 2026-09-05 13:17:52.954862 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-05 13:17:52.981881 | debian-bookworm | ok 2026-09-05 13:17:52.986325 | 2026-09-05 13:17:52.986404 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-05 13:17:53.302055 | debian-bookworm -> localhost | ok 2026-09-05 13:17:53.307314 | 2026-09-05 13:17:53.307388 | TASK [validate-host : Collect information about the host] 2026-09-05 13:17:54.401302 | debian-bookworm | ok 2026-09-05 13:17:54.416101 | 2026-09-05 13:17:54.416187 | TASK [validate-host : Sanitize hostname] 2026-09-05 13:17:54.543420 | debian-bookworm | ok 2026-09-05 13:17:54.547434 | 2026-09-05 13:17:54.547544 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-05 13:17:55.234801 | debian-bookworm -> localhost | changed 2026-09-05 13:17:55.248640 | 2026-09-05 13:17:55.248728 | TASK [validate-host : Collect information about zuul worker] 2026-09-05 13:17:55.701733 | debian-bookworm | ok 2026-09-05 13:17:55.707461 | 2026-09-05 13:17:55.707562 | TASK [validate-host : Write out all zuul information for each host] 2026-09-05 13:17:56.237623 | debian-bookworm -> localhost | changed 2026-09-05 13:17:56.247254 | 2026-09-05 13:17:56.247338 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-05 13:17:56.509039 | debian-bookworm | ok 2026-09-05 13:17:56.513344 | 2026-09-05 13:17:56.513416 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-05 13:17:57.459628 | debian-bookworm | changed: 2026-09-05 13:17:57.461111 | debian-bookworm | cd+++++++++ src/ 2026-09-05 13:17:57.461155 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-05 13:17:57.461181 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-05 13:17:57.461203 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-05 13:17:57.461224 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/logs" 2026-09-05 13:18:59.348202 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/artifacts" 2026-09-05 13:18:59.612445 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/810dc848b0e94c7d9b97709e2b33486b/work/docs" 2026-09-05 13:18:59.621931 | 2026-09-05 13:18:59.622050 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-05 13:19:00.392747 | debian-bookworm | changed: 2026-09-05 13:19:00.393011 | debian-bookworm | .d..t...... ./ 2026-09-05 13:19:00.393069 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-05 13:19:00.393110 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-05 13:19:00.393151 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-05 13:19:00.393191 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-05 13:19:00.393231 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-05 13:19:00.393297 | debian-bookworm | changed: All items complete 2026-09-05 13:19:00.393340 | 2026-09-05 13:19:00.921269 | debian-bookworm | changed: .d..t...... ./ 2026-09-05 13:19:01.472694 | debian-bookworm | changed: .d..t...... ./ 2026-09-05 13:19:01.495937 | 2026-09-05 13:19:01.496058 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-05 13:19:01.814251 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005764 2026-09-05 13:19:02.115793 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008125 2026-09-05 13:19:02.127548 | 2026-09-05 13:19:02.127635 | PLAY RECAP 2026-09-05 13:19:02.127684 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-05 13:19:02.127720 | 2026-09-05 13:19:02.258212 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-05 13:19:02.259176 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 13:19:02.981100 | 2026-09-05 13:19:02.981259 | PLAY [Base post] 2026-09-05 13:19:02.994685 | 2026-09-05 13:19:02.994824 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-05 13:19:03.549353 | debian-bookworm | changed 2026-09-05 13:19:03.555665 | 2026-09-05 13:19:03.555766 | PLAY RECAP 2026-09-05 13:19:03.555830 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-05 13:19:03.555890 | 2026-09-05 13:19:03.680133 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 13:19:03.681009 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-05 13:19:04.484269 | 2026-09-05 13:19:04.484411 | PLAY [Base post-logs] 2026-09-05 13:19:04.493810 | 2026-09-05 13:19:04.493930 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-05 13:19:04.953726 | localhost | changed 2026-09-05 13:19:04.963980 | 2026-09-05 13:19:04.964114 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-05 13:19:04.988713 | localhost | ok 2026-09-05 13:19:04.991701 | 2026-09-05 13:19:04.991791 | TASK [Set zuul-log-path fact] 2026-09-05 13:19:05.005903 | localhost | ok 2026-09-05 13:19:05.013678 | 2026-09-05 13:19:05.013770 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 13:19:05.047757 | localhost | ok 2026-09-05 13:19:05.050657 | 2026-09-05 13:19:05.050748 | TASK [upload-logs : Create log directories] 2026-09-05 13:19:05.480035 | localhost | changed 2026-09-05 13:19:05.482513 | 2026-09-05 13:19:05.482602 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-05 13:19:05.902766 | localhost -> localhost | ok: Runtime: 0:00:00.006359 2026-09-05 13:19:05.905722 | 2026-09-05 13:19:05.905801 | TASK [upload-logs : Upload logs to log server] 2026-09-05 13:19:06.429591 | localhost | Output suppressed because no_log was given 2026-09-05 13:19:06.432270 | 2026-09-05 13:19:06.432357 | LOOP [upload-logs : Compress console log and json output] 2026-09-05 13:19:06.472701 | localhost | skipping: Conditional result was False 2026-09-05 13:19:06.477994 | localhost | skipping: Conditional result was False 2026-09-05 13:19:06.487559 | 2026-09-05 13:19:06.487646 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-05 13:19:06.555905 | localhost | skipping: Conditional result was False 2026-09-05 13:19:06.556121 | 2026-09-05 13:19:06.570558 | localhost | skipping: Conditional result was False 2026-09-05 13:19:06.582793 | 2026-09-05 13:19:06.582892 | LOOP [upload-logs : Upload console log and json output]