2026-02-26 18:20:50.015932 | Job console starting 2026-02-26 18:20:50.029111 | Updating git repos 2026-02-26 18:20:50.064653 | Cloning repos into workspace 2026-02-26 18:20:50.132793 | Restoring repo states 2026-02-26 18:20:50.143429 | Merging changes 2026-02-26 18:20:50.645165 | Checking out repos 2026-02-26 18:20:50.708434 | Preparing playbooks 2026-02-26 18:20:51.509008 | Running Ansible setup 2026-02-26 18:20:55.962464 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-26 18:20:56.752005 | 2026-02-26 18:20:56.752172 | PLAY [Base pre] 2026-02-26 18:20:56.769578 | 2026-02-26 18:20:56.769744 | TASK [Setup log path fact] 2026-02-26 18:20:56.798802 | debian-bookworm | ok 2026-02-26 18:20:56.814877 | 2026-02-26 18:20:56.815025 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-26 18:20:56.856133 | debian-bookworm | ok 2026-02-26 18:20:56.866449 | 2026-02-26 18:20:56.866565 | TASK [emit-job-header : Print job information] 2026-02-26 18:20:56.908426 | # Job Information 2026-02-26 18:20:56.908598 | Ansible Version: 2.16.14 2026-02-26 18:20:56.908632 | Job: python-black 2026-02-26 18:20:56.908664 | Pipeline: check 2026-02-26 18:20:56.908722 | Executor: 521e9411259a 2026-02-26 18:20:56.908744 | Triggered by: https://github.com/osism/testbed/pull/2850 2026-02-26 18:20:56.908767 | Event ID: db2d6a10-133f-11f1-8fb6-26b029a9db6e 2026-02-26 18:20:56.913744 | 2026-02-26 18:20:56.913860 | LOOP [emit-job-header : Print node information] 2026-02-26 18:20:57.024622 | debian-bookworm | ok: 2026-02-26 18:20:57.024923 | debian-bookworm | # Node Information 2026-02-26 18:20:57.024962 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-26 18:20:57.024987 | debian-bookworm | Hostname: debian 2026-02-26 18:20:57.025009 | debian-bookworm | Username: zuul 2026-02-26 18:20:57.025030 | debian-bookworm | Distro: Debian 12.13 2026-02-26 18:20:57.025053 | debian-bookworm | Provider: regiocloud-a 2026-02-26 18:20:57.025074 | debian-bookworm | Region: 2026-02-26 18:20:57.025095 | debian-bookworm | Label: debian-bookworm 2026-02-26 18:20:57.025114 | debian-bookworm | Product Name: OpenStack Nova 2026-02-26 18:20:57.025134 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5c:4d18 2026-02-26 18:20:57.052933 | 2026-02-26 18:20:57.053090 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-26 18:20:57.573386 | debian-bookworm -> localhost | changed 2026-02-26 18:20:57.581136 | 2026-02-26 18:20:57.581288 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-26 18:20:58.710296 | debian-bookworm -> localhost | changed 2026-02-26 18:20:58.721586 | 2026-02-26 18:20:58.721758 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-26 18:20:58.993998 | debian-bookworm -> localhost | ok 2026-02-26 18:20:59.004073 | 2026-02-26 18:20:59.004217 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-26 18:20:59.033395 | debian-bookworm | ok 2026-02-26 18:20:59.052173 | debian-bookworm | included: /var/lib/zuul/builds/ea7c8df56f5b4bd891316cc76600e581/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-26 18:20:59.058563 | 2026-02-26 18:20:59.058716 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-26 18:21:00.369452 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-26 18:21:00.369721 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ea7c8df56f5b4bd891316cc76600e581/work/ea7c8df56f5b4bd891316cc76600e581_id_rsa 2026-02-26 18:21:00.369764 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ea7c8df56f5b4bd891316cc76600e581/work/ea7c8df56f5b4bd891316cc76600e581_id_rsa.pub 2026-02-26 18:21:00.369790 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-26 18:21:00.369815 | debian-bookworm -> localhost | SHA256:wt486S3tjxvHrvqqnMJcHv5FFQXYGlo6lvTyn8CWDRk zuul-build-sshkey 2026-02-26 18:21:00.369838 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-26 18:21:00.369876 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-26 18:21:00.369899 | debian-bookworm -> localhost | | ooo. | 2026-02-26 18:21:00.369920 | debian-bookworm -> localhost | | . E .. | 2026-02-26 18:21:00.369941 | debian-bookworm -> localhost | | . * =. | 2026-02-26 18:21:00.369961 | debian-bookworm -> localhost | | . B =. | 2026-02-26 18:21:00.369980 | debian-bookworm -> localhost | | o.S=.+ | 2026-02-26 18:21:00.370004 | debian-bookworm -> localhost | | .o+ o*.. | 2026-02-26 18:21:00.370024 | debian-bookworm -> localhost | | o +..=oooo. | 2026-02-26 18:21:00.370044 | debian-bookworm -> localhost | | +.oo.+.=o | 2026-02-26 18:21:00.370065 | debian-bookworm -> localhost | | .+o=*B+o | 2026-02-26 18:21:00.370086 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-26 18:21:00.370138 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.780097 2026-02-26 18:21:00.376735 | 2026-02-26 18:21:00.376852 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-26 18:21:00.405621 | debian-bookworm | ok 2026-02-26 18:21:00.415312 | debian-bookworm | included: /var/lib/zuul/builds/ea7c8df56f5b4bd891316cc76600e581/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-26 18:21:00.424417 | 2026-02-26 18:21:00.424515 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-26 18:21:00.448742 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:21:00.455207 | 2026-02-26 18:21:00.455312 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-26 18:21:01.090046 | debian-bookworm | changed 2026-02-26 18:21:01.099156 | 2026-02-26 18:21:01.099295 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-26 18:21:01.361851 | debian-bookworm | ok 2026-02-26 18:21:01.371340 | 2026-02-26 18:21:01.371492 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-26 18:21:02.056255 | debian-bookworm | changed 2026-02-26 18:21:02.066892 | 2026-02-26 18:21:02.067069 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-26 18:21:02.717563 | debian-bookworm | changed 2026-02-26 18:21:02.723361 | 2026-02-26 18:21:02.723475 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-26 18:21:02.757142 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:21:02.763227 | 2026-02-26 18:21:02.763335 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-26 18:21:03.230020 | debian-bookworm -> localhost | changed 2026-02-26 18:21:03.249861 | 2026-02-26 18:21:03.250054 | TASK [add-build-sshkey : Add back temp key] 2026-02-26 18:21:03.607856 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ea7c8df56f5b4bd891316cc76600e581/work/ea7c8df56f5b4bd891316cc76600e581_id_rsa (zuul-build-sshkey) 2026-02-26 18:21:03.608108 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010383 2026-02-26 18:21:03.616368 | 2026-02-26 18:21:03.616496 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-26 18:21:04.029139 | debian-bookworm | ok 2026-02-26 18:21:04.035727 | 2026-02-26 18:21:04.035856 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-26 18:21:04.059866 | debian-bookworm | skipping: Conditional result was False 2026-02-26 18:21:04.071073 | 2026-02-26 18:21:04.071196 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-26 18:21:04.524924 | debian-bookworm | ok 2026-02-26 18:21:04.542374 | 2026-02-26 18:21:04.542517 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-26 18:21:04.601863 | debian-bookworm | ok 2026-02-26 18:21:04.607092 | 2026-02-26 18:21:04.607207 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-26 18:21:04.917498 | debian-bookworm -> localhost | ok 2026-02-26 18:21:04.931805 | 2026-02-26 18:21:04.931969 | TASK [validate-host : Collect information about the host] 2026-02-26 18:21:06.047934 | debian-bookworm | ok 2026-02-26 18:21:06.058200 | 2026-02-26 18:21:06.058312 | TASK [validate-host : Sanitize hostname] 2026-02-26 18:21:06.175870 | debian-bookworm | ok 2026-02-26 18:21:06.216175 | 2026-02-26 18:21:06.216304 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-26 18:21:06.807061 | debian-bookworm -> localhost | changed 2026-02-26 18:21:06.812950 | 2026-02-26 18:21:06.813064 | TASK [validate-host : Collect information about zuul worker] 2026-02-26 18:21:07.236591 | debian-bookworm | ok 2026-02-26 18:21:07.241529 | 2026-02-26 18:21:07.241648 | TASK [validate-host : Write out all zuul information for each host] 2026-02-26 18:21:07.802583 | debian-bookworm -> localhost | changed 2026-02-26 18:21:07.812699 | 2026-02-26 18:21:07.812824 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-26 18:21:08.101766 | debian-bookworm | ok 2026-02-26 18:21:08.108455 | 2026-02-26 18:21:08.108568 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-26 18:21:09.257983 | debian-bookworm | changed: 2026-02-26 18:21:09.258198 | debian-bookworm | cd+++++++++ src/ 2026-02-26 18:21:09.258236 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-26 18:21:09.258261 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-26 18:21:09.258284 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-02-26 18:21:09.258306 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007336 2026-02-26 18:21:33.987697 | 2026-02-26 18:21:33.987825 | TASK [upload-logs : Upload logs to log server] 2026-02-26 18:21:34.520283 | localhost | Output suppressed because no_log was given 2026-02-26 18:21:34.522163 | 2026-02-26 18:21:34.522268 | LOOP [upload-logs : Compress console log and json output] 2026-02-26 18:21:34.570549 | localhost | skipping: Conditional result was False 2026-02-26 18:21:34.577096 | localhost | skipping: Conditional result was False 2026-02-26 18:21:34.589163 | 2026-02-26 18:21:34.589281 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-26 18:21:34.641597 | localhost | skipping: Conditional result was False 2026-02-26 18:21:34.641916 | 2026-02-26 18:21:34.648629 | localhost | skipping: Conditional result was False 2026-02-26 18:21:34.656270 | 2026-02-26 18:21:34.656395 | LOOP [upload-logs : Upload console log and json output]