2026-01-29 09:51:56.556274 | Job console starting 2026-01-29 09:51:56.588977 | Updating git repos 2026-01-29 09:51:56.682316 | Cloning repos into workspace 2026-01-29 09:51:56.741602 | Restoring repo states 2026-01-29 09:51:56.768784 | Merging changes 2026-01-29 09:51:57.377963 | Checking out repos 2026-01-29 09:51:57.435851 | Preparing playbooks 2026-01-29 09:51:58.664394 | Running Ansible setup 2026-01-29 09:52:04.076083 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 09:52:05.075808 | 2026-01-29 09:52:05.075990 | PLAY [Base pre] 2026-01-29 09:52:05.110987 | 2026-01-29 09:52:05.111155 | TASK [Setup log path fact] 2026-01-29 09:52:05.134554 | debian-bookworm | ok 2026-01-29 09:52:05.169227 | 2026-01-29 09:52:05.169403 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 09:52:05.241247 | debian-bookworm | ok 2026-01-29 09:52:05.266236 | 2026-01-29 09:52:05.266394 | TASK [emit-job-header : Print job information] 2026-01-29 09:52:05.336496 | # Job Information 2026-01-29 09:52:05.336687 | Ansible Version: 2.16.14 2026-01-29 09:52:05.336723 | Job: python-black 2026-01-29 09:52:05.336755 | Pipeline: check 2026-01-29 09:52:05.336778 | Executor: 521e9411259a 2026-01-29 09:52:05.336799 | Triggered by: https://github.com/osism/python-osism/pull/1975 2026-01-29 09:52:05.336820 | Event ID: 1f876020-fcf8-11f0-8521-e59fe54c0aed 2026-01-29 09:52:05.342395 | 2026-01-29 09:52:05.342514 | LOOP [emit-job-header : Print node information] 2026-01-29 09:52:05.574413 | debian-bookworm | ok: 2026-01-29 09:52:05.574664 | debian-bookworm | # Node Information 2026-01-29 09:52:05.574700 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 09:52:05.574726 | debian-bookworm | Hostname: debian 2026-01-29 09:52:05.574749 | debian-bookworm | Username: zuul 2026-01-29 09:52:05.574770 | debian-bookworm | Distro: Debian 12.13 2026-01-29 09:52:05.574806 | debian-bookworm | Provider: regiocloud-a 2026-01-29 09:52:05.574828 | debian-bookworm | Region: 2026-01-29 09:52:05.574879 | debian-bookworm | Label: debian-bookworm 2026-01-29 09:52:05.574900 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 09:52:05.574920 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:a062 2026-01-29 09:52:05.615002 | 2026-01-29 09:52:05.615167 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 09:52:06.500926 | debian-bookworm -> localhost | changed 2026-01-29 09:52:06.508339 | 2026-01-29 09:52:06.508465 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 09:52:08.260212 | debian-bookworm -> localhost | changed 2026-01-29 09:52:08.274533 | 2026-01-29 09:52:08.274642 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 09:52:08.716118 | debian-bookworm -> localhost | ok 2026-01-29 09:52:08.722012 | 2026-01-29 09:52:08.722113 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 09:52:08.751635 | debian-bookworm | ok 2026-01-29 09:52:08.780042 | debian-bookworm | included: /var/lib/zuul/builds/ca497d9846f043378e7e79b9f929ae07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 09:52:08.805469 | 2026-01-29 09:52:08.805578 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 09:52:12.437747 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 09:52:12.437959 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ca497d9846f043378e7e79b9f929ae07/work/ca497d9846f043378e7e79b9f929ae07_id_rsa 2026-01-29 09:52:12.438000 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ca497d9846f043378e7e79b9f929ae07/work/ca497d9846f043378e7e79b9f929ae07_id_rsa.pub 2026-01-29 09:52:12.438027 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 09:52:12.438050 | debian-bookworm -> localhost | SHA256:vqp5RqPGN7n0l4NkM6w81RjSWi7YrZs+J2/VpUlIYug zuul-build-sshkey 2026-01-29 09:52:12.438073 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 09:52:12.438105 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 09:52:12.438129 | debian-bookworm -> localhost | | . | 2026-01-29 09:52:12.438152 | debian-bookworm -> localhost | | . o . | 2026-01-29 09:52:12.438223 | debian-bookworm -> localhost | | . o o . | 2026-01-29 09:52:12.438247 | debian-bookworm -> localhost | | E + . . . | 2026-01-29 09:52:12.438268 | debian-bookworm -> localhost | | o BS+ o + | 2026-01-29 09:52:12.438296 | debian-bookworm -> localhost | | . *.@ o + | 2026-01-29 09:52:12.438318 | debian-bookworm -> localhost | | . +.X.= . | 2026-01-29 09:52:12.438340 | debian-bookworm -> localhost | | +o&o+.+ | 2026-01-29 09:52:12.438362 | debian-bookworm -> localhost | | .o**%+. . | 2026-01-29 09:52:12.438383 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 09:52:12.438439 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.782448 2026-01-29 09:52:12.445715 | 2026-01-29 09:52:12.445812 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 09:52:12.473741 | debian-bookworm | ok 2026-01-29 09:52:12.484044 | debian-bookworm | included: /var/lib/zuul/builds/ca497d9846f043378e7e79b9f929ae07/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 09:52:12.492933 | 2026-01-29 09:52:12.493019 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 09:52:12.505882 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:52:12.512712 | 2026-01-29 09:52:12.512860 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 09:52:13.107355 | debian-bookworm | changed 2026-01-29 09:52:13.112490 | 2026-01-29 09:52:13.112585 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 09:52:13.379814 | debian-bookworm | ok 2026-01-29 09:52:13.384969 | 2026-01-29 09:52:13.385050 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 09:52:14.058179 | debian-bookworm | changed 2026-01-29 09:52:14.064821 | 2026-01-29 09:52:14.064926 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 09:52:14.759381 | debian-bookworm | changed 2026-01-29 09:52:14.767140 | 2026-01-29 09:52:14.767264 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 09:52:14.793114 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:52:14.799092 | 2026-01-29 09:52:14.799221 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 09:52:15.334905 | debian-bookworm -> localhost | changed 2026-01-29 09:52:15.345442 | 2026-01-29 09:52:15.345543 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 09:52:15.756853 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ca497d9846f043378e7e79b9f929ae07/work/ca497d9846f043378e7e79b9f929ae07_id_rsa (zuul-build-sshkey) 2026-01-29 09:52:15.757205 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017224 2026-01-29 09:52:15.769426 | 2026-01-29 09:52:15.769556 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 09:52:16.162150 | debian-bookworm | ok 2026-01-29 09:52:16.166939 | 2026-01-29 09:52:16.167028 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 09:52:16.189973 | debian-bookworm | skipping: Conditional result was False 2026-01-29 09:52:16.199997 | 2026-01-29 09:52:16.200107 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 09:52:16.695673 | debian-bookworm | ok 2026-01-29 09:52:16.707279 | 2026-01-29 09:52:16.707393 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 09:52:16.766226 | debian-bookworm | ok 2026-01-29 09:52:16.771128 | 2026-01-29 09:52:16.771235 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 09:52:17.188334 | debian-bookworm -> localhost | ok 2026-01-29 09:52:17.195138 | 2026-01-29 09:52:17.195264 | TASK [validate-host : Collect information about the host] 2026-01-29 09:52:18.416693 | debian-bookworm | ok 2026-01-29 09:52:18.428537 | 2026-01-29 09:52:18.428633 | TASK [validate-host : Sanitize hostname] 2026-01-29 09:52:18.515272 | debian-bookworm | ok 2026-01-29 09:52:18.564661 | 2026-01-29 09:52:18.564844 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 09:52:19.231489 | debian-bookworm -> localhost | changed 2026-01-29 09:52:19.236871 | 2026-01-29 09:52:19.236970 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 09:52:19.722803 | debian-bookworm | ok 2026-01-29 09:52:19.727891 | 2026-01-29 09:52:19.728024 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 09:52:20.665125 | debian-bookworm -> localhost | changed 2026-01-29 09:52:20.679627 | 2026-01-29 09:52:20.679774 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 09:52:20.998002 | debian-bookworm | ok 2026-01-29 09:52:21.005321 | 2026-01-29 09:52:21.005451 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 09:52:22.203105 | debian-bookworm | changed: 2026-01-29 09:52:22.203326 | debian-bookworm | cd+++++++++ src/ 2026-01-29 09:52:22.203363 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 09:52:22.203388 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 09:52:22.203411 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-29 09:52:22.203432 | debian-bookworm | Containerfile 2026-01-29 09:52:22.203565 | debian-bookworm | Containerfile 2026-01-29 09:52:22.211424 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007071 2026-01-29 09:52:50.186733 | 2026-01-29 09:52:50.186994 | TASK [upload-logs : Upload logs to log server] 2026-01-29 09:52:50.758592 | localhost | Output suppressed because no_log was given 2026-01-29 09:52:50.760680 | 2026-01-29 09:52:50.760791 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 09:52:50.813343 | localhost | skipping: Conditional result was False 2026-01-29 09:52:50.837260 | localhost | skipping: Conditional result was False 2026-01-29 09:52:50.849022 | 2026-01-29 09:52:50.849173 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 09:52:50.894270 | localhost | skipping: Conditional result was False 2026-01-29 09:52:50.894564 | 2026-01-29 09:52:50.899367 | localhost | skipping: Conditional result was False 2026-01-29 09:52:50.907750 | 2026-01-29 09:52:50.907868 | LOOP [upload-logs : Upload console log and json output]