2026-05-21 03:09:26.209520 | Job console starting 2026-05-21 03:09:26.221699 | Updating git repos 2026-05-21 03:09:26.267911 | Cloning repos into workspace 2026-05-21 03:09:26.347042 | Restoring repo states 2026-05-21 03:09:26.386815 | Merging changes 2026-05-21 03:09:26.386842 | Checking out repos 2026-05-21 03:09:26.453465 | Preparing playbooks 2026-05-21 03:09:27.501421 | Running Ansible setup 2026-05-21 03:09:33.720516 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 03:09:34.655371 | 2026-05-21 03:09:34.655499 | PLAY [Base pre] 2026-05-21 03:09:34.672221 | 2026-05-21 03:09:34.672342 | TASK [Setup log path fact] 2026-05-21 03:09:34.700460 | debian-bookworm | ok 2026-05-21 03:09:34.715620 | 2026-05-21 03:09:34.715744 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 03:09:34.755243 | debian-bookworm | ok 2026-05-21 03:09:34.764649 | 2026-05-21 03:09:34.764741 | TASK [emit-job-header : Print job information] 2026-05-21 03:09:34.796277 | # Job Information 2026-05-21 03:09:34.796437 | Ansible Version: 2.16.14 2026-05-21 03:09:34.796473 | Job: python-black 2026-05-21 03:09:34.796505 | Pipeline: periodic-daily 2026-05-21 03:09:34.796527 | Executor: 521e9411259a 2026-05-21 03:09:34.796548 | Triggered by: https://github.com/osism/container-image-osism-ansible 2026-05-21 03:09:34.796569 | Event ID: 49b710b396804466bfe90facb1d0affb 2026-05-21 03:09:34.805161 | 2026-05-21 03:09:34.805267 | LOOP [emit-job-header : Print node information] 2026-05-21 03:09:34.900603 | debian-bookworm | ok: 2026-05-21 03:09:34.900812 | debian-bookworm | # Node Information 2026-05-21 03:09:34.900848 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-21 03:09:34.900873 | debian-bookworm | Hostname: debian 2026-05-21 03:09:34.900897 | debian-bookworm | Username: zuul 2026-05-21 03:09:34.900918 | debian-bookworm | Distro: Debian 12.14 2026-05-21 03:09:34.900941 | debian-bookworm | Provider: regiocloud-a 2026-05-21 03:09:34.900962 | debian-bookworm | Region: 2026-05-21 03:09:34.900983 | debian-bookworm | Label: debian-bookworm 2026-05-21 03:09:34.901002 | debian-bookworm | Product Name: OpenStack Nova 2026-05-21 03:09:34.901022 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea1:f777 2026-05-21 03:09:34.921258 | 2026-05-21 03:09:34.921380 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 03:09:35.524759 | debian-bookworm -> localhost | changed 2026-05-21 03:09:35.531803 | 2026-05-21 03:09:35.531913 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 03:09:36.761387 | debian-bookworm -> localhost | changed 2026-05-21 03:09:36.773441 | 2026-05-21 03:09:36.773589 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 03:09:37.146340 | debian-bookworm -> localhost | ok 2026-05-21 03:09:37.153393 | 2026-05-21 03:09:37.153535 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 03:09:37.184995 | debian-bookworm | ok 2026-05-21 03:09:37.201851 | debian-bookworm | included: /var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 03:09:37.209059 | 2026-05-21 03:09:37.209215 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 03:09:38.779611 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-21 03:09:38.779852 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/b28bbfe1294f4d4e9ca65b82e2d2a693_id_rsa 2026-05-21 03:09:38.779890 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/b28bbfe1294f4d4e9ca65b82e2d2a693_id_rsa.pub 2026-05-21 03:09:38.779916 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-21 03:09:38.779941 | debian-bookworm -> localhost | SHA256:crPJBD086aliQd3M4At6BlIHU83Apq/IVWYrUxYcp+Q zuul-build-sshkey 2026-05-21 03:09:38.779962 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-21 03:09:38.779997 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-21 03:09:38.780018 | debian-bookworm -> localhost | | ++=*o. | 2026-05-21 03:09:38.780039 | debian-bookworm -> localhost | | . o===B . | 2026-05-21 03:09:38.780059 | debian-bookworm -> localhost | |. .ooE= X | 2026-05-21 03:09:38.780079 | debian-bookworm -> localhost | | ..+ B + + | 2026-05-21 03:09:38.780098 | debian-bookworm -> localhost | | ..X + S | 2026-05-21 03:09:38.780123 | debian-bookworm -> localhost | | *.o * + | 2026-05-21 03:09:38.780143 | debian-bookworm -> localhost | |....= . + | 2026-05-21 03:09:38.780202 | debian-bookworm -> localhost | |.... . | 2026-05-21 03:09:38.780224 | debian-bookworm -> localhost | | | 2026-05-21 03:09:38.780244 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-21 03:09:38.780303 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.957660 2026-05-21 03:09:38.787167 | 2026-05-21 03:09:38.787298 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 03:09:38.818358 | debian-bookworm | ok 2026-05-21 03:09:38.830351 | debian-bookworm | included: /var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 03:09:38.840041 | 2026-05-21 03:09:38.840180 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 03:09:38.864870 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:09:38.878352 | 2026-05-21 03:09:38.878530 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 03:09:39.504962 | debian-bookworm | changed 2026-05-21 03:09:39.519427 | 2026-05-21 03:09:39.519565 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 03:09:39.769853 | debian-bookworm | ok 2026-05-21 03:09:39.777611 | 2026-05-21 03:09:39.777768 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 03:09:40.419393 | debian-bookworm | changed 2026-05-21 03:09:40.431700 | 2026-05-21 03:09:40.431852 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 03:09:41.028354 | debian-bookworm | changed 2026-05-21 03:09:41.035140 | 2026-05-21 03:09:41.035308 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 03:09:41.076277 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:09:41.093005 | 2026-05-21 03:09:41.093152 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 03:09:41.630691 | debian-bookworm -> localhost | changed 2026-05-21 03:09:41.642235 | 2026-05-21 03:09:41.642372 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 03:09:42.035396 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/b28bbfe1294f4d4e9ca65b82e2d2a693_id_rsa (zuul-build-sshkey) 2026-05-21 03:09:42.035660 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041260 2026-05-21 03:09:42.044452 | 2026-05-21 03:09:42.044579 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 03:09:42.586652 | debian-bookworm | ok 2026-05-21 03:09:42.597541 | 2026-05-21 03:09:42.597678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 03:09:42.624384 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:09:42.636566 | 2026-05-21 03:09:42.636698 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-21 03:09:43.110272 | debian-bookworm | ok 2026-05-21 03:09:43.138203 | 2026-05-21 03:09:43.138358 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-21 03:09:43.168563 | debian-bookworm | ok 2026-05-21 03:09:43.174128 | 2026-05-21 03:09:43.174288 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-21 03:09:43.478189 | debian-bookworm -> localhost | ok 2026-05-21 03:09:43.488403 | 2026-05-21 03:09:43.488534 | TASK [validate-host : Collect information about the host] 2026-05-21 03:09:44.640074 | debian-bookworm | ok 2026-05-21 03:09:44.681115 | 2026-05-21 03:09:44.681252 | TASK [validate-host : Sanitize hostname] 2026-05-21 03:09:44.840524 | debian-bookworm | ok 2026-05-21 03:09:44.887903 | 2026-05-21 03:09:44.888078 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-21 03:09:45.929660 | debian-bookworm -> localhost | changed 2026-05-21 03:09:45.943891 | 2026-05-21 03:09:45.944006 | TASK [validate-host : Collect information about zuul worker] 2026-05-21 03:09:46.382240 | debian-bookworm | ok 2026-05-21 03:09:46.387090 | 2026-05-21 03:09:46.387215 | TASK [validate-host : Write out all zuul information for each host] 2026-05-21 03:09:47.051737 | debian-bookworm -> localhost | changed 2026-05-21 03:09:47.064593 | 2026-05-21 03:09:47.064686 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-21 03:09:47.327714 | debian-bookworm | ok 2026-05-21 03:09:47.333578 | 2026-05-21 03:09:47.333674 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-21 03:09:48.291333 | debian-bookworm | changed: 2026-05-21 03:09:48.291532 | debian-bookworm | cd+++++++++ src/ 2026-05-21 03:09:48.291566 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-21 03:09:48.291591 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-21 03:09:48.291613 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2026-05-21 03:09:48.291633 | debian-bookworm | Containerfile 2026-05-21 03:09:48.292456 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/logs" 2026-05-21 03:10:16.443871 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/artifacts" 2026-05-21 03:10:16.732212 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/b28bbfe1294f4d4e9ca65b82e2d2a693/work/docs" 2026-05-21 03:10:16.747005 | 2026-05-21 03:10:16.747158 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 03:10:17.585241 | debian-bookworm | changed: 2026-05-21 03:10:17.585504 | debian-bookworm | .d..t...... ./ 2026-05-21 03:10:17.585542 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-21 03:10:17.585572 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-21 03:10:17.585598 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-21 03:10:17.585642 | debian-bookworm | changed: All items complete 2026-05-21 03:10:17.585669 | 2026-05-21 03:10:18.198472 | debian-bookworm | changed: .d..t...... ./ 2026-05-21 03:10:18.880954 | debian-bookworm | changed: .d..t...... ./ 2026-05-21 03:10:18.909659 | 2026-05-21 03:10:18.909804 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 03:10:18.958348 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:10:18.964169 | debian-bookworm | skipping: Conditional result was False 2026-05-21 03:10:18.972802 | 2026-05-21 03:10:18.972891 | PLAY RECAP 2026-05-21 03:10:18.972943 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-21 03:10:18.972969 | 2026-05-21 03:10:19.266165 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-21 03:10:19.268701 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 03:10:20.674954 | 2026-05-21 03:10:20.675448 | PLAY [Base post] 2026-05-21 03:10:20.697606 | 2026-05-21 03:10:20.700489 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 03:10:21.615287 | debian-bookworm | changed 2026-05-21 03:10:21.629302 | 2026-05-21 03:10:21.629466 | PLAY RECAP 2026-05-21 03:10:21.629536 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 03:10:21.629601 | 2026-05-21 03:10:22.216355 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 03:10:22.217997 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 03:10:24.020418 | 2026-05-21 03:10:24.021881 | PLAY [Base post-logs] 2026-05-21 03:10:24.034350 | 2026-05-21 03:10:24.034508 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 03:10:24.601078 | localhost | changed 2026-05-21 03:10:24.613486 | 2026-05-21 03:10:24.613799 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 03:10:24.643793 | localhost | ok 2026-05-21 03:10:24.648061 | 2026-05-21 03:10:24.648185 | TASK [Set zuul-log-path fact] 2026-05-21 03:10:24.664412 | localhost | ok 2026-05-21 03:10:24.674149 | 2026-05-21 03:10:24.674410 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 03:10:24.711422 | localhost | ok 2026-05-21 03:10:24.715283 | 2026-05-21 03:10:24.715467 | TASK [upload-logs : Create log directories] 2026-05-21 03:10:25.380083 | localhost | changed 2026-05-21 03:10:25.383159 | 2026-05-21 03:10:25.383297 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 03:10:26.750910 | localhost -> localhost | ok: Runtime: 0:00:00.026264 2026-05-21 03:10:26.755287 | 2026-05-21 03:10:26.755434 | TASK [upload-logs : Upload logs to log server] 2026-05-21 03:10:27.694977 | localhost | Output suppressed because no_log was given 2026-05-21 03:10:27.696936 | 2026-05-21 03:10:27.697045 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 03:10:27.820682 | localhost | skipping: Conditional result was False 2026-05-21 03:10:27.841249 | localhost | skipping: Conditional result was False 2026-05-21 03:10:27.854235 | 2026-05-21 03:10:27.854418 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 03:10:27.904099 | localhost | skipping: Conditional result was False 2026-05-21 03:10:27.904431 | 2026-05-21 03:10:27.909633 | localhost | skipping: Conditional result was False 2026-05-21 03:10:27.914026 | 2026-05-21 03:10:27.914147 | LOOP [upload-logs : Upload console log and json output]