2025-03-31 17:46:10.875079 | Job console starting... 2025-03-31 17:46:10.902872 | Updating repositories 2025-03-31 17:46:10.944101 | Preparing job workspace 2025-03-31 17:46:12.841622 | Running Ansible setup... 2025-03-31 17:46:18.292332 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-31 17:46:18.874037 | 2025-03-31 17:46:18.874145 | PLAY [Base pre] 2025-03-31 17:46:18.900548 | 2025-03-31 17:46:18.900670 | TASK [Setup log path fact] 2025-03-31 17:46:18.939264 | ubuntu-noble | ok 2025-03-31 17:46:18.954857 | 2025-03-31 17:46:18.954961 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-31 17:46:19.013783 | ubuntu-noble | ok 2025-03-31 17:46:19.036355 | 2025-03-31 17:46:19.036468 | TASK [emit-job-header : Print job information] 2025-03-31 17:46:19.136118 | # Job Information 2025-03-31 17:46:19.136289 | Ansible Version: 2.15.3 2025-03-31 17:46:19.136319 | Job: python-black 2025-03-31 17:46:19.136345 | Pipeline: check 2025-03-31 17:46:19.136363 | Executor: 7d211f194f6a 2025-03-31 17:46:19.136379 | Triggered by: https://github.com/osism/testbed/pull/2653 2025-03-31 17:46:19.136405 | Event ID: 04296ce0-0e58-11f0-87d6-34f820ed8bff 2025-03-31 17:46:19.141470 | 2025-03-31 17:46:19.141545 | LOOP [emit-job-header : Print node information] 2025-03-31 17:46:19.310739 | ubuntu-noble | ok: 2025-03-31 17:46:19.310879 | ubuntu-noble | # Node Information 2025-03-31 17:46:19.310907 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-31 17:46:19.310927 | ubuntu-noble | Hostname: ubuntu 2025-03-31 17:46:19.310945 | ubuntu-noble | Username: zuul 2025-03-31 17:46:19.310961 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-31 17:46:19.310980 | ubuntu-noble | Provider: regiocloud-a 2025-03-31 17:46:19.310998 | ubuntu-noble | Label: ubuntu-noble 2025-03-31 17:46:19.311015 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-31 17:46:19.311032 | ubuntu-noble | Interface IP: 81.163.193.47 2025-03-31 17:46:19.348820 | 2025-03-31 17:46:19.348938 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-31 17:46:19.900483 | ubuntu-noble -> localhost | changed 2025-03-31 17:46:19.908491 | 2025-03-31 17:46:19.908602 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-31 17:46:20.835997 | ubuntu-noble -> localhost | changed 2025-03-31 17:46:20.854310 | 2025-03-31 17:46:20.854419 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-31 17:46:21.169235 | ubuntu-noble -> localhost | ok 2025-03-31 17:46:21.175304 | 2025-03-31 17:46:21.175392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-31 17:46:21.203648 | ubuntu-noble | ok 2025-03-31 17:46:21.216924 | ubuntu-noble | included: /var/lib/zuul/builds/1c75b9269dfb473c812c90ec5c4c1716/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-31 17:46:21.222970 | 2025-03-31 17:46:21.223044 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-31 17:46:22.021954 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-31 17:46:22.022150 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c75b9269dfb473c812c90ec5c4c1716/work/1c75b9269dfb473c812c90ec5c4c1716_id_rsa 2025-03-31 17:46:22.022181 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c75b9269dfb473c812c90ec5c4c1716/work/1c75b9269dfb473c812c90ec5c4c1716_id_rsa.pub 2025-03-31 17:46:22.022202 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-31 17:46:22.022221 | ubuntu-noble -> localhost | SHA256:BA+2WguwyESaApTnihmTE4ExHcza9D7eAY9a/IrHGV4 zuul-build-sshkey 2025-03-31 17:46:22.022239 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-31 17:46:22.022256 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-31 17:46:22.022273 | ubuntu-noble -> localhost | |OX+. + | 2025-03-31 17:46:22.022289 | ubuntu-noble -> localhost | |B==+ . = | 2025-03-31 17:46:22.022305 | ubuntu-noble -> localhost | |=B+.. o o | 2025-03-31 17:46:22.022328 | ubuntu-noble -> localhost | |B ..o+ o | 2025-03-31 17:46:22.022345 | ubuntu-noble -> localhost | |.=.o.+. S | 2025-03-31 17:46:22.022360 | ubuntu-noble -> localhost | |o. B E | 2025-03-31 17:46:22.022379 | ubuntu-noble -> localhost | | * B . | 2025-03-31 17:46:22.022396 | ubuntu-noble -> localhost | | ..* o | 2025-03-31 17:46:22.022412 | ubuntu-noble -> localhost | | .... | 2025-03-31 17:46:22.022427 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-31 17:46:22.022471 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.361398 2025-03-31 17:46:22.029355 | 2025-03-31 17:46:22.029443 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-31 17:46:22.050293 | ubuntu-noble | ok 2025-03-31 17:46:22.059046 | ubuntu-noble | included: /var/lib/zuul/builds/1c75b9269dfb473c812c90ec5c4c1716/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-31 17:46:22.066922 | 2025-03-31 17:46:22.067004 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-31 17:46:22.080332 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 17:46:22.089019 | 2025-03-31 17:46:22.089107 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-31 17:46:22.860612 | ubuntu-noble | changed 2025-03-31 17:46:22.866009 | 2025-03-31 17:46:22.866083 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-31 17:46:23.196958 | ubuntu-noble | ok 2025-03-31 17:46:23.204912 | 2025-03-31 17:46:23.205006 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-31 17:46:23.967890 | ubuntu-noble | changed 2025-03-31 17:46:23.975895 | 2025-03-31 17:46:23.975975 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-31 17:46:24.671151 | ubuntu-noble | changed 2025-03-31 17:46:24.680668 | 2025-03-31 17:46:24.680758 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-31 17:46:24.704550 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 17:46:24.710527 | 2025-03-31 17:46:24.710603 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-31 17:46:25.131723 | ubuntu-noble -> localhost | changed 2025-03-31 17:46:25.150983 | 2025-03-31 17:46:25.151075 | TASK [add-build-sshkey : Add back temp key] 2025-03-31 17:46:25.584718 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1c75b9269dfb473c812c90ec5c4c1716/work/1c75b9269dfb473c812c90ec5c4c1716_id_rsa (zuul-build-sshkey) 2025-03-31 17:46:25.584887 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.006764 2025-03-31 17:46:25.590880 | 2025-03-31 17:46:25.590957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-31 17:46:26.016075 | ubuntu-noble | ok 2025-03-31 17:46:26.039668 | 2025-03-31 17:46:26.039760 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-31 17:46:26.093395 | ubuntu-noble | skipping: Conditional result was False 2025-03-31 17:46:26.104149 | 2025-03-31 17:46:26.104241 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-31 17:46:26.646087 | ubuntu-noble | ok 2025-03-31 17:46:26.655674 | 2025-03-31 17:46:26.655767 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-31 17:46:26.683981 | ubuntu-noble | ok 2025-03-31 17:46:26.690001 | 2025-03-31 17:46:26.690080 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-31 17:46:26.907082 | ubuntu-noble -> localhost | ok 2025-03-31 17:46:26.913363 | 2025-03-31 17:46:26.913443 | TASK [validate-host : Collect information about the host] 2025-03-31 17:46:28.155739 | ubuntu-noble | ok 2025-03-31 17:46:28.167114 | 2025-03-31 17:46:28.167201 | TASK [validate-host : Sanitize hostname] 2025-03-31 17:46:28.229706 | ubuntu-noble | ok 2025-03-31 17:46:28.239485 | 2025-03-31 17:46:28.239619 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-31 17:46:28.771359 | ubuntu-noble -> localhost | changed 2025-03-31 17:46:28.776845 | 2025-03-31 17:46:28.776933 | TASK [validate-host : Collect information about zuul worker] 2025-03-31 17:46:29.312926 | ubuntu-noble | ok 2025-03-31 17:46:29.317911 | 2025-03-31 17:46:29.317991 | TASK [validate-host : Write out all zuul information for each host] 2025-03-31 17:46:29.821057 | ubuntu-noble -> localhost | changed 2025-03-31 17:46:29.832813 | 2025-03-31 17:46:29.832905 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-31 17:46:30.187356 | ubuntu-noble | ok 2025-03-31 17:46:30.193087 | 2025-03-31 17:46:30.193164 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-31 17:46:31.201503 | ubuntu-noble | changed: 2025-03-31 17:46:31.201687 | ubuntu-noble | cd+++++++++ src/ 2025-03-31 17:46:31.201723 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-31 17:46:31.201748 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-31 17:46:31.201769 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-31 17:46:31.201789 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.016634 2025-03-31 17:47:10.992940 | 2025-03-31 17:47:10.993019 | TASK [upload-logs : Upload logs to log server] 2025-03-31 17:47:11.891561 | localhost | Output suppressed because no_log was given 2025-03-31 17:47:11.894220 | 2025-03-31 17:47:11.894300 | LOOP [upload-logs : Compress console log and json output] 2025-03-31 17:47:12.022998 | localhost | skipping: Conditional result was False 2025-03-31 17:47:12.045985 | localhost | skipping: Conditional result was False 2025-03-31 17:47:12.063375 | 2025-03-31 17:47:12.063466 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-31 17:47:12.174376 | localhost | skipping: Conditional result was False 2025-03-31 17:47:12.174607 | 2025-03-31 17:47:12.188699 | localhost | skipping: Conditional result was False 2025-03-31 17:47:12.196838 | 2025-03-31 17:47:12.196941 | LOOP [upload-logs : Upload console log and json output]