2026-05-23 03:12:18.631584 | Job console starting 2026-05-23 03:12:18.665765 | Updating git repos 2026-05-23 03:12:18.742541 | Cloning repos into workspace 2026-05-23 03:12:18.822362 | Restoring repo states 2026-05-23 03:12:18.851661 | Merging changes 2026-05-23 03:12:18.851682 | Checking out repos 2026-05-23 03:12:18.943548 | Preparing playbooks 2026-05-23 03:12:20.296179 | Running Ansible setup 2026-05-23 03:12:25.559112 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-23 03:12:26.595696 | 2026-05-23 03:12:26.595912 | PLAY [Base pre] 2026-05-23 03:12:26.634989 | 2026-05-23 03:12:26.635197 | TASK [Setup log path fact] 2026-05-23 03:12:26.677404 | debian-bookworm | ok 2026-05-23 03:12:26.723344 | 2026-05-23 03:12:26.723576 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:12:26.774641 | debian-bookworm | ok 2026-05-23 03:12:26.802727 | 2026-05-23 03:12:26.802942 | TASK [emit-job-header : Print job information] 2026-05-23 03:12:26.846020 | # Job Information 2026-05-23 03:12:26.846340 | Ansible Version: 2.16.14 2026-05-23 03:12:26.846380 | Job: python-black 2026-05-23 03:12:26.846423 | Pipeline: periodic-daily 2026-05-23 03:12:26.846451 | Executor: 521e9411259a 2026-05-23 03:12:26.846508 | Triggered by: https://github.com/osism/container-image-osism-ansible 2026-05-23 03:12:26.846541 | Event ID: 54c5e614c948471a86e662dfbb34d261 2026-05-23 03:12:26.852209 | 2026-05-23 03:12:26.852368 | LOOP [emit-job-header : Print node information] 2026-05-23 03:12:26.970190 | debian-bookworm | ok: 2026-05-23 03:12:26.970536 | debian-bookworm | # Node Information 2026-05-23 03:12:26.970582 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-23 03:12:26.970621 | debian-bookworm | Hostname: debian 2026-05-23 03:12:26.970648 | debian-bookworm | Username: zuul 2026-05-23 03:12:26.970668 | debian-bookworm | Distro: Debian 12.14 2026-05-23 03:12:26.970692 | debian-bookworm | Provider: regiocloud-a 2026-05-23 03:12:26.970714 | debian-bookworm | Region: 2026-05-23 03:12:26.970735 | debian-bookworm | Label: debian-bookworm 2026-05-23 03:12:26.970754 | debian-bookworm | Product Name: OpenStack Nova 2026-05-23 03:12:26.970774 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe72:e4d 2026-05-23 03:12:26.996196 | 2026-05-23 03:12:26.996374 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-23 03:12:27.683204 | debian-bookworm -> localhost | changed 2026-05-23 03:12:27.700425 | 2026-05-23 03:12:27.700650 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-23 03:12:29.274770 | debian-bookworm -> localhost | changed 2026-05-23 03:12:29.296530 | 2026-05-23 03:12:29.296708 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-23 03:12:29.678544 | debian-bookworm -> localhost | ok 2026-05-23 03:12:29.685628 | 2026-05-23 03:12:29.685755 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-23 03:12:29.734259 | debian-bookworm | ok 2026-05-23 03:12:29.751169 | debian-bookworm | included: /var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-23 03:12:29.757701 | 2026-05-23 03:12:29.757815 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-23 03:12:31.486717 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-23 03:12:31.487064 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/dc26bf3e85e04862a038b9b6c2fd212c_id_rsa 2026-05-23 03:12:31.487117 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/dc26bf3e85e04862a038b9b6c2fd212c_id_rsa.pub 2026-05-23 03:12:31.487151 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-23 03:12:31.487182 | debian-bookworm -> localhost | SHA256:D0A2+IaWSB3nK/Crzh1ceF6WxEcyItNGG5WDDizbH8s zuul-build-sshkey 2026-05-23 03:12:31.487210 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-23 03:12:31.487845 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-23 03:12:31.487930 | debian-bookworm -> localhost | | o+=Oo+.. | 2026-05-23 03:12:31.487964 | debian-bookworm -> localhost | | o =B+*o+ | 2026-05-23 03:12:31.487992 | debian-bookworm -> localhost | | ..= B+ o.. | 2026-05-23 03:12:31.488019 | debian-bookworm -> localhost | | oo=.=+ o | 2026-05-23 03:12:31.488045 | debian-bookworm -> localhost | | .+++oS | 2026-05-23 03:12:31.488088 | debian-bookworm -> localhost | | . *Eo o | 2026-05-23 03:12:31.488117 | debian-bookworm -> localhost | | + . . | 2026-05-23 03:12:31.488144 | debian-bookworm -> localhost | | . o . | 2026-05-23 03:12:31.488174 | debian-bookworm -> localhost | | .+ . | 2026-05-23 03:12:31.488200 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-23 03:12:31.488282 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.159279 2026-05-23 03:12:31.510603 | 2026-05-23 03:12:31.510735 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-23 03:12:31.563326 | debian-bookworm | ok 2026-05-23 03:12:31.578268 | debian-bookworm | included: /var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-23 03:12:31.590217 | 2026-05-23 03:12:31.590333 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-23 03:12:31.625569 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:12:31.636134 | 2026-05-23 03:12:31.636310 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-23 03:12:32.504604 | debian-bookworm | changed 2026-05-23 03:12:32.517271 | 2026-05-23 03:12:32.517415 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-23 03:12:32.796004 | debian-bookworm | ok 2026-05-23 03:12:32.802345 | 2026-05-23 03:12:32.802458 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-23 03:12:33.613858 | debian-bookworm | changed 2026-05-23 03:12:33.627316 | 2026-05-23 03:12:33.627517 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-23 03:12:34.419158 | debian-bookworm | changed 2026-05-23 03:12:34.425750 | 2026-05-23 03:12:34.425872 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-23 03:12:34.449996 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:12:34.456331 | 2026-05-23 03:12:34.456449 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-23 03:12:34.966817 | debian-bookworm -> localhost | changed 2026-05-23 03:12:34.978714 | 2026-05-23 03:12:34.981342 | TASK [add-build-sshkey : Add back temp key] 2026-05-23 03:12:35.461870 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/dc26bf3e85e04862a038b9b6c2fd212c_id_rsa (zuul-build-sshkey) 2026-05-23 03:12:35.462143 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032061 2026-05-23 03:12:35.472023 | 2026-05-23 03:12:35.472162 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-23 03:12:35.974145 | debian-bookworm | ok 2026-05-23 03:12:35.980344 | 2026-05-23 03:12:35.980473 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-23 03:12:36.011420 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:12:36.025279 | 2026-05-23 03:12:36.025434 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-23 03:12:36.634356 | debian-bookworm | ok 2026-05-23 03:12:36.647631 | 2026-05-23 03:12:36.647753 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-23 03:12:36.677010 | debian-bookworm | ok 2026-05-23 03:12:36.682263 | 2026-05-23 03:12:36.682374 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-23 03:12:37.085709 | debian-bookworm -> localhost | ok 2026-05-23 03:12:37.092540 | 2026-05-23 03:12:37.092633 | TASK [validate-host : Collect information about the host] 2026-05-23 03:12:38.286396 | debian-bookworm | ok 2026-05-23 03:12:38.310747 | 2026-05-23 03:12:38.310926 | TASK [validate-host : Sanitize hostname] 2026-05-23 03:12:38.450859 | debian-bookworm | ok 2026-05-23 03:12:38.536712 | 2026-05-23 03:12:38.536843 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-23 03:12:39.353500 | debian-bookworm -> localhost | changed 2026-05-23 03:12:39.366468 | 2026-05-23 03:12:39.366608 | TASK [validate-host : Collect information about zuul worker] 2026-05-23 03:12:39.847645 | debian-bookworm | ok 2026-05-23 03:12:39.855570 | 2026-05-23 03:12:39.855733 | TASK [validate-host : Write out all zuul information for each host] 2026-05-23 03:12:40.498637 | debian-bookworm -> localhost | changed 2026-05-23 03:12:40.508649 | 2026-05-23 03:12:40.509903 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-23 03:12:40.780624 | debian-bookworm | ok 2026-05-23 03:12:40.786673 | 2026-05-23 03:12:40.786781 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-23 03:12:41.741343 | debian-bookworm | changed: 2026-05-23 03:12:41.741622 | debian-bookworm | cd+++++++++ src/ 2026-05-23 03:12:41.741660 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-23 03:12:41.741686 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-23 03:12:41.741709 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2026-05-23 03:12:41.741729 | debian-bookworm | Containerfile 2026-05-23 03:12:41.741878 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/logs" 2026-05-23 03:13:09.635753 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/artifacts" 2026-05-23 03:13:10.099932 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/dc26bf3e85e04862a038b9b6c2fd212c/work/docs" 2026-05-23 03:13:10.116872 | 2026-05-23 03:13:10.117011 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-23 03:13:11.132762 | debian-bookworm | changed: 2026-05-23 03:13:11.133523 | debian-bookworm | .d..t...... ./ 2026-05-23 03:13:11.133590 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-23 03:13:11.134683 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-23 03:13:11.134768 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-23 03:13:11.134866 | debian-bookworm | changed: All items complete 2026-05-23 03:13:11.134903 | 2026-05-23 03:13:12.368230 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:13:13.334667 | debian-bookworm | changed: .d..t...... ./ 2026-05-23 03:13:13.352691 | 2026-05-23 03:13:13.352822 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-23 03:13:13.412159 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:13:13.418718 | debian-bookworm | skipping: Conditional result was False 2026-05-23 03:13:13.430516 | 2026-05-23 03:13:13.432139 | PLAY RECAP 2026-05-23 03:13:13.432232 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-23 03:13:13.432261 | 2026-05-23 03:13:13.641827 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-23 03:13:13.642647 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:13:14.810298 | 2026-05-23 03:13:14.810466 | PLAY [Base post] 2026-05-23 03:13:14.823333 | 2026-05-23 03:13:14.823468 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-23 03:13:15.465387 | debian-bookworm | changed 2026-05-23 03:13:15.471448 | 2026-05-23 03:13:15.471573 | PLAY RECAP 2026-05-23 03:13:15.471634 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-23 03:13:15.471693 | 2026-05-23 03:13:15.559626 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-23 03:13:15.560427 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-23 03:13:16.375543 | 2026-05-23 03:13:16.375678 | PLAY [Base post-logs] 2026-05-23 03:13:16.385362 | 2026-05-23 03:13:16.385476 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-23 03:13:17.128597 | localhost | changed 2026-05-23 03:13:17.138300 | 2026-05-23 03:13:17.138437 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-23 03:13:17.193970 | localhost | ok 2026-05-23 03:13:17.196993 | 2026-05-23 03:13:17.197086 | TASK [Set zuul-log-path fact] 2026-05-23 03:13:17.222080 | localhost | ok 2026-05-23 03:13:17.229947 | 2026-05-23 03:13:17.230053 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-23 03:13:17.277854 | localhost | ok 2026-05-23 03:13:17.280850 | 2026-05-23 03:13:17.280949 | TASK [upload-logs : Create log directories] 2026-05-23 03:13:18.074067 | localhost | changed 2026-05-23 03:13:18.076804 | 2026-05-23 03:13:18.076899 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-23 03:13:18.762795 | localhost -> localhost | ok: Runtime: 0:00:00.003692 2026-05-23 03:13:18.766385 | 2026-05-23 03:13:18.766484 | TASK [upload-logs : Upload logs to log server] 2026-05-23 03:13:19.584665 | localhost | Output suppressed because no_log was given 2026-05-23 03:13:19.586291 | 2026-05-23 03:13:19.586373 | LOOP [upload-logs : Compress console log and json output] 2026-05-23 03:13:19.638448 | localhost | skipping: Conditional result was False 2026-05-23 03:13:19.643622 | localhost | skipping: Conditional result was False 2026-05-23 03:13:19.653139 | 2026-05-23 03:13:19.653239 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-23 03:13:19.753616 | localhost | skipping: Conditional result was False 2026-05-23 03:13:19.756534 | 2026-05-23 03:13:19.757380 | localhost | skipping: Conditional result was False 2026-05-23 03:13:19.766265 | 2026-05-23 03:13:19.766369 | LOOP [upload-logs : Upload console log and json output]