2025-05-13 18:44:07.919757 | Job console starting 2025-05-13 18:44:07.934611 | Updating git repos 2025-05-13 18:44:07.963512 | Cloning repos into workspace 2025-05-13 18:44:08.022196 | Restoring repo states 2025-05-13 18:44:08.026468 | Merging changes 2025-05-13 18:44:08.603451 | Checking out repos 2025-05-13 18:44:08.682696 | Preparing playbooks 2025-05-13 18:44:09.505271 | Running Ansible setup 2025-05-13 18:44:14.181454 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-13 18:44:15.032971 | 2025-05-13 18:44:15.033150 | PLAY [Base pre] 2025-05-13 18:44:15.049550 | 2025-05-13 18:44:15.049699 | TASK [Setup log path fact] 2025-05-13 18:44:15.069777 | ubuntu-noble | ok 2025-05-13 18:44:15.087028 | 2025-05-13 18:44:15.087192 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-13 18:44:15.116771 | ubuntu-noble | ok 2025-05-13 18:44:15.126585 | 2025-05-13 18:44:15.126700 | TASK [emit-job-header : Print job information] 2025-05-13 18:44:15.179518 | # Job Information 2025-05-13 18:44:15.179726 | Ansible Version: 2.16.14 2025-05-13 18:44:15.179764 | Job: python-black 2025-05-13 18:44:15.179794 | Pipeline: check 2025-05-13 18:44:15.179816 | Executor: 521e9411259a 2025-05-13 18:44:15.179835 | Triggered by: https://github.com/osism/testbed/pull/2660 2025-05-13 18:44:15.179857 | Event ID: 3c0a40f0-302a-11f0-9f00-b946316c18a2 2025-05-13 18:44:15.184888 | 2025-05-13 18:44:15.185016 | LOOP [emit-job-header : Print node information] 2025-05-13 18:44:15.296565 | ubuntu-noble | ok: 2025-05-13 18:44:15.296774 | ubuntu-noble | # Node Information 2025-05-13 18:44:15.296808 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-05-13 18:44:15.296833 | ubuntu-noble | Hostname: ubuntu 2025-05-13 18:44:15.296855 | ubuntu-noble | Username: zuul 2025-05-13 18:44:15.296875 | ubuntu-noble | Distro: Ubuntu 24.04 2025-05-13 18:44:15.296899 | ubuntu-noble | Provider: regiocloud-a 2025-05-13 18:44:15.296919 | ubuntu-noble | Region: 2025-05-13 18:44:15.296940 | ubuntu-noble | Label: ubuntu-noble 2025-05-13 18:44:15.296960 | ubuntu-noble | Product Name: OpenStack Nova 2025-05-13 18:44:15.296979 | ubuntu-noble | Interface IP: 81.163.193.248 2025-05-13 18:44:15.311123 | 2025-05-13 18:44:15.311278 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-13 18:44:15.913033 | ubuntu-noble -> localhost | changed 2025-05-13 18:44:15.920693 | 2025-05-13 18:44:15.920830 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-13 18:44:17.021482 | ubuntu-noble -> localhost | changed 2025-05-13 18:44:17.033429 | 2025-05-13 18:44:17.033583 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-13 18:44:17.354958 | ubuntu-noble -> localhost | ok 2025-05-13 18:44:17.361504 | 2025-05-13 18:44:17.361632 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-13 18:44:17.390162 | ubuntu-noble | ok 2025-05-13 18:44:17.406156 | ubuntu-noble | included: /var/lib/zuul/builds/7fb73c916ac04d91bb63d37547815c9c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-13 18:44:17.414468 | 2025-05-13 18:44:17.414601 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-13 18:44:18.596381 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-05-13 18:44:18.596651 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/7fb73c916ac04d91bb63d37547815c9c/work/7fb73c916ac04d91bb63d37547815c9c_id_rsa 2025-05-13 18:44:18.596700 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/7fb73c916ac04d91bb63d37547815c9c/work/7fb73c916ac04d91bb63d37547815c9c_id_rsa.pub 2025-05-13 18:44:18.596734 | ubuntu-noble -> localhost | The key fingerprint is: 2025-05-13 18:44:18.596764 | ubuntu-noble -> localhost | SHA256:l9Y1S2tkS4M9X+3iu3HPpNweF5kS9021QS5IXqSzBM8 zuul-build-sshkey 2025-05-13 18:44:18.596803 | ubuntu-noble -> localhost | The key's randomart image is: 2025-05-13 18:44:18.596831 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-05-13 18:44:18.596871 | ubuntu-noble -> localhost | | . ..o.o.| 2025-05-13 18:44:18.596900 | ubuntu-noble -> localhost | | * +o. =| 2025-05-13 18:44:18.596926 | ubuntu-noble -> localhost | | E.o@++| 2025-05-13 18:44:18.596951 | ubuntu-noble -> localhost | | .oo*+@*| 2025-05-13 18:44:18.596976 | ubuntu-noble -> localhost | | S +...*+=| 2025-05-13 18:44:18.597011 | ubuntu-noble -> localhost | | o o...| 2025-05-13 18:44:18.597038 | ubuntu-noble -> localhost | | o.+| 2025-05-13 18:44:18.597064 | ubuntu-noble -> localhost | | . O+| 2025-05-13 18:44:18.597090 | ubuntu-noble -> localhost | | =o=| 2025-05-13 18:44:18.597116 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-05-13 18:44:18.597182 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.661164 2025-05-13 18:44:18.604599 | 2025-05-13 18:44:18.604728 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-13 18:44:18.633257 | ubuntu-noble | ok 2025-05-13 18:44:18.642671 | ubuntu-noble | included: /var/lib/zuul/builds/7fb73c916ac04d91bb63d37547815c9c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-13 18:44:18.650905 | 2025-05-13 18:44:18.651008 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-13 18:44:18.674506 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:44:18.680257 | 2025-05-13 18:44:18.680394 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-13 18:44:19.374824 | ubuntu-noble | changed 2025-05-13 18:44:19.381175 | 2025-05-13 18:44:19.381296 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-13 18:44:19.699693 | ubuntu-noble | ok 2025-05-13 18:44:19.709824 | 2025-05-13 18:44:19.710004 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-13 18:44:20.482427 | ubuntu-noble | changed 2025-05-13 18:44:20.491834 | 2025-05-13 18:44:20.491987 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-13 18:44:21.199396 | ubuntu-noble | changed 2025-05-13 18:44:21.208521 | 2025-05-13 18:44:21.208656 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-13 18:44:21.244983 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:44:21.253065 | 2025-05-13 18:44:21.253196 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-13 18:44:21.724681 | ubuntu-noble -> localhost | changed 2025-05-13 18:44:21.744519 | 2025-05-13 18:44:21.744686 | TASK [add-build-sshkey : Add back temp key] 2025-05-13 18:44:22.087795 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/7fb73c916ac04d91bb63d37547815c9c/work/7fb73c916ac04d91bb63d37547815c9c_id_rsa (zuul-build-sshkey) 2025-05-13 18:44:22.088062 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014665 2025-05-13 18:44:22.094489 | 2025-05-13 18:44:22.094612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-13 18:44:22.553911 | ubuntu-noble | ok 2025-05-13 18:44:22.559402 | 2025-05-13 18:44:22.559529 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-13 18:44:22.583681 | ubuntu-noble | skipping: Conditional result was False 2025-05-13 18:44:22.596445 | 2025-05-13 18:44:22.596578 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-13 18:44:23.083972 | ubuntu-noble | ok 2025-05-13 18:44:23.101636 | 2025-05-13 18:44:23.101827 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-13 18:44:23.142782 | ubuntu-noble | ok 2025-05-13 18:44:23.148005 | 2025-05-13 18:44:23.148111 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-13 18:44:23.445421 | ubuntu-noble -> localhost | ok 2025-05-13 18:44:23.453825 | 2025-05-13 18:44:23.453940 | TASK [validate-host : Collect information about the host] 2025-05-13 18:44:24.669992 | ubuntu-noble | ok 2025-05-13 18:44:24.684187 | 2025-05-13 18:44:24.684385 | TASK [validate-host : Sanitize hostname] 2025-05-13 18:44:24.749405 | ubuntu-noble | ok 2025-05-13 18:44:24.757538 | 2025-05-13 18:44:24.757712 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-13 18:44:25.359898 | ubuntu-noble -> localhost | changed 2025-05-13 18:44:25.369025 | 2025-05-13 18:44:25.369181 | TASK [validate-host : Collect information about zuul worker] 2025-05-13 18:44:25.924347 | ubuntu-noble | ok 2025-05-13 18:44:25.933525 | 2025-05-13 18:44:25.933686 | TASK [validate-host : Write out all zuul information for each host] 2025-05-13 18:44:26.528938 | ubuntu-noble -> localhost | changed 2025-05-13 18:44:26.575572 | 2025-05-13 18:44:26.575707 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-13 18:44:26.896739 | ubuntu-noble | ok 2025-05-13 18:44:26.902761 | 2025-05-13 18:44:26.903154 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-13 18:44:28.003110 | ubuntu-noble | changed: 2025-05-13 18:44:28.003425 | ubuntu-noble | cd+++++++++ src/ 2025-05-13 18:44:28.003473 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-05-13 18:44:28.003505 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-05-13 18:44:28.003533 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-05-13 18:44:28.003558 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.024009 2025-05-13 18:44:59.722086 | 2025-05-13 18:44:59.722178 | TASK [upload-logs : Upload logs to log server] 2025-05-13 18:45:00.235719 | localhost | Output suppressed because no_log was given 2025-05-13 18:45:00.238203 | 2025-05-13 18:45:00.238348 | LOOP [upload-logs : Compress console log and json output] 2025-05-13 18:45:00.294710 | localhost | skipping: Conditional result was False 2025-05-13 18:45:00.301041 | localhost | skipping: Conditional result was False 2025-05-13 18:45:00.307000 | 2025-05-13 18:45:00.307150 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-13 18:45:00.349038 | localhost | skipping: Conditional result was False 2025-05-13 18:45:00.349377 | 2025-05-13 18:45:00.354477 | localhost | skipping: Conditional result was False 2025-05-13 18:45:00.367352 | 2025-05-13 18:45:00.367597 | LOOP [upload-logs : Upload console log and json output]