2026-03-19 22:03:50.749340 | Job console starting 2026-03-19 22:03:50.781463 | Updating git repos 2026-03-19 22:03:50.863947 | Cloning repos into workspace 2026-03-19 22:03:50.915181 | Restoring repo states 2026-03-19 22:03:50.927399 | Merging changes 2026-03-19 22:03:51.685528 | Checking out repos 2026-03-19 22:03:51.770662 | Preparing playbooks 2026-03-19 22:03:52.920978 | Running Ansible setup 2026-03-19 22:03:59.825066 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-19 22:04:01.249363 | 2026-03-19 22:04:01.249547 | PLAY [Base pre] 2026-03-19 22:04:01.275662 | 2026-03-19 22:04:01.275788 | TASK [Setup log path fact] 2026-03-19 22:04:01.304962 | debian-bookworm | ok 2026-03-19 22:04:01.330496 | 2026-03-19 22:04:01.330649 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-19 22:04:01.419048 | debian-bookworm | ok 2026-03-19 22:04:01.441996 | 2026-03-19 22:04:01.442108 | TASK [emit-job-header : Print job information] 2026-03-19 22:04:01.501040 | # Job Information 2026-03-19 22:04:01.501296 | Ansible Version: 2.16.14 2026-03-19 22:04:01.501336 | Job: python-black 2026-03-19 22:04:01.501373 | Pipeline: check 2026-03-19 22:04:01.501399 | Executor: 521e9411259a 2026-03-19 22:04:01.501420 | Triggered by: https://github.com/osism/python-osism/pull/2102 2026-03-19 22:04:01.501442 | Event ID: 7cffe3e0-23df-11f1-8f48-ccd2a732fe93 2026-03-19 22:04:01.509254 | 2026-03-19 22:04:01.509378 | LOOP [emit-job-header : Print node information] 2026-03-19 22:04:01.616220 | debian-bookworm | ok: 2026-03-19 22:04:01.616381 | debian-bookworm | # Node Information 2026-03-19 22:04:01.616416 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-19 22:04:01.616441 | debian-bookworm | Hostname: debian 2026-03-19 22:04:01.616463 | debian-bookworm | Username: zuul 2026-03-19 22:04:01.616484 | debian-bookworm | Distro: Debian 12.13 2026-03-19 22:04:01.616509 | debian-bookworm | Provider: regiocloud-a 2026-03-19 22:04:01.616531 | debian-bookworm | Region: 2026-03-19 22:04:01.616548 | debian-bookworm | Label: debian-bookworm 2026-03-19 22:04:01.616565 | debian-bookworm | Product Name: OpenStack Nova 2026-03-19 22:04:01.616581 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe70:a144 2026-03-19 22:04:01.635523 | 2026-03-19 22:04:01.635633 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-19 22:04:03.093553 | debian-bookworm -> localhost | changed 2026-03-19 22:04:03.099187 | 2026-03-19 22:04:03.099299 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-19 22:04:05.553214 | debian-bookworm -> localhost | changed 2026-03-19 22:04:05.561733 | 2026-03-19 22:04:05.561822 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-19 22:04:06.137764 | debian-bookworm -> localhost | ok 2026-03-19 22:04:06.142539 | 2026-03-19 22:04:06.142625 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-19 22:04:06.179302 | debian-bookworm | ok 2026-03-19 22:04:06.211751 | debian-bookworm | included: /var/lib/zuul/builds/522415cd1e5c4fccb84b4eed132cd017/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-19 22:04:06.216699 | 2026-03-19 22:04:06.216793 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-19 22:04:12.250904 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-19 22:04:12.251068 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/522415cd1e5c4fccb84b4eed132cd017/work/522415cd1e5c4fccb84b4eed132cd017_id_rsa 2026-03-19 22:04:12.251098 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/522415cd1e5c4fccb84b4eed132cd017/work/522415cd1e5c4fccb84b4eed132cd017_id_rsa.pub 2026-03-19 22:04:12.251120 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-19 22:04:12.251141 | debian-bookworm -> localhost | SHA256:zOUVvlXhNILaMQgrigSIu3QbJ8hUd6nXLAZ2z+PNrmk zuul-build-sshkey 2026-03-19 22:04:12.251159 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-19 22:04:12.251185 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-19 22:04:12.251203 | debian-bookworm -> localhost | |+ .. . oo . o. +o| 2026-03-19 22:04:12.251220 | debian-bookworm -> localhost | |+. .o.o.. = .+..| 2026-03-19 22:04:12.251237 | debian-bookworm -> localhost | |oo. ..+.= + = .. | 2026-03-19 22:04:12.251252 | debian-bookworm -> localhost | |o+.+.o.* X o o | 2026-03-19 22:04:12.251268 | debian-bookworm -> localhost | |.o..= o S = . | 2026-03-19 22:04:12.251313 | debian-bookworm -> localhost | |. . . o | 2026-03-19 22:04:12.251335 | debian-bookworm -> localhost | | . | 2026-03-19 22:04:12.251352 | debian-bookworm -> localhost | | E.. | 2026-03-19 22:04:12.251369 | debian-bookworm -> localhost | | .o. | 2026-03-19 22:04:12.251385 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-19 22:04:12.251426 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.581536 2026-03-19 22:04:12.256433 | 2026-03-19 22:04:12.256510 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-19 22:04:12.330338 | debian-bookworm | ok 2026-03-19 22:04:12.347521 | debian-bookworm | included: /var/lib/zuul/builds/522415cd1e5c4fccb84b4eed132cd017/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-19 22:04:12.355728 | 2026-03-19 22:04:12.355807 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-19 22:04:12.388912 | debian-bookworm | skipping: Conditional result was False 2026-03-19 22:04:12.394010 | 2026-03-19 22:04:12.394094 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-19 22:04:13.181264 | debian-bookworm | changed 2026-03-19 22:04:13.186442 | 2026-03-19 22:04:13.186526 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-19 22:04:13.421475 | debian-bookworm | ok 2026-03-19 22:04:13.428432 | 2026-03-19 22:04:13.428513 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-19 22:04:14.201495 | debian-bookworm | changed 2026-03-19 22:04:14.207348 | 2026-03-19 22:04:14.207430 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-19 22:04:14.969560 | debian-bookworm | changed 2026-03-19 22:04:14.984195 | 2026-03-19 22:04:14.984320 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-19 22:04:15.017416 | debian-bookworm | skipping: Conditional result was False 2026-03-19 22:04:15.023320 | 2026-03-19 22:04:15.023420 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-19 22:04:15.511518 | debian-bookworm -> localhost | changed 2026-03-19 22:04:15.522960 | 2026-03-19 22:04:15.523055 | TASK [add-build-sshkey : Add back temp key] 2026-03-19 22:04:15.970189 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/522415cd1e5c4fccb84b4eed132cd017/work/522415cd1e5c4fccb84b4eed132cd017_id_rsa (zuul-build-sshkey) 2026-03-19 22:04:15.970437 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014839 2026-03-19 22:04:15.978481 | 2026-03-19 22:04:15.978579 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-19 22:04:16.509891 | debian-bookworm | ok 2026-03-19 22:04:16.520780 | 2026-03-19 22:04:16.520889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-19 22:04:16.567750 | debian-bookworm | skipping: Conditional result was False 2026-03-19 22:04:16.578920 | 2026-03-19 22:04:16.579026 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-19 22:04:17.103019 | debian-bookworm | ok 2026-03-19 22:04:17.127914 | 2026-03-19 22:04:17.128011 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-19 22:04:17.207319 | debian-bookworm | ok 2026-03-19 22:04:17.216904 | 2026-03-19 22:04:17.216994 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-19 22:04:17.591012 | debian-bookworm -> localhost | ok 2026-03-19 22:04:17.597230 | 2026-03-19 22:04:17.597330 | TASK [validate-host : Collect information about the host] 2026-03-19 22:04:18.922436 | debian-bookworm | ok 2026-03-19 22:04:18.936843 | 2026-03-19 22:04:18.936934 | TASK [validate-host : Sanitize hostname] 2026-03-19 22:04:19.145034 | debian-bookworm | ok 2026-03-19 22:04:19.233833 | 2026-03-19 22:04:19.233936 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-19 22:04:20.173047 | debian-bookworm -> localhost | changed 2026-03-19 22:04:20.177712 | 2026-03-19 22:04:20.177796 | TASK [validate-host : Collect information about zuul worker] 2026-03-19 22:04:20.643708 | debian-bookworm | ok 2026-03-19 22:04:20.649014 | 2026-03-19 22:04:20.649100 | TASK [validate-host : Write out all zuul information for each host] 2026-03-19 22:04:21.615538 | debian-bookworm -> localhost | changed 2026-03-19 22:04:21.639385 | 2026-03-19 22:04:21.639492 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-19 22:04:21.942887 | debian-bookworm | ok 2026-03-19 22:04:21.952053 | 2026-03-19 22:04:21.952151 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-19 22:04:23.494687 | debian-bookworm | changed: 2026-03-19 22:04:23.495006 | debian-bookworm | cd+++++++++ src/ 2026-03-19 22:04:23.495050 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-19 22:04:23.495071 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-19 22:04:23.495089 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-03-19 22:04:23.495106 | debian-bookworm | Containerfile 2026-03-19 22:04:23.495215 | debian-bookworm | Containerfile 2026-03-19 22:04:23.522147 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006558 2026-03-19 22:04:52.805476 | 2026-03-19 22:04:52.805595 | TASK [upload-logs : Upload logs to log server] 2026-03-19 22:04:53.361659 | localhost | Output suppressed because no_log was given 2026-03-19 22:04:53.363821 | 2026-03-19 22:04:53.363900 | LOOP [upload-logs : Compress console log and json output] 2026-03-19 22:04:53.398789 | localhost | skipping: Conditional result was False 2026-03-19 22:04:53.404699 | localhost | skipping: Conditional result was False 2026-03-19 22:04:53.408486 | 2026-03-19 22:04:53.408567 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-19 22:04:53.444391 | localhost | skipping: Conditional result was False 2026-03-19 22:04:53.444599 | 2026-03-19 22:04:53.449615 | localhost | skipping: Conditional result was False 2026-03-19 22:04:53.453398 | 2026-03-19 22:04:53.453481 | LOOP [upload-logs : Upload console log and json output]