2025-12-09 08:33:56.421198 | Job console starting 2025-12-09 08:33:56.441953 | Updating git repos 2025-12-09 08:33:56.489893 | Cloning repos into workspace 2025-12-09 08:33:56.587238 | Restoring repo states 2025-12-09 08:33:56.596379 | Merging changes 2025-12-09 08:33:57.258677 | Checking out repos 2025-12-09 08:33:57.311981 | Preparing playbooks 2025-12-09 08:33:58.128819 | Running Ansible setup 2025-12-09 08:34:02.640449 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-09 08:34:03.800380 | 2025-12-09 08:34:03.800655 | PLAY [Base pre] 2025-12-09 08:34:03.818132 | 2025-12-09 08:34:03.818293 | TASK [Setup log path fact] 2025-12-09 08:34:03.853114 | debian-bookworm | ok 2025-12-09 08:34:03.870988 | 2025-12-09 08:34:03.871225 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-09 08:34:03.929277 | debian-bookworm | ok 2025-12-09 08:34:03.943914 | 2025-12-09 08:34:03.944060 | TASK [emit-job-header : Print job information] 2025-12-09 08:34:03.983382 | # Job Information 2025-12-09 08:34:03.983604 | Ansible Version: 2.16.14 2025-12-09 08:34:03.983646 | Job: python-black 2025-12-09 08:34:03.983679 | Pipeline: check 2025-12-09 08:34:03.983702 | Executor: 521e9411259a 2025-12-09 08:34:03.983723 | Triggered by: https://github.com/osism/testbed/pull/2801 2025-12-09 08:34:03.983745 | Event ID: c7484780-d4d9-11f0-85c5-daf287984dd4 2025-12-09 08:34:03.988819 | 2025-12-09 08:34:03.988944 | LOOP [emit-job-header : Print node information] 2025-12-09 08:34:04.103373 | debian-bookworm | ok: 2025-12-09 08:34:04.103661 | debian-bookworm | # Node Information 2025-12-09 08:34:04.103698 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-09 08:34:04.103722 | debian-bookworm | Hostname: debian 2025-12-09 08:34:04.103744 | debian-bookworm | Username: zuul 2025-12-09 08:34:04.103764 | debian-bookworm | Distro: Debian 12.12 2025-12-09 08:34:04.103787 | debian-bookworm | Provider: regiocloud-a 2025-12-09 08:34:04.103808 | debian-bookworm | Region: 2025-12-09 08:34:04.103829 | debian-bookworm | Label: debian-bookworm 2025-12-09 08:34:04.103849 | debian-bookworm | Product Name: OpenStack Nova 2025-12-09 08:34:04.103868 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec0:15a4 2025-12-09 08:34:04.125334 | 2025-12-09 08:34:04.125483 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-09 08:34:04.830315 | debian-bookworm -> localhost | changed 2025-12-09 08:34:04.842332 | 2025-12-09 08:34:04.842588 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-09 08:34:06.435470 | debian-bookworm -> localhost | changed 2025-12-09 08:34:06.459911 | 2025-12-09 08:34:06.460066 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-09 08:34:06.879808 | debian-bookworm -> localhost | ok 2025-12-09 08:34:06.886194 | 2025-12-09 08:34:06.886328 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-09 08:34:06.915946 | debian-bookworm | ok 2025-12-09 08:34:06.956531 | debian-bookworm | included: /var/lib/zuul/builds/9382e8a5038042df8b4122a7f86db73a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-09 08:34:06.980604 | 2025-12-09 08:34:06.980740 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-09 08:34:08.871529 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-09 08:34:08.871879 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9382e8a5038042df8b4122a7f86db73a/work/9382e8a5038042df8b4122a7f86db73a_id_rsa 2025-12-09 08:34:08.871942 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9382e8a5038042df8b4122a7f86db73a/work/9382e8a5038042df8b4122a7f86db73a_id_rsa.pub 2025-12-09 08:34:08.871985 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-09 08:34:08.872024 | debian-bookworm -> localhost | SHA256:818iEnrpgtJDatbm68FnmvTsYrtgGvFAC5/bAe/XsHE zuul-build-sshkey 2025-12-09 08:34:08.872059 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-09 08:34:08.872110 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-09 08:34:08.872145 | debian-bookworm -> localhost | | | 2025-12-09 08:34:08.872179 | debian-bookworm -> localhost | | | 2025-12-09 08:34:08.872211 | debian-bookworm -> localhost | |... | 2025-12-09 08:34:08.872243 | debian-bookworm -> localhost | |o..+ | 2025-12-09 08:34:08.872275 | debian-bookworm -> localhost | |o.o o o E | 2025-12-09 08:34:08.872321 | debian-bookworm -> localhost | | + =.. B = | 2025-12-09 08:34:08.872360 | debian-bookworm -> localhost | |. ==*.* = o . . | 2025-12-09 08:34:08.872394 | debian-bookworm -> localhost | | +=oOX.o . o o | 2025-12-09 08:34:08.872429 | debian-bookworm -> localhost | |.o *OB+.. . | 2025-12-09 08:34:08.872462 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-09 08:34:08.872547 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.251237 2025-12-09 08:34:08.882947 | 2025-12-09 08:34:08.883098 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-09 08:34:08.915710 | debian-bookworm | ok 2025-12-09 08:34:08.927601 | debian-bookworm | included: /var/lib/zuul/builds/9382e8a5038042df8b4122a7f86db73a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-09 08:34:08.938317 | 2025-12-09 08:34:08.938434 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-09 08:34:08.965709 | debian-bookworm | skipping: Conditional result was False 2025-12-09 08:34:08.982818 | 2025-12-09 08:34:08.983048 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-09 08:34:09.673585 | debian-bookworm | changed 2025-12-09 08:34:09.680829 | 2025-12-09 08:34:09.680973 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-09 08:34:09.966473 | debian-bookworm | ok 2025-12-09 08:34:09.978295 | 2025-12-09 08:34:09.978450 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-09 08:34:10.666118 | debian-bookworm | changed 2025-12-09 08:34:10.675999 | 2025-12-09 08:34:10.676258 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-09 08:34:11.331255 | debian-bookworm | changed 2025-12-09 08:34:11.338256 | 2025-12-09 08:34:11.338386 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-09 08:34:11.363398 | debian-bookworm | skipping: Conditional result was False 2025-12-09 08:34:11.379484 | 2025-12-09 08:34:11.379670 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-09 08:34:11.929705 | debian-bookworm -> localhost | changed 2025-12-09 08:34:11.943100 | 2025-12-09 08:34:11.943249 | TASK [add-build-sshkey : Add back temp key] 2025-12-09 08:34:12.273402 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9382e8a5038042df8b4122a7f86db73a/work/9382e8a5038042df8b4122a7f86db73a_id_rsa (zuul-build-sshkey) 2025-12-09 08:34:12.273707 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011609 2025-12-09 08:34:12.283052 | 2025-12-09 08:34:12.283182 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-09 08:34:12.734293 | debian-bookworm | ok 2025-12-09 08:34:12.745994 | 2025-12-09 08:34:12.746124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-09 08:34:12.771803 | debian-bookworm | skipping: Conditional result was False 2025-12-09 08:34:12.794541 | 2025-12-09 08:34:12.794794 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-09 08:34:13.280576 | debian-bookworm | ok 2025-12-09 08:34:13.292102 | 2025-12-09 08:34:13.292242 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-09 08:34:13.329295 | debian-bookworm | ok 2025-12-09 08:34:13.336128 | 2025-12-09 08:34:13.336257 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-09 08:34:13.668478 | debian-bookworm -> localhost | ok 2025-12-09 08:34:13.675342 | 2025-12-09 08:34:13.675456 | TASK [validate-host : Collect information about the host] 2025-12-09 08:34:14.825391 | debian-bookworm | ok 2025-12-09 08:34:14.838449 | 2025-12-09 08:34:14.838633 | TASK [validate-host : Sanitize hostname] 2025-12-09 08:34:14.974877 | debian-bookworm | ok 2025-12-09 08:34:15.030204 | 2025-12-09 08:34:15.030343 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-09 08:34:15.691948 | debian-bookworm -> localhost | changed 2025-12-09 08:34:15.698270 | 2025-12-09 08:34:15.698398 | TASK [validate-host : Collect information about zuul worker] 2025-12-09 08:34:16.130496 | debian-bookworm | ok 2025-12-09 08:34:16.140972 | 2025-12-09 08:34:16.141155 | TASK [validate-host : Write out all zuul information for each host] 2025-12-09 08:34:16.721519 | debian-bookworm -> localhost | changed 2025-12-09 08:34:16.732131 | 2025-12-09 08:34:16.732259 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-09 08:34:16.994326 | debian-bookworm | ok 2025-12-09 08:34:17.004469 | 2025-12-09 08:34:17.004632 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-09 08:34:18.108858 | debian-bookworm | changed: 2025-12-09 08:34:18.109073 | debian-bookworm | cd+++++++++ src/ 2025-12-09 08:34:18.109109 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-09 08:34:18.109133 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-09 08:34:18.109155 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-09 08:34:18.109175 | debian-bookworm | localhost | ok: Runtime: 0:00:00.015870 2025-12-09 08:34:43.707494 | 2025-12-09 08:34:43.707654 | TASK [upload-logs : Upload logs to log server] 2025-12-09 08:34:44.407723 | localhost | Output suppressed because no_log was given 2025-12-09 08:34:44.410056 | 2025-12-09 08:34:44.410206 | LOOP [upload-logs : Compress console log and json output] 2025-12-09 08:34:44.523168 | localhost | skipping: Conditional result was False 2025-12-09 08:34:44.531235 | localhost | skipping: Conditional result was False 2025-12-09 08:34:44.540868 | 2025-12-09 08:34:44.541007 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-09 08:34:44.602824 | localhost | skipping: Conditional result was False 2025-12-09 08:34:44.603204 | 2025-12-09 08:34:44.613128 | localhost | skipping: Conditional result was False 2025-12-09 08:34:44.624515 | 2025-12-09 08:34:44.624724 | LOOP [upload-logs : Upload console log and json output]