2026-05-26 15:34:03.804740 | Job console starting 2026-05-26 15:34:03.863285 | Updating git repos 2026-05-26 15:34:03.980860 | Cloning repos into workspace 2026-05-26 15:34:04.066880 | Restoring repo states 2026-05-26 15:34:04.095874 | Merging changes 2026-05-26 15:34:04.769223 | Checking out repos 2026-05-26 15:34:04.877779 | Preparing playbooks 2026-05-26 15:34:06.151811 | Running Ansible setup 2026-05-26 15:34:11.365388 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-26 15:34:12.679944 | 2026-05-26 15:34:12.680131 | PLAY [Base pre] 2026-05-26 15:34:12.699492 | 2026-05-26 15:34:12.699675 | TASK [Setup log path fact] 2026-05-26 15:34:12.729921 | debian-bookworm | ok 2026-05-26 15:34:12.758432 | 2026-05-26 15:34:12.758640 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 15:34:12.819540 | debian-bookworm | ok 2026-05-26 15:34:12.830007 | 2026-05-26 15:34:12.830151 | TASK [emit-job-header : Print job information] 2026-05-26 15:34:12.915498 | # Job Information 2026-05-26 15:34:12.915750 | Ansible Version: 2.16.14 2026-05-26 15:34:12.915788 | Job: python-black 2026-05-26 15:34:12.915820 | Pipeline: check 2026-05-26 15:34:12.915844 | Executor: 521e9411259a 2026-05-26 15:34:12.915865 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1220 2026-05-26 15:34:12.915887 | Event ID: 4b1dd710-5918-11f1-8657-38cd1ecd1201 2026-05-26 15:34:12.920960 | 2026-05-26 15:34:12.921083 | LOOP [emit-job-header : Print node information] 2026-05-26 15:34:13.082671 | debian-bookworm | ok: 2026-05-26 15:34:13.083030 | debian-bookworm | # Node Information 2026-05-26 15:34:13.083073 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-26 15:34:13.083099 | debian-bookworm | Hostname: debian 2026-05-26 15:34:13.083121 | debian-bookworm | Username: zuul 2026-05-26 15:34:13.083142 | debian-bookworm | Distro: Debian 12.14 2026-05-26 15:34:13.083176 | debian-bookworm | Provider: regiocloud-a 2026-05-26 15:34:13.083202 | debian-bookworm | Region: 2026-05-26 15:34:13.083223 | debian-bookworm | Label: debian-bookworm 2026-05-26 15:34:13.083242 | debian-bookworm | Product Name: OpenStack Nova 2026-05-26 15:34:13.083261 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee8:41f3 2026-05-26 15:34:13.117977 | 2026-05-26 15:34:13.118156 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-26 15:34:13.902355 | debian-bookworm -> localhost | changed 2026-05-26 15:34:13.910009 | 2026-05-26 15:34:13.910143 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-26 15:34:15.121116 | debian-bookworm -> localhost | changed 2026-05-26 15:34:15.132132 | 2026-05-26 15:34:15.132258 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-26 15:34:15.624271 | debian-bookworm -> localhost | ok 2026-05-26 15:34:15.629376 | 2026-05-26 15:34:15.629464 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-26 15:34:15.668678 | debian-bookworm | ok 2026-05-26 15:34:15.691607 | debian-bookworm | included: /var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-26 15:34:15.696530 | 2026-05-26 15:34:15.696630 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-26 15:34:17.011174 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-26 15:34:17.011354 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/bc05867128224f4abf7a7ebaef749b18_id_rsa 2026-05-26 15:34:17.011384 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/bc05867128224f4abf7a7ebaef749b18_id_rsa.pub 2026-05-26 15:34:17.011405 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-26 15:34:17.011425 | debian-bookworm -> localhost | SHA256:RSYdUlDDqrCSwZOr4qltRgdiKf20wb4xLMFizmQmx48 zuul-build-sshkey 2026-05-26 15:34:17.011443 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-26 15:34:17.011468 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-26 15:34:17.011487 | debian-bookworm -> localhost | | +*B. | 2026-05-26 15:34:17.011504 | debian-bookworm -> localhost | | =o. | 2026-05-26 15:34:17.011521 | debian-bookworm -> localhost | | =.o .. | 2026-05-26 15:34:17.011538 | debian-bookworm -> localhost | |=B% = .. | 2026-05-26 15:34:17.011554 | debian-bookworm -> localhost | |@+ # = .S | 2026-05-26 15:34:17.011589 | debian-bookworm -> localhost | | oE @ . | 2026-05-26 15:34:17.011608 | debian-bookworm -> localhost | | o + + | 2026-05-26 15:34:17.011624 | debian-bookworm -> localhost | |o.+ . | 2026-05-26 15:34:17.011641 | debian-bookworm -> localhost | |==. | 2026-05-26 15:34:17.011658 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-26 15:34:17.011703 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.568546 2026-05-26 15:34:17.018466 | 2026-05-26 15:34:17.018546 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-26 15:34:17.054479 | debian-bookworm | ok 2026-05-26 15:34:17.061484 | debian-bookworm | included: /var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-26 15:34:17.078981 | 2026-05-26 15:34:17.079050 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-26 15:34:17.111386 | debian-bookworm | skipping: Conditional result was False 2026-05-26 15:34:17.115865 | 2026-05-26 15:34:17.115933 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-26 15:34:17.840930 | debian-bookworm | changed 2026-05-26 15:34:17.846137 | 2026-05-26 15:34:17.846228 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-26 15:34:18.126435 | debian-bookworm | ok 2026-05-26 15:34:18.134374 | 2026-05-26 15:34:18.134482 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-26 15:34:18.796301 | debian-bookworm | changed 2026-05-26 15:34:18.803169 | 2026-05-26 15:34:18.803278 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-26 15:34:19.467449 | debian-bookworm | changed 2026-05-26 15:34:19.474053 | 2026-05-26 15:34:19.474164 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-26 15:34:19.497775 | debian-bookworm | skipping: Conditional result was False 2026-05-26 15:34:19.504292 | 2026-05-26 15:34:19.504411 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-26 15:34:19.974744 | debian-bookworm -> localhost | changed 2026-05-26 15:34:19.983426 | 2026-05-26 15:34:19.983510 | TASK [add-build-sshkey : Add back temp key] 2026-05-26 15:34:20.364480 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/bc05867128224f4abf7a7ebaef749b18_id_rsa (zuul-build-sshkey) 2026-05-26 15:34:20.364696 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020409 2026-05-26 15:34:20.371164 | 2026-05-26 15:34:20.371243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-26 15:34:20.755669 | debian-bookworm | ok 2026-05-26 15:34:20.759879 | 2026-05-26 15:34:20.759959 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-26 15:34:20.789263 | debian-bookworm | skipping: Conditional result was False 2026-05-26 15:34:20.797887 | 2026-05-26 15:34:20.797973 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-26 15:34:21.235255 | debian-bookworm | ok 2026-05-26 15:34:21.243856 | 2026-05-26 15:34:21.243948 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-26 15:34:21.281097 | debian-bookworm | ok 2026-05-26 15:34:21.285085 | 2026-05-26 15:34:21.285156 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-26 15:34:21.540339 | debian-bookworm -> localhost | ok 2026-05-26 15:34:21.545563 | 2026-05-26 15:34:21.545644 | TASK [validate-host : Collect information about the host] 2026-05-26 15:34:22.671428 | debian-bookworm | ok 2026-05-26 15:34:22.681342 | 2026-05-26 15:34:22.681433 | TASK [validate-host : Sanitize hostname] 2026-05-26 15:34:22.790808 | debian-bookworm | ok 2026-05-26 15:34:22.819660 | 2026-05-26 15:34:22.819766 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-26 15:34:23.420637 | debian-bookworm -> localhost | changed 2026-05-26 15:34:23.429012 | 2026-05-26 15:34:23.429134 | TASK [validate-host : Collect information about zuul worker] 2026-05-26 15:34:23.825597 | debian-bookworm | ok 2026-05-26 15:34:23.830020 | 2026-05-26 15:34:23.830113 | TASK [validate-host : Write out all zuul information for each host] 2026-05-26 15:34:24.502999 | debian-bookworm -> localhost | changed 2026-05-26 15:34:24.519315 | 2026-05-26 15:34:24.519484 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-26 15:34:24.793213 | debian-bookworm | ok 2026-05-26 15:34:24.799647 | 2026-05-26 15:34:24.799764 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-26 15:34:26.091177 | debian-bookworm | changed: 2026-05-26 15:34:26.091418 | debian-bookworm | cd+++++++++ src/ 2026-05-26 15:34:26.091454 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-26 15:34:26.091480 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-26 15:34:26.091502 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-26 15:34:26.091522 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/logs" 2026-05-26 15:34:53.392639 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/artifacts" 2026-05-26 15:34:53.653776 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/bc05867128224f4abf7a7ebaef749b18/work/docs" 2026-05-26 15:34:53.672522 | 2026-05-26 15:34:53.672713 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-26 15:34:54.460571 | debian-bookworm | changed: 2026-05-26 15:34:54.460974 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-26 15:34:54.461079 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-26 15:34:54.461163 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-26 15:34:54.461264 | debian-bookworm | changed: All items complete 2026-05-26 15:34:54.461330 | 2026-05-26 15:34:55.020959 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 15:34:55.613236 | debian-bookworm | changed: .d..t...... ./ 2026-05-26 15:34:55.631170 | 2026-05-26 15:34:55.631342 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-26 15:34:56.212400 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.014189 2026-05-26 15:34:56.509684 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.006655 2026-05-26 15:34:56.521926 | 2026-05-26 15:34:56.522062 | PLAY RECAP 2026-05-26 15:34:56.522123 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-26 15:34:56.522149 | 2026-05-26 15:34:56.675432 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-26 15:34:56.676482 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 15:34:57.518063 | 2026-05-26 15:34:57.518243 | PLAY [Base post] 2026-05-26 15:34:57.532062 | 2026-05-26 15:34:57.532227 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-26 15:34:58.201538 | debian-bookworm | changed 2026-05-26 15:34:58.213382 | 2026-05-26 15:34:58.213697 | PLAY RECAP 2026-05-26 15:34:58.213911 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-26 15:34:58.213986 | 2026-05-26 15:34:58.434936 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-26 15:34:58.435930 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-26 15:34:59.301136 | 2026-05-26 15:34:59.301354 | PLAY [Base post-logs] 2026-05-26 15:34:59.312239 | 2026-05-26 15:34:59.312383 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-26 15:34:59.772442 | localhost | changed 2026-05-26 15:34:59.783558 | 2026-05-26 15:34:59.783749 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-26 15:34:59.819815 | localhost | ok 2026-05-26 15:34:59.823030 | 2026-05-26 15:34:59.823131 | TASK [Set zuul-log-path fact] 2026-05-26 15:34:59.838370 | localhost | ok 2026-05-26 15:34:59.846586 | 2026-05-26 15:34:59.846728 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-26 15:34:59.872144 | localhost | ok 2026-05-26 15:34:59.875317 | 2026-05-26 15:34:59.875425 | TASK [upload-logs : Create log directories] 2026-05-26 15:35:00.379754 | localhost | changed 2026-05-26 15:35:00.382670 | 2026-05-26 15:35:00.382778 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-26 15:35:00.869106 | localhost -> localhost | ok: Runtime: 0:00:00.007732 2026-05-26 15:35:00.873430 | 2026-05-26 15:35:00.873555 | TASK [upload-logs : Upload logs to log server] 2026-05-26 15:35:01.442786 | localhost | Output suppressed because no_log was given 2026-05-26 15:35:01.444773 | 2026-05-26 15:35:01.444879 | LOOP [upload-logs : Compress console log and json output] 2026-05-26 15:35:01.493983 | localhost | skipping: Conditional result was False 2026-05-26 15:35:01.500004 | localhost | skipping: Conditional result was False 2026-05-26 15:35:01.503548 | 2026-05-26 15:35:01.503714 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-26 15:35:01.547034 | localhost | skipping: Conditional result was False 2026-05-26 15:35:01.547362 | 2026-05-26 15:35:01.551911 | localhost | skipping: Conditional result was False 2026-05-26 15:35:01.562574 | 2026-05-26 15:35:01.562947 | LOOP [upload-logs : Upload console log and json output]