2025-06-05 08:20:00.580937 | Job console starting 2025-06-05 08:20:00.604497 | Updating git repos 2025-06-05 08:20:00.638475 | Cloning repos into workspace 2025-06-05 08:20:00.709591 | Restoring repo states 2025-06-05 08:20:00.724008 | Merging changes 2025-06-05 08:20:01.251647 | Checking out repos 2025-06-05 08:20:01.297381 | Preparing playbooks 2025-06-05 08:20:02.073586 | Running Ansible setup 2025-06-05 08:20:06.690385 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-05 08:20:07.923277 | 2025-06-05 08:20:07.923438 | PLAY [Base pre] 2025-06-05 08:20:07.940230 | 2025-06-05 08:20:07.940375 | TASK [Setup log path fact] 2025-06-05 08:20:07.984828 | debian-bookworm | ok 2025-06-05 08:20:07.999921 | 2025-06-05 08:20:08.000066 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-05 08:20:08.030481 | debian-bookworm | ok 2025-06-05 08:20:08.042025 | 2025-06-05 08:20:08.042166 | TASK [emit-job-header : Print job information] 2025-06-05 08:20:08.081263 | # Job Information 2025-06-05 08:20:08.081445 | Ansible Version: 2.16.14 2025-06-05 08:20:08.081480 | Job: python-black 2025-06-05 08:20:08.081512 | Pipeline: check 2025-06-05 08:20:08.081535 | Executor: 521e9411259a 2025-06-05 08:20:08.081556 | Triggered by: https://github.com/osism/testbed/pull/2725 2025-06-05 08:20:08.081579 | Event ID: daaf4080-41e5-11f0-87dd-386553a35b8c 2025-06-05 08:20:08.089624 | 2025-06-05 08:20:08.089773 | LOOP [emit-job-header : Print node information] 2025-06-05 08:20:08.318031 | debian-bookworm | ok: 2025-06-05 08:20:08.318974 | debian-bookworm | # Node Information 2025-06-05 08:20:08.319064 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-05 08:20:08.319100 | debian-bookworm | Hostname: debian 2025-06-05 08:20:08.319130 | debian-bookworm | Username: zuul 2025-06-05 08:20:08.319157 | debian-bookworm | Distro: Debian 12.11 2025-06-05 08:20:08.319189 | debian-bookworm | Provider: regiocloud-a 2025-06-05 08:20:08.319218 | debian-bookworm | Region: 2025-06-05 08:20:08.319245 | debian-bookworm | Label: debian-bookworm 2025-06-05 08:20:08.319269 | debian-bookworm | Product Name: OpenStack Nova 2025-06-05 08:20:08.319293 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe46:f821 2025-06-05 08:20:08.342537 | 2025-06-05 08:20:08.342721 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-05 08:20:09.402450 | debian-bookworm -> localhost | changed 2025-06-05 08:20:09.410690 | 2025-06-05 08:20:09.410851 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-05 08:20:10.691975 | debian-bookworm -> localhost | changed 2025-06-05 08:20:10.707238 | 2025-06-05 08:20:10.707382 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-05 08:20:11.106219 | debian-bookworm -> localhost | ok 2025-06-05 08:20:11.113045 | 2025-06-05 08:20:11.113210 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-05 08:20:11.156167 | debian-bookworm | ok 2025-06-05 08:20:11.191113 | debian-bookworm | included: /var/lib/zuul/builds/33a3516223794966865f14679c35dc1d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-05 08:20:11.209867 | 2025-06-05 08:20:11.210013 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-05 08:20:12.369785 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-05 08:20:12.370011 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/33a3516223794966865f14679c35dc1d/work/33a3516223794966865f14679c35dc1d_id_rsa 2025-06-05 08:20:12.370050 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/33a3516223794966865f14679c35dc1d/work/33a3516223794966865f14679c35dc1d_id_rsa.pub 2025-06-05 08:20:12.370075 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-05 08:20:12.370101 | debian-bookworm -> localhost | SHA256:2xWw4id0vsw+Buy8C69Ew90p3aofOXkcB7noRs+GckI zuul-build-sshkey 2025-06-05 08:20:12.370123 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-05 08:20:12.370157 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-05 08:20:12.370179 | debian-bookworm -> localhost | | . | 2025-06-05 08:20:12.370201 | debian-bookworm -> localhost | | o . | 2025-06-05 08:20:12.370221 | debian-bookworm -> localhost | | o o + | 2025-06-05 08:20:12.370240 | debian-bookworm -> localhost | | . + * + + | 2025-06-05 08:20:12.370259 | debian-bookworm -> localhost | | +.E O = . | 2025-06-05 08:20:12.370287 | debian-bookworm -> localhost | | . oo@ @ o | 2025-06-05 08:20:12.370307 | debian-bookworm -> localhost | | oo+./ * | 2025-06-05 08:20:12.370327 | debian-bookworm -> localhost | | . ooBo= | 2025-06-05 08:20:12.370346 | debian-bookworm -> localhost | | ..==o. | 2025-06-05 08:20:12.370366 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-05 08:20:12.370416 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.542418 2025-06-05 08:20:12.377236 | 2025-06-05 08:20:12.377350 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-05 08:20:12.422136 | debian-bookworm | ok 2025-06-05 08:20:12.438662 | debian-bookworm | included: /var/lib/zuul/builds/33a3516223794966865f14679c35dc1d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-05 08:20:12.453941 | 2025-06-05 08:20:12.454066 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-05 08:20:12.480522 | debian-bookworm | skipping: Conditional result was False 2025-06-05 08:20:12.490167 | 2025-06-05 08:20:12.490543 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-05 08:20:13.342442 | debian-bookworm | changed 2025-06-05 08:20:13.348368 | 2025-06-05 08:20:13.348499 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-05 08:20:13.612860 | debian-bookworm | ok 2025-06-05 08:20:13.618532 | 2025-06-05 08:20:13.618667 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-05 08:20:14.353143 | debian-bookworm | changed 2025-06-05 08:20:14.362487 | 2025-06-05 08:20:14.362739 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-05 08:20:15.065241 | debian-bookworm | changed 2025-06-05 08:20:15.081077 | 2025-06-05 08:20:15.081333 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-05 08:20:15.117497 | debian-bookworm | skipping: Conditional result was False 2025-06-05 08:20:15.126989 | 2025-06-05 08:20:15.127149 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-05 08:20:15.583240 | debian-bookworm -> localhost | changed 2025-06-05 08:20:15.604131 | 2025-06-05 08:20:15.604281 | TASK [add-build-sshkey : Add back temp key] 2025-06-05 08:20:15.956337 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/33a3516223794966865f14679c35dc1d/work/33a3516223794966865f14679c35dc1d_id_rsa (zuul-build-sshkey) 2025-06-05 08:20:15.956617 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016145 2025-06-05 08:20:15.965824 | 2025-06-05 08:20:15.965964 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-05 08:20:16.421079 | debian-bookworm | ok 2025-06-05 08:20:16.448660 | 2025-06-05 08:20:16.448858 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-05 08:20:16.475103 | debian-bookworm | skipping: Conditional result was False 2025-06-05 08:20:16.535246 | 2025-06-05 08:20:16.536802 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-05 08:20:17.084120 | debian-bookworm | ok 2025-06-05 08:20:17.104144 | 2025-06-05 08:20:17.104307 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-05 08:20:17.151881 | debian-bookworm | ok 2025-06-05 08:20:17.157366 | 2025-06-05 08:20:17.162824 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-05 08:20:17.486691 | debian-bookworm -> localhost | ok 2025-06-05 08:20:17.502489 | 2025-06-05 08:20:17.502753 | TASK [validate-host : Collect information about the host] 2025-06-05 08:20:18.595171 | debian-bookworm | ok 2025-06-05 08:20:18.605507 | 2025-06-05 08:20:18.605681 | TASK [validate-host : Sanitize hostname] 2025-06-05 08:20:18.724429 | debian-bookworm | ok 2025-06-05 08:20:18.799091 | 2025-06-05 08:20:18.799234 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-05 08:20:19.421943 | debian-bookworm -> localhost | changed 2025-06-05 08:20:19.435225 | 2025-06-05 08:20:19.435430 | TASK [validate-host : Collect information about zuul worker] 2025-06-05 08:20:19.876856 | debian-bookworm | ok 2025-06-05 08:20:19.881942 | 2025-06-05 08:20:19.882132 | TASK [validate-host : Write out all zuul information for each host] 2025-06-05 08:20:20.492308 | debian-bookworm -> localhost | changed 2025-06-05 08:20:20.502271 | 2025-06-05 08:20:20.502394 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-05 08:20:20.794364 | debian-bookworm | ok 2025-06-05 08:20:20.800438 | 2025-06-05 08:20:20.800562 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-05 08:20:21.984203 | debian-bookworm | changed: 2025-06-05 08:20:21.984409 | debian-bookworm | cd+++++++++ src/ 2025-06-05 08:20:21.984444 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-05 08:20:21.984467 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-05 08:20:21.984489 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-05 08:20:21.984509 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008031 2025-06-05 08:20:48.265168 | 2025-06-05 08:20:48.265295 | TASK [upload-logs : Upload logs to log server] 2025-06-05 08:20:48.841079 | localhost | Output suppressed because no_log was given 2025-06-05 08:20:48.842981 | 2025-06-05 08:20:48.843095 | LOOP [upload-logs : Compress console log and json output] 2025-06-05 08:20:48.892128 | localhost | skipping: Conditional result was False 2025-06-05 08:20:48.901384 | localhost | skipping: Conditional result was False 2025-06-05 08:20:48.914029 | 2025-06-05 08:20:48.914192 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-05 08:20:48.977363 | localhost | skipping: Conditional result was False 2025-06-05 08:20:48.977708 | 2025-06-05 08:20:48.984808 | localhost | skipping: Conditional result was False 2025-06-05 08:20:48.992252 | 2025-06-05 08:20:48.992395 | LOOP [upload-logs : Upload console log and json output]