2026-06-08 16:54:53.477859 | Job console starting 2026-06-08 16:54:53.496359 | Updating git repos 2026-06-08 16:54:53.607270 | Cloning repos into workspace 2026-06-08 16:54:53.733751 | Restoring repo states 2026-06-08 16:54:53.748869 | Merging changes 2026-06-08 16:54:54.286350 | Checking out repos 2026-06-08 16:54:54.336892 | Preparing playbooks 2026-06-08 16:54:55.303918 | Running Ansible setup 2026-06-08 16:55:00.389378 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 16:55:01.296123 | 2026-06-08 16:55:01.296344 | PLAY [Base pre] 2026-06-08 16:55:01.331384 | 2026-06-08 16:55:01.331561 | TASK [Setup log path fact] 2026-06-08 16:55:01.373890 | debian-bookworm | ok 2026-06-08 16:55:01.404978 | 2026-06-08 16:55:01.405153 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 16:55:01.435407 | debian-bookworm | ok 2026-06-08 16:55:01.445570 | 2026-06-08 16:55:01.445716 | TASK [emit-job-header : Print job information] 2026-06-08 16:55:01.485323 | # Job Information 2026-06-08 16:55:01.485511 | Ansible Version: 2.16.14 2026-06-08 16:55:01.485545 | Job: python-black 2026-06-08 16:55:01.485578 | Pipeline: check 2026-06-08 16:55:01.485601 | Executor: 521e9411259a 2026-06-08 16:55:01.485622 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1232 2026-06-08 16:55:01.485646 | Event ID: bee744f0-635a-11f1-8e4e-f467d7dc460e 2026-06-08 16:55:01.491968 | 2026-06-08 16:55:01.492095 | LOOP [emit-job-header : Print node information] 2026-06-08 16:55:01.604765 | debian-bookworm | ok: 2026-06-08 16:55:01.604968 | debian-bookworm | # Node Information 2026-06-08 16:55:01.605003 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-08 16:55:01.605029 | debian-bookworm | Hostname: debian 2026-06-08 16:55:01.605052 | debian-bookworm | Username: zuul 2026-06-08 16:55:01.605074 | debian-bookworm | Distro: Debian 12.14 2026-06-08 16:55:01.605099 | debian-bookworm | Provider: regiocloud-a 2026-06-08 16:55:01.605121 | debian-bookworm | Region: 2026-06-08 16:55:01.605142 | debian-bookworm | Label: debian-bookworm 2026-06-08 16:55:01.605162 | debian-bookworm | Product Name: OpenStack Nova 2026-06-08 16:55:01.605181 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5c:df27 2026-06-08 16:55:01.618501 | 2026-06-08 16:55:01.618654 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 16:55:02.447920 | debian-bookworm -> localhost | changed 2026-06-08 16:55:02.456212 | 2026-06-08 16:55:02.456391 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 16:55:03.831312 | debian-bookworm -> localhost | changed 2026-06-08 16:55:03.851164 | 2026-06-08 16:55:03.851323 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 16:55:04.429964 | debian-bookworm -> localhost | ok 2026-06-08 16:55:04.444879 | 2026-06-08 16:55:04.445025 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 16:55:04.482196 | debian-bookworm | ok 2026-06-08 16:55:04.498160 | debian-bookworm | included: /var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 16:55:04.506458 | 2026-06-08 16:55:04.506585 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 16:55:06.036053 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-08 16:55:06.036269 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/025b322ee5564a17a4f1f6b6b79f913f_id_rsa 2026-06-08 16:55:06.036303 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/025b322ee5564a17a4f1f6b6b79f913f_id_rsa.pub 2026-06-08 16:55:06.036325 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-08 16:55:06.036346 | debian-bookworm -> localhost | SHA256:ouNVPOxgU+FLHL59HvOdmS3y15X661NIpUdhMg7lVc4 zuul-build-sshkey 2026-06-08 16:55:06.036364 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-08 16:55:06.036390 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-08 16:55:06.036408 | debian-bookworm -> localhost | | o ..+ ++| 2026-06-08 16:55:06.036426 | debian-bookworm -> localhost | | + o + =oo| 2026-06-08 16:55:06.036443 | debian-bookworm -> localhost | | * o +E| 2026-06-08 16:55:06.036459 | debian-bookworm -> localhost | | = + o .| 2026-06-08 16:55:06.036474 | debian-bookworm -> localhost | | = S . +. o.| 2026-06-08 16:55:06.036495 | debian-bookworm -> localhost | | o * . o +.oB| 2026-06-08 16:55:06.036513 | debian-bookworm -> localhost | | o . . o ++*| 2026-06-08 16:55:06.036529 | debian-bookworm -> localhost | | . o + oo| 2026-06-08 16:55:06.036546 | debian-bookworm -> localhost | | . +=o| 2026-06-08 16:55:06.036563 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-08 16:55:06.036611 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.907611 2026-06-08 16:55:06.041709 | 2026-06-08 16:55:06.041786 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 16:55:06.078145 | debian-bookworm | ok 2026-06-08 16:55:06.094107 | debian-bookworm | included: /var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 16:55:06.102252 | 2026-06-08 16:55:06.102329 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 16:55:06.119956 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:55:06.126855 | 2026-06-08 16:55:06.126958 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 16:55:06.770206 | debian-bookworm | changed 2026-06-08 16:55:06.775334 | 2026-06-08 16:55:06.775411 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 16:55:07.037304 | debian-bookworm | ok 2026-06-08 16:55:07.044123 | 2026-06-08 16:55:07.044223 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 16:55:07.673363 | debian-bookworm | changed 2026-06-08 16:55:07.682760 | 2026-06-08 16:55:07.682924 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 16:55:08.306652 | debian-bookworm | changed 2026-06-08 16:55:08.313560 | 2026-06-08 16:55:08.313671 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 16:55:08.337652 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:55:08.351135 | 2026-06-08 16:55:08.351298 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 16:55:08.767632 | debian-bookworm -> localhost | changed 2026-06-08 16:55:08.777844 | 2026-06-08 16:55:08.777944 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 16:55:09.078185 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/025b322ee5564a17a4f1f6b6b79f913f_id_rsa (zuul-build-sshkey) 2026-06-08 16:55:09.078404 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015410 2026-06-08 16:55:09.085997 | 2026-06-08 16:55:09.086114 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 16:55:09.449233 | debian-bookworm | ok 2026-06-08 16:55:09.454356 | 2026-06-08 16:55:09.454449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 16:55:09.475141 | debian-bookworm | skipping: Conditional result was False 2026-06-08 16:55:09.491622 | 2026-06-08 16:55:09.491740 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-08 16:55:09.904569 | debian-bookworm | ok 2026-06-08 16:55:09.921176 | 2026-06-08 16:55:09.921333 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-08 16:55:09.968526 | debian-bookworm | ok 2026-06-08 16:55:09.973941 | 2026-06-08 16:55:09.974035 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-08 16:55:10.236865 | debian-bookworm -> localhost | ok 2026-06-08 16:55:10.245191 | 2026-06-08 16:55:10.245306 | TASK [validate-host : Collect information about the host] 2026-06-08 16:55:11.364927 | debian-bookworm | ok 2026-06-08 16:55:11.375306 | 2026-06-08 16:55:11.375410 | TASK [validate-host : Sanitize hostname] 2026-06-08 16:55:11.483445 | debian-bookworm | ok 2026-06-08 16:55:11.520642 | 2026-06-08 16:55:11.520768 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-08 16:55:12.056683 | debian-bookworm -> localhost | changed 2026-06-08 16:55:12.062590 | 2026-06-08 16:55:12.062697 | TASK [validate-host : Collect information about zuul worker] 2026-06-08 16:55:12.466195 | debian-bookworm | ok 2026-06-08 16:55:12.470880 | 2026-06-08 16:55:12.470983 | TASK [validate-host : Write out all zuul information for each host] 2026-06-08 16:55:13.034602 | debian-bookworm -> localhost | changed 2026-06-08 16:55:13.047154 | 2026-06-08 16:55:13.047302 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-08 16:55:13.344759 | debian-bookworm | ok 2026-06-08 16:55:13.352341 | 2026-06-08 16:55:13.352468 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-08 16:55:14.381178 | debian-bookworm | changed: 2026-06-08 16:55:14.381443 | debian-bookworm | cd+++++++++ src/ 2026-06-08 16:55:14.381480 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-08 16:55:14.381504 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-08 16:55:14.381525 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-08 16:55:14.381545 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/logs" 2026-06-08 16:55:41.367183 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/artifacts" 2026-06-08 16:55:41.637908 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/025b322ee5564a17a4f1f6b6b79f913f/work/docs" 2026-06-08 16:55:41.649995 | 2026-06-08 16:55:41.650157 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 16:55:42.512497 | debian-bookworm | changed: 2026-06-08 16:55:42.512893 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-08 16:55:42.512981 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-08 16:55:42.513029 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-08 16:55:42.513112 | debian-bookworm | changed: All items complete 2026-06-08 16:55:42.513153 | 2026-06-08 16:55:43.118811 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 16:55:43.685140 | debian-bookworm | changed: .d..t...... ./ 2026-06-08 16:55:43.704199 | 2026-06-08 16:55:43.704353 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 16:55:44.252658 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007629 2026-06-08 16:55:44.579705 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.025517 2026-06-08 16:55:44.594419 | 2026-06-08 16:55:44.594526 | PLAY RECAP 2026-06-08 16:55:44.594579 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-08 16:55:44.594606 | 2026-06-08 16:55:44.745584 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-08 16:55:44.746521 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 16:55:45.592656 | 2026-06-08 16:55:45.592886 | PLAY [Base post] 2026-06-08 16:55:45.607334 | 2026-06-08 16:55:45.607498 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 16:55:46.269315 | debian-bookworm | changed 2026-06-08 16:55:46.276078 | 2026-06-08 16:55:46.276254 | PLAY RECAP 2026-06-08 16:55:46.276323 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 16:55:46.276386 | 2026-06-08 16:55:46.420393 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 16:55:46.421318 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 16:55:47.357041 | 2026-06-08 16:55:47.357223 | PLAY [Base post-logs] 2026-06-08 16:55:47.370257 | 2026-06-08 16:55:47.370424 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 16:55:47.885842 | localhost | changed 2026-06-08 16:55:47.902103 | 2026-06-08 16:55:47.902464 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 16:55:47.943051 | localhost | ok 2026-06-08 16:55:47.951470 | 2026-06-08 16:55:47.951638 | TASK [Set zuul-log-path fact] 2026-06-08 16:55:47.987355 | localhost | ok 2026-06-08 16:55:47.999084 | 2026-06-08 16:55:47.999222 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 16:55:48.029627 | localhost | ok 2026-06-08 16:55:48.032838 | 2026-06-08 16:55:48.032951 | TASK [upload-logs : Create log directories] 2026-06-08 16:55:48.634448 | localhost | changed 2026-06-08 16:55:48.637390 | 2026-06-08 16:55:48.637509 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 16:55:49.134933 | localhost -> localhost | ok: Runtime: 0:00:00.005270 2026-06-08 16:55:49.139600 | 2026-06-08 16:55:49.139718 | TASK [upload-logs : Upload logs to log server] 2026-06-08 16:55:49.790473 | localhost | Output suppressed because no_log was given 2026-06-08 16:55:49.793004 | 2026-06-08 16:55:49.793156 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 16:55:49.871024 | localhost | skipping: Conditional result was False 2026-06-08 16:55:49.880003 | localhost | skipping: Conditional result was False 2026-06-08 16:55:49.893275 | 2026-06-08 16:55:49.893439 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 16:55:49.958344 | localhost | skipping: Conditional result was False 2026-06-08 16:55:49.958718 | 2026-06-08 16:55:49.965974 | localhost | skipping: Conditional result was False 2026-06-08 16:55:49.972766 | 2026-06-08 16:55:49.972946 | LOOP [upload-logs : Upload console log and json output]