2025-04-09 15:44:59.335534 | Job console starting... 2025-04-09 15:44:59.367673 | Updating repositories 2025-04-09 15:44:59.409626 | Preparing job workspace 2025-04-09 15:45:01.239890 | Running Ansible setup... 2025-04-09 15:45:06.699144 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-09 15:45:07.502379 | 2025-04-09 15:45:07.502544 | PLAY [Base pre] 2025-04-09 15:45:07.540175 | 2025-04-09 15:45:07.540353 | TASK [Setup log path fact] 2025-04-09 15:45:07.563605 | ubuntu-noble | ok 2025-04-09 15:45:07.587023 | 2025-04-09 15:45:07.587166 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-09 15:45:07.638506 | ubuntu-noble | ok 2025-04-09 15:45:07.655330 | 2025-04-09 15:45:07.655461 | TASK [emit-job-header : Print job information] 2025-04-09 15:45:07.708930 | # Job Information 2025-04-09 15:45:07.709198 | Ansible Version: 2.15.3 2025-04-09 15:45:07.709238 | Job: python-black 2025-04-09 15:45:07.709284 | Pipeline: check 2025-04-09 15:45:07.709304 | Executor: 7d211f194f6a 2025-04-09 15:45:07.709324 | Triggered by: https://github.com/osism/testbed/pull/2654 2025-04-09 15:45:07.709342 | Event ID: 933a75c0-1559-11f0-80b2-8590332c80ed 2025-04-09 15:45:07.719213 | 2025-04-09 15:45:07.719350 | LOOP [emit-job-header : Print node information] 2025-04-09 15:45:07.872466 | ubuntu-noble | ok: 2025-04-09 15:45:07.872808 | ubuntu-noble | # Node Information 2025-04-09 15:45:07.872852 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-09 15:45:07.872878 | ubuntu-noble | Hostname: ubuntu 2025-04-09 15:45:07.872901 | ubuntu-noble | Username: zuul 2025-04-09 15:45:07.872921 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-09 15:45:07.872945 | ubuntu-noble | Provider: regiocloud-a 2025-04-09 15:45:07.872965 | ubuntu-noble | Label: ubuntu-noble 2025-04-09 15:45:07.872986 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-09 15:45:07.873006 | ubuntu-noble | Interface IP: 81.163.193.95 2025-04-09 15:45:07.897001 | 2025-04-09 15:45:07.897144 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-09 15:45:08.390339 | ubuntu-noble -> localhost | changed 2025-04-09 15:45:08.399450 | 2025-04-09 15:45:08.399557 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-09 15:45:09.433999 | ubuntu-noble -> localhost | changed 2025-04-09 15:45:09.450886 | 2025-04-09 15:45:09.450993 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-09 15:45:09.701172 | ubuntu-noble -> localhost | ok 2025-04-09 15:45:09.708468 | 2025-04-09 15:45:09.708575 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-09 15:45:09.738278 | ubuntu-noble | ok 2025-04-09 15:45:09.754096 | ubuntu-noble | included: /var/lib/zuul/builds/f3a874c1e83e4805a22e0fa98c3e5ce2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-09 15:45:09.761738 | 2025-04-09 15:45:09.761832 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-09 15:45:10.321566 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-09 15:45:10.321773 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f3a874c1e83e4805a22e0fa98c3e5ce2/work/f3a874c1e83e4805a22e0fa98c3e5ce2_id_rsa 2025-04-09 15:45:10.321808 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f3a874c1e83e4805a22e0fa98c3e5ce2/work/f3a874c1e83e4805a22e0fa98c3e5ce2_id_rsa.pub 2025-04-09 15:45:10.321833 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-09 15:45:10.321857 | ubuntu-noble -> localhost | SHA256:8Raao9H9Daa+ABbJKiLsVU8B0qo9bj4U6Ue2PPNvCxU zuul-build-sshkey 2025-04-09 15:45:10.321879 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-09 15:45:10.321899 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-09 15:45:10.321919 | ubuntu-noble -> localhost | | ..... | 2025-04-09 15:45:10.321937 | ubuntu-noble -> localhost | | .o .. | 2025-04-09 15:45:10.321956 | ubuntu-noble -> localhost | | o.+..E. | 2025-04-09 15:45:10.321985 | ubuntu-noble -> localhost | |. +.+oo *.. | 2025-04-09 15:45:10.322005 | ubuntu-noble -> localhost | |o.=.* =.S.+ o | 2025-04-09 15:45:10.322023 | ubuntu-noble -> localhost | |oo.* B +.o + o | 2025-04-09 15:45:10.322049 | ubuntu-noble -> localhost | | .o o =.. . . . | 2025-04-09 15:45:10.322070 | ubuntu-noble -> localhost | | + ..+ | 2025-04-09 15:45:10.322091 | ubuntu-noble -> localhost | | o.. oo+. | 2025-04-09 15:45:10.322110 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-09 15:45:10.322158 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.185818 2025-04-09 15:45:10.348612 | 2025-04-09 15:45:10.348703 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-09 15:45:10.386855 | ubuntu-noble | ok 2025-04-09 15:45:10.406417 | ubuntu-noble | included: /var/lib/zuul/builds/f3a874c1e83e4805a22e0fa98c3e5ce2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-09 15:45:10.415845 | 2025-04-09 15:45:10.415933 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-09 15:45:10.439909 | ubuntu-noble | skipping: Conditional result was False 2025-04-09 15:45:10.447006 | 2025-04-09 15:45:10.447100 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-09 15:45:11.175196 | ubuntu-noble | changed 2025-04-09 15:45:11.185479 | 2025-04-09 15:45:11.185586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-09 15:45:11.490933 | ubuntu-noble | ok 2025-04-09 15:45:11.501438 | 2025-04-09 15:45:11.501549 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-09 15:45:12.235990 | ubuntu-noble | changed 2025-04-09 15:45:12.245135 | 2025-04-09 15:45:12.246163 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-09 15:45:13.015527 | ubuntu-noble | changed 2025-04-09 15:45:13.024827 | 2025-04-09 15:45:13.024929 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-09 15:45:13.048931 | ubuntu-noble | skipping: Conditional result was False 2025-04-09 15:45:13.056495 | 2025-04-09 15:45:13.056584 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-09 15:45:13.470996 | ubuntu-noble -> localhost | changed 2025-04-09 15:45:13.484565 | 2025-04-09 15:45:13.484669 | TASK [add-build-sshkey : Add back temp key] 2025-04-09 15:45:13.783100 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f3a874c1e83e4805a22e0fa98c3e5ce2/work/f3a874c1e83e4805a22e0fa98c3e5ce2_id_rsa (zuul-build-sshkey) 2025-04-09 15:45:13.783320 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009577 2025-04-09 15:45:13.792099 | 2025-04-09 15:45:13.792191 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-09 15:45:14.215991 | ubuntu-noble | ok 2025-04-09 15:45:14.222959 | 2025-04-09 15:45:14.223043 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-09 15:45:14.246445 | ubuntu-noble | skipping: Conditional result was False 2025-04-09 15:45:14.259535 | 2025-04-09 15:45:14.259624 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-09 15:45:14.702043 | ubuntu-noble | ok 2025-04-09 15:45:14.754478 | 2025-04-09 15:45:14.754578 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-09 15:45:14.790812 | ubuntu-noble | ok 2025-04-09 15:45:14.797525 | 2025-04-09 15:45:14.797626 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-09 15:45:15.339644 | ubuntu-noble -> localhost | ok 2025-04-09 15:45:15.349327 | 2025-04-09 15:45:15.349500 | TASK [validate-host : Collect information about the host] 2025-04-09 15:45:16.742074 | ubuntu-noble | ok 2025-04-09 15:45:16.755976 | 2025-04-09 15:45:16.756084 | TASK [validate-host : Sanitize hostname] 2025-04-09 15:45:16.848950 | ubuntu-noble | ok 2025-04-09 15:45:16.857769 | 2025-04-09 15:45:16.857885 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-09 15:45:17.472935 | ubuntu-noble -> localhost | changed 2025-04-09 15:45:17.480182 | 2025-04-09 15:45:17.480328 | TASK [validate-host : Collect information about zuul worker] 2025-04-09 15:45:17.953530 | ubuntu-noble | ok 2025-04-09 15:45:17.959618 | 2025-04-09 15:45:17.959731 | TASK [validate-host : Write out all zuul information for each host] 2025-04-09 15:45:18.534620 | ubuntu-noble -> localhost | changed 2025-04-09 15:45:18.547506 | 2025-04-09 15:45:18.547635 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-09 15:45:18.871924 | ubuntu-noble | ok 2025-04-09 15:45:18.882167 | 2025-04-09 15:45:18.882320 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-09 15:45:20.091302 | ubuntu-noble | changed: 2025-04-09 15:45:20.091511 | ubuntu-noble | cd+++++++++ src/ 2025-04-09 15:45:20.091546 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-09 15:45:20.091570 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-09 15:45:20.091591 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-09 15:45:20.091612 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007325 2025-04-09 15:45:54.420377 | 2025-04-09 15:45:54.420587 | TASK [upload-logs : Upload logs to log server] 2025-04-09 15:45:54.994045 | localhost | Output suppressed because no_log was given 2025-04-09 15:45:54.997251 | 2025-04-09 15:45:54.997405 | LOOP [upload-logs : Compress console log and json output] 2025-04-09 15:45:55.074401 | localhost | skipping: Conditional result was False 2025-04-09 15:45:55.085113 | localhost | skipping: Conditional result was False 2025-04-09 15:45:55.097477 | 2025-04-09 15:45:55.097613 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-09 15:45:55.177585 | localhost | skipping: Conditional result was False 2025-04-09 15:45:55.177900 | 2025-04-09 15:45:55.195965 | localhost | skipping: Conditional result was False 2025-04-09 15:45:55.208206 | 2025-04-09 15:45:55.208350 | LOOP [upload-logs : Upload console log and json output]