2025-03-26 13:03:30.842266 | Job console starting... 2025-03-26 13:03:30.868041 | Updating repositories 2025-03-26 13:03:30.896975 | Preparing job workspace 2025-03-26 13:03:32.583626 | Running Ansible setup... 2025-03-26 13:03:38.008937 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-26 13:03:38.840152 | 2025-03-26 13:03:38.840306 | PLAY [Base pre] 2025-03-26 13:03:38.869257 | 2025-03-26 13:03:38.869394 | TASK [Setup log path fact] 2025-03-26 13:03:38.891132 | ubuntu-noble | ok 2025-03-26 13:03:38.910521 | 2025-03-26 13:03:38.910676 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-26 13:03:38.952870 | ubuntu-noble | ok 2025-03-26 13:03:38.968133 | 2025-03-26 13:03:38.968251 | TASK [emit-job-header : Print job information] 2025-03-26 13:03:39.019993 | # Job Information 2025-03-26 13:03:39.020222 | Ansible Version: 2.15.3 2025-03-26 13:03:39.020270 | Job: python-black 2025-03-26 13:03:39.020314 | Pipeline: check 2025-03-26 13:03:39.020348 | Executor: 7d211f194f6a 2025-03-26 13:03:39.020379 | Triggered by: https://github.com/osism/testbed/pull/2647 2025-03-26 13:03:39.020466 | Event ID: b24263a0-0a42-11f0-92a3-050b34f82456 2025-03-26 13:03:39.027866 | 2025-03-26 13:03:39.027983 | LOOP [emit-job-header : Print node information] 2025-03-26 13:03:39.182810 | ubuntu-noble | ok: 2025-03-26 13:03:39.182999 | ubuntu-noble | # Node Information 2025-03-26 13:03:39.183031 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-26 13:03:39.183054 | ubuntu-noble | Hostname: ubuntu 2025-03-26 13:03:39.183074 | ubuntu-noble | Username: zuul 2025-03-26 13:03:39.183094 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-26 13:03:39.183118 | ubuntu-noble | Provider: regiocloud-a 2025-03-26 13:03:39.183138 | ubuntu-noble | Label: ubuntu-noble 2025-03-26 13:03:39.183158 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-26 13:03:39.183178 | ubuntu-noble | Interface IP: 81.163.193.143 2025-03-26 13:03:39.205198 | 2025-03-26 13:03:39.205335 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-26 13:03:39.808282 | ubuntu-noble -> localhost | changed 2025-03-26 13:03:39.816774 | 2025-03-26 13:03:39.816892 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-26 13:03:40.916518 | ubuntu-noble -> localhost | changed 2025-03-26 13:03:40.929010 | 2025-03-26 13:03:40.929094 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-26 13:03:41.205777 | ubuntu-noble -> localhost | ok 2025-03-26 13:03:41.212421 | 2025-03-26 13:03:41.212515 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-26 13:03:41.233032 | ubuntu-noble | ok 2025-03-26 13:03:41.245520 | ubuntu-noble | included: /var/lib/zuul/builds/b9e92e5b154146219266445f48fc6c42/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-26 13:03:41.251718 | 2025-03-26 13:03:41.251789 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-26 13:03:42.025019 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-26 13:03:42.025176 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b9e92e5b154146219266445f48fc6c42/work/b9e92e5b154146219266445f48fc6c42_id_rsa 2025-03-26 13:03:42.025207 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b9e92e5b154146219266445f48fc6c42/work/b9e92e5b154146219266445f48fc6c42_id_rsa.pub 2025-03-26 13:03:42.025228 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-26 13:03:42.025249 | ubuntu-noble -> localhost | SHA256:ZKJ3ZI9Vf4P3t2TDP5qsYMKkdt3PprwXu5Nff0BHY3g zuul-build-sshkey 2025-03-26 13:03:42.025269 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-26 13:03:42.025288 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-26 13:03:42.025306 | ubuntu-noble -> localhost | | . . | 2025-03-26 13:03:42.025324 | ubuntu-noble -> localhost | | . o.E.| 2025-03-26 13:03:42.025341 | ubuntu-noble -> localhost | | . = . .++o| 2025-03-26 13:03:42.025366 | ubuntu-noble -> localhost | | . * + +.+| 2025-03-26 13:03:42.025385 | ubuntu-noble -> localhost | | . ..S . . *o| 2025-03-26 13:03:42.025402 | ubuntu-noble -> localhost | | .+.. . .+ =| 2025-03-26 13:03:42.025425 | ubuntu-noble -> localhost | | o + + . ++o| 2025-03-26 13:03:42.025443 | ubuntu-noble -> localhost | | . . o o +*o =| 2025-03-26 13:03:42.025461 | ubuntu-noble -> localhost | | =*B+.o| 2025-03-26 13:03:42.025479 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-26 13:03:42.025522 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.412676 2025-03-26 13:03:42.032994 | 2025-03-26 13:03:42.033073 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-26 13:03:42.074805 | ubuntu-noble | ok 2025-03-26 13:03:42.087319 | ubuntu-noble | included: /var/lib/zuul/builds/b9e92e5b154146219266445f48fc6c42/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-26 13:03:42.095310 | 2025-03-26 13:03:42.095377 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-26 13:03:42.128506 | ubuntu-noble | skipping: Conditional result was False 2025-03-26 13:03:42.137207 | 2025-03-26 13:03:42.137303 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-26 13:03:42.897813 | ubuntu-noble | changed 2025-03-26 13:03:42.906563 | 2025-03-26 13:03:42.906697 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-26 13:03:43.241974 | ubuntu-noble | ok 2025-03-26 13:03:43.251852 | 2025-03-26 13:03:43.251982 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-26 13:03:44.112497 | ubuntu-noble | changed 2025-03-26 13:03:44.122759 | 2025-03-26 13:03:44.122872 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-26 13:03:44.859424 | ubuntu-noble | changed 2025-03-26 13:03:44.877144 | 2025-03-26 13:03:44.877277 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-26 13:03:44.899572 | ubuntu-noble | skipping: Conditional result was False 2025-03-26 13:03:44.911104 | 2025-03-26 13:03:44.911278 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-26 13:03:45.240466 | ubuntu-noble -> localhost | changed 2025-03-26 13:03:45.254056 | 2025-03-26 13:03:45.254164 | TASK [add-build-sshkey : Add back temp key] 2025-03-26 13:03:45.586408 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b9e92e5b154146219266445f48fc6c42/work/b9e92e5b154146219266445f48fc6c42_id_rsa (zuul-build-sshkey) 2025-03-26 13:03:45.586844 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014270 2025-03-26 13:03:45.600678 | 2025-03-26 13:03:45.600811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-26 13:03:46.078359 | ubuntu-noble | ok 2025-03-26 13:03:46.090423 | 2025-03-26 13:03:46.090524 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-26 13:03:46.124763 | ubuntu-noble | skipping: Conditional result was False 2025-03-26 13:03:46.144825 | 2025-03-26 13:03:46.144927 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-26 13:03:46.687922 | ubuntu-noble | ok 2025-03-26 13:03:46.700597 | 2025-03-26 13:03:46.700698 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-26 13:03:46.740659 | ubuntu-noble | ok 2025-03-26 13:03:46.746883 | 2025-03-26 13:03:46.746988 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-26 13:03:47.042674 | ubuntu-noble -> localhost | ok 2025-03-26 13:03:47.053480 | 2025-03-26 13:03:47.053573 | TASK [validate-host : Collect information about the host] 2025-03-26 13:03:48.213577 | ubuntu-noble | ok 2025-03-26 13:03:48.225519 | 2025-03-26 13:03:48.225607 | TASK [validate-host : Sanitize hostname] 2025-03-26 13:03:48.284644 | ubuntu-noble | ok 2025-03-26 13:03:48.290482 | 2025-03-26 13:03:48.290581 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-26 13:03:48.821563 | ubuntu-noble -> localhost | changed 2025-03-26 13:03:48.828702 | 2025-03-26 13:03:48.828799 | TASK [validate-host : Collect information about zuul worker] 2025-03-26 13:03:49.375679 | ubuntu-noble | ok 2025-03-26 13:03:49.394254 | 2025-03-26 13:03:49.394343 | TASK [validate-host : Write out all zuul information for each host] 2025-03-26 13:03:49.894742 | ubuntu-noble -> localhost | changed 2025-03-26 13:03:49.908255 | 2025-03-26 13:03:49.908354 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-26 13:03:50.257529 | ubuntu-noble | ok 2025-03-26 13:03:50.268715 | 2025-03-26 13:03:50.268846 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-26 13:03:51.467912 | ubuntu-noble | changed: 2025-03-26 13:03:51.468177 | ubuntu-noble | cd+++++++++ src/ 2025-03-26 13:03:51.468219 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-26 13:03:51.468248 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-26 13:03:51.468272 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-26 13:03:51.468293 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007751 2025-03-26 13:04:28.474375 | 2025-03-26 13:04:28.474470 | TASK [upload-logs : Upload logs to log server] 2025-03-26 13:04:29.213403 | localhost | Output suppressed because no_log was given 2025-03-26 13:04:29.215833 | 2025-03-26 13:04:29.215913 | LOOP [upload-logs : Compress console log and json output] 2025-03-26 13:04:29.282818 | localhost | skipping: Conditional result was False 2025-03-26 13:04:29.283954 | localhost | skipping: Conditional result was False 2025-03-26 13:04:29.295118 | 2025-03-26 13:04:29.295195 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-26 13:04:29.358164 | localhost | skipping: Conditional result was False 2025-03-26 13:04:29.358383 | 2025-03-26 13:04:29.366059 | localhost | skipping: Conditional result was False 2025-03-26 13:04:29.372059 | 2025-03-26 13:04:29.372134 | LOOP [upload-logs : Upload console log and json output]