2026-09-07 23:36:50.480852 | Job console starting 2026-09-07 23:36:50.501644 | Updating git repos 2026-09-07 23:36:50.576052 | Cloning repos into workspace 2026-09-07 23:36:50.735040 | Restoring repo states 2026-09-07 23:36:50.783842 | Merging changes 2026-09-07 23:36:55.225777 | Checking out repos 2026-09-07 23:36:55.325328 | Preparing playbooks 2026-09-07 23:36:56.167425 | Running Ansible setup 2026-09-07 23:37:01.219506 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 23:37:02.062380 | 2026-09-07 23:37:02.062502 | PLAY [Base pre] 2026-09-07 23:37:02.078552 | 2026-09-07 23:37:02.078657 | TASK [Setup log path fact] 2026-09-07 23:37:02.117386 | debian-bookworm | ok 2026-09-07 23:37:02.132857 | 2026-09-07 23:37:02.132961 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 23:37:02.160404 | debian-bookworm | ok 2026-09-07 23:37:02.169873 | 2026-09-07 23:37:02.169979 | TASK [emit-job-header : Print job information] 2026-09-07 23:37:02.207789 | # Job Information 2026-09-07 23:37:02.207933 | Ansible Version: 2.16.14 2026-09-07 23:37:02.207968 | Job: python-black 2026-09-07 23:37:02.208001 | Pipeline: check 2026-09-07 23:37:02.208023 | Executor: 521e9411259a 2026-09-07 23:37:02.208044 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2162 2026-09-07 23:37:02.208065 | Event ID: db44a280-ab14-11f1-9392-bda9cfdc0842 2026-09-07 23:37:02.212860 | 2026-09-07 23:37:02.212951 | LOOP [emit-job-header : Print node information] 2026-09-07 23:37:02.371049 | debian-bookworm | ok: 2026-09-07 23:37:02.371212 | debian-bookworm | # Node Information 2026-09-07 23:37:02.371245 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-07 23:37:02.371270 | debian-bookworm | Hostname: debian 2026-09-07 23:37:02.371309 | debian-bookworm | Username: zuul 2026-09-07 23:37:02.371330 | debian-bookworm | Distro: Debian 12.15 2026-09-07 23:37:02.371354 | debian-bookworm | Provider: regiocloud-a 2026-09-07 23:37:02.371375 | debian-bookworm | Region: 2026-09-07 23:37:02.371396 | debian-bookworm | Label: debian-bookworm 2026-09-07 23:37:02.371416 | debian-bookworm | Product Name: OpenStack Nova 2026-09-07 23:37:02.371435 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feea:6a44 2026-09-07 23:37:02.381859 | 2026-09-07 23:37:02.381963 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 23:37:03.073401 | debian-bookworm -> localhost | changed 2026-09-07 23:37:03.081182 | 2026-09-07 23:37:03.081307 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 23:37:04.009198 | debian-bookworm -> localhost | changed 2026-09-07 23:37:04.017773 | 2026-09-07 23:37:04.017850 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 23:37:04.413992 | debian-bookworm -> localhost | ok 2026-09-07 23:37:04.420564 | 2026-09-07 23:37:04.420653 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 23:37:04.489863 | debian-bookworm | ok 2026-09-07 23:37:04.516364 | debian-bookworm | included: /var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 23:37:04.528358 | 2026-09-07 23:37:04.529013 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 23:37:05.904454 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-07 23:37:05.904807 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/2f5a0815a54042bebab79e84e1e9901c_id_rsa 2026-09-07 23:37:05.904850 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/2f5a0815a54042bebab79e84e1e9901c_id_rsa.pub 2026-09-07 23:37:05.904878 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-07 23:37:05.904915 | debian-bookworm -> localhost | SHA256:cXj69NKp3neYGRaqOyu0nOvVutKodTN1Lgr/z6nS26o zuul-build-sshkey 2026-09-07 23:37:05.904940 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-07 23:37:05.904972 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-07 23:37:05.904996 | debian-bookworm -> localhost | | | 2026-09-07 23:37:05.905018 | debian-bookworm -> localhost | | . | 2026-09-07 23:37:05.905040 | debian-bookworm -> localhost | | o o | 2026-09-07 23:37:05.905061 | debian-bookworm -> localhost | | = . | 2026-09-07 23:37:05.905093 | debian-bookworm -> localhost | | S . .... | 2026-09-07 23:37:05.905120 | debian-bookworm -> localhost | | .o =.+o | 2026-09-07 23:37:05.905142 | debian-bookworm -> localhost | | oo=Bo*..= | 2026-09-07 23:37:05.905162 | debian-bookworm -> localhost | | .B==O.+=..| 2026-09-07 23:37:05.905184 | debian-bookworm -> localhost | | .oo=EO**=. | 2026-09-07 23:37:05.905204 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-07 23:37:05.905254 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.852755 2026-09-07 23:37:05.922205 | 2026-09-07 23:37:05.922306 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 23:37:05.939056 | debian-bookworm | ok 2026-09-07 23:37:05.948661 | debian-bookworm | included: /var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 23:37:05.955798 | 2026-09-07 23:37:05.955873 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 23:37:05.988474 | debian-bookworm | skipping: Conditional result was False 2026-09-07 23:37:05.993153 | 2026-09-07 23:37:05.993226 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 23:37:06.740014 | debian-bookworm | changed 2026-09-07 23:37:06.744291 | 2026-09-07 23:37:06.744366 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 23:37:07.016070 | debian-bookworm | ok 2026-09-07 23:37:07.022341 | 2026-09-07 23:37:07.022423 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 23:37:07.779560 | debian-bookworm | changed 2026-09-07 23:37:07.783945 | 2026-09-07 23:37:07.784026 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 23:37:08.494391 | debian-bookworm | changed 2026-09-07 23:37:08.505135 | 2026-09-07 23:37:08.505234 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 23:37:08.518353 | debian-bookworm | skipping: Conditional result was False 2026-09-07 23:37:08.524737 | 2026-09-07 23:37:08.524839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 23:37:08.948206 | debian-bookworm -> localhost | changed 2026-09-07 23:37:08.958366 | 2026-09-07 23:37:08.958452 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 23:37:09.368666 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/2f5a0815a54042bebab79e84e1e9901c_id_rsa (zuul-build-sshkey) 2026-09-07 23:37:09.368857 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039649 2026-09-07 23:37:09.378557 | 2026-09-07 23:37:09.378645 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 23:37:09.800905 | debian-bookworm | ok 2026-09-07 23:37:09.805232 | 2026-09-07 23:37:09.805325 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 23:37:09.828026 | debian-bookworm | skipping: Conditional result was False 2026-09-07 23:37:09.837264 | 2026-09-07 23:37:09.837353 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-07 23:37:10.281476 | debian-bookworm | ok 2026-09-07 23:37:10.292091 | 2026-09-07 23:37:10.292193 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-07 23:37:10.322950 | debian-bookworm | ok 2026-09-07 23:37:10.335739 | 2026-09-07 23:37:10.335843 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-07 23:37:10.716980 | debian-bookworm -> localhost | ok 2026-09-07 23:37:10.723025 | 2026-09-07 23:37:10.723108 | TASK [validate-host : Collect information about the host] 2026-09-07 23:37:11.971875 | debian-bookworm | ok 2026-09-07 23:37:11.984953 | 2026-09-07 23:37:11.985093 | TASK [validate-host : Sanitize hostname] 2026-09-07 23:37:12.106755 | debian-bookworm | ok 2026-09-07 23:37:12.113367 | 2026-09-07 23:37:12.113505 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-07 23:37:12.702678 | debian-bookworm -> localhost | changed 2026-09-07 23:37:12.708874 | 2026-09-07 23:37:12.708959 | TASK [validate-host : Collect information about zuul worker] 2026-09-07 23:37:13.206180 | debian-bookworm | ok 2026-09-07 23:37:13.213803 | 2026-09-07 23:37:13.213939 | TASK [validate-host : Write out all zuul information for each host] 2026-09-07 23:37:13.776365 | debian-bookworm -> localhost | changed 2026-09-07 23:37:13.785532 | 2026-09-07 23:37:13.785670 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-07 23:37:14.105598 | debian-bookworm | ok 2026-09-07 23:37:14.117907 | 2026-09-07 23:37:14.118036 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-07 23:37:15.181880 | debian-bookworm | changed: 2026-09-07 23:37:15.182108 | debian-bookworm | cd+++++++++ src/ 2026-09-07 23:37:15.182157 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-07 23:37:15.182193 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-07 23:37:15.182225 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-09-07 23:37:15.182253 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/logs" 2026-09-07 23:38:19.522297 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/artifacts" 2026-09-07 23:38:19.784109 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2f5a0815a54042bebab79e84e1e9901c/work/docs" 2026-09-07 23:38:19.802982 | 2026-09-07 23:38:19.803161 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 23:38:20.674532 | debian-bookworm | changed: 2026-09-07 23:38:20.674766 | debian-bookworm | .d..t...... ./ 2026-09-07 23:38:20.674811 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-07 23:38:20.674844 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-07 23:38:20.674873 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-07 23:38:20.674901 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-07 23:38:20.674928 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-07 23:38:20.674976 | debian-bookworm | changed: All items complete 2026-09-07 23:38:20.675005 | 2026-09-07 23:38:21.294890 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 23:38:21.876310 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 23:38:21.904614 | 2026-09-07 23:38:21.904771 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 23:38:22.235277 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009470 2026-09-07 23:38:22.562545 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010122 2026-09-07 23:38:22.588249 | 2026-09-07 23:38:22.588371 | PLAY RECAP 2026-09-07 23:38:22.588427 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-07 23:38:22.588453 | 2026-09-07 23:38:22.720980 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 23:38:22.721930 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 23:38:23.468390 | 2026-09-07 23:38:23.468539 | PLAY [Base post] 2026-09-07 23:38:23.483199 | 2026-09-07 23:38:23.483369 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 23:38:24.062968 | debian-bookworm | changed 2026-09-07 23:38:24.072149 | 2026-09-07 23:38:24.072342 | PLAY RECAP 2026-09-07 23:38:24.072421 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 23:38:24.072493 | 2026-09-07 23:38:24.188991 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 23:38:24.191083 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 23:38:25.027981 | 2026-09-07 23:38:25.028136 | PLAY [Base post-logs] 2026-09-07 23:38:25.038786 | 2026-09-07 23:38:25.038913 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 23:38:25.491021 | localhost | changed 2026-09-07 23:38:25.504842 | 2026-09-07 23:38:25.504993 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 23:38:25.530460 | localhost | ok 2026-09-07 23:38:25.534274 | 2026-09-07 23:38:25.534402 | TASK [Set zuul-log-path fact] 2026-09-07 23:38:25.549141 | localhost | ok 2026-09-07 23:38:25.557616 | 2026-09-07 23:38:25.557718 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 23:38:25.582524 | localhost | ok 2026-09-07 23:38:25.586252 | 2026-09-07 23:38:25.586395 | TASK [upload-logs : Create log directories] 2026-09-07 23:38:26.160780 | localhost | changed 2026-09-07 23:38:26.165499 | 2026-09-07 23:38:26.165774 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 23:38:26.670454 | localhost -> localhost | ok: Runtime: 0:00:00.005312 2026-09-07 23:38:26.674508 | 2026-09-07 23:38:26.674620 | TASK [upload-logs : Upload logs to log server] 2026-09-07 23:38:27.238661 | localhost | Output suppressed because no_log was given 2026-09-07 23:38:27.241523 | 2026-09-07 23:38:27.241710 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 23:38:27.303359 | localhost | skipping: Conditional result was False 2026-09-07 23:38:27.317619 | localhost | skipping: Conditional result was False 2026-09-07 23:38:27.332460 | 2026-09-07 23:38:27.332695 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 23:38:27.398263 | localhost | skipping: Conditional result was False 2026-09-07 23:38:27.398851 | 2026-09-07 23:38:27.402982 | localhost | skipping: Conditional result was False 2026-09-07 23:38:27.419052 | 2026-09-07 23:38:27.419242 | LOOP [upload-logs : Upload console log and json output]