2025-04-07 20:03:01.254893 | Job console starting... 2025-04-07 20:03:01.303724 | Updating repositories 2025-04-07 20:03:01.356249 | Preparing job workspace 2025-04-07 20:03:03.230358 | Running Ansible setup... 2025-04-07 20:03:09.703395 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-07 20:03:10.611647 | 2025-04-07 20:03:10.611834 | PLAY [Base pre] 2025-04-07 20:03:10.654987 | 2025-04-07 20:03:10.655109 | TASK [Setup log path fact] 2025-04-07 20:03:10.676730 | ubuntu-noble | ok 2025-04-07 20:03:10.714786 | 2025-04-07 20:03:10.714902 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-07 20:03:10.768269 | ubuntu-noble | ok 2025-04-07 20:03:10.791515 | 2025-04-07 20:03:10.791616 | TASK [emit-job-header : Print job information] 2025-04-07 20:03:10.855850 | # Job Information 2025-04-07 20:03:10.856004 | Ansible Version: 2.15.3 2025-04-07 20:03:10.856036 | Job: python-black 2025-04-07 20:03:10.856063 | Pipeline: check 2025-04-07 20:03:10.856099 | Executor: 7d211f194f6a 2025-04-07 20:03:10.856173 | Triggered by: https://github.com/osism/testbed/pull/2654 2025-04-07 20:03:10.856193 | Event ID: 4ab42e50-13eb-11f0-8757-b32bfa15fb4e 2025-04-07 20:03:10.862784 | 2025-04-07 20:03:10.862864 | LOOP [emit-job-header : Print node information] 2025-04-07 20:03:11.001846 | ubuntu-noble | ok: 2025-04-07 20:03:11.002049 | ubuntu-noble | # Node Information 2025-04-07 20:03:11.002086 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-07 20:03:11.002111 | ubuntu-noble | Hostname: ubuntu 2025-04-07 20:03:11.002134 | ubuntu-noble | Username: zuul 2025-04-07 20:03:11.002154 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-07 20:03:11.002178 | ubuntu-noble | Provider: regiocloud-a 2025-04-07 20:03:11.002198 | ubuntu-noble | Label: ubuntu-noble 2025-04-07 20:03:11.002251 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-07 20:03:11.002277 | ubuntu-noble | Interface IP: 81.163.193.97 2025-04-07 20:03:11.024282 | 2025-04-07 20:03:11.024420 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-07 20:03:11.759364 | ubuntu-noble -> localhost | changed 2025-04-07 20:03:11.782420 | 2025-04-07 20:03:11.782614 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-07 20:03:13.251843 | ubuntu-noble -> localhost | changed 2025-04-07 20:03:13.265701 | 2025-04-07 20:03:13.265812 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-07 20:03:13.616836 | ubuntu-noble -> localhost | ok 2025-04-07 20:03:13.625841 | 2025-04-07 20:03:13.625931 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-07 20:03:13.656461 | ubuntu-noble | ok 2025-04-07 20:03:13.676159 | ubuntu-noble | included: /var/lib/zuul/builds/33c43de830dd460bb459d15278bc87a7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-07 20:03:13.683093 | 2025-04-07 20:03:13.683168 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-07 20:03:14.628754 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-07 20:03:14.628963 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/33c43de830dd460bb459d15278bc87a7/work/33c43de830dd460bb459d15278bc87a7_id_rsa 2025-04-07 20:03:14.629034 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/33c43de830dd460bb459d15278bc87a7/work/33c43de830dd460bb459d15278bc87a7_id_rsa.pub 2025-04-07 20:03:14.629060 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-07 20:03:14.629083 | ubuntu-noble -> localhost | SHA256:FCc7AKauWyju9yDwVIm/sLh0MC5LdWcZZ9ofYRpW9fc zuul-build-sshkey 2025-04-07 20:03:14.629104 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-07 20:03:14.629124 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-07 20:03:14.629143 | ubuntu-noble -> localhost | | o.. o .... | 2025-04-07 20:03:14.629162 | ubuntu-noble -> localhost | | + . . =. . | 2025-04-07 20:03:14.629181 | ubuntu-noble -> localhost | | o o .+= o ..| 2025-04-07 20:03:14.629244 | ubuntu-noble -> localhost | | . o .O.+ . o| 2025-04-07 20:03:14.629269 | ubuntu-noble -> localhost | |.o+... =So . E| 2025-04-07 20:03:14.629289 | ubuntu-noble -> localhost | |o*+o..o . . | 2025-04-07 20:03:14.629313 | ubuntu-noble -> localhost | |*=+o. . | 2025-04-07 20:03:14.629332 | ubuntu-noble -> localhost | |*=o.. | 2025-04-07 20:03:14.629351 | ubuntu-noble -> localhost | |=o. .. | 2025-04-07 20:03:14.629370 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-07 20:03:14.629419 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.450542 2025-04-07 20:03:14.637628 | 2025-04-07 20:03:14.637717 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-07 20:03:14.668461 | ubuntu-noble | ok 2025-04-07 20:03:14.680639 | ubuntu-noble | included: /var/lib/zuul/builds/33c43de830dd460bb459d15278bc87a7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-07 20:03:14.691154 | 2025-04-07 20:03:14.691236 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-07 20:03:14.705689 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 20:03:14.712487 | 2025-04-07 20:03:14.712561 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-07 20:03:15.407316 | ubuntu-noble | changed 2025-04-07 20:03:15.414080 | 2025-04-07 20:03:15.414168 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-07 20:03:15.746780 | ubuntu-noble | ok 2025-04-07 20:03:15.756665 | 2025-04-07 20:03:15.756775 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-07 20:03:16.463029 | ubuntu-noble | changed 2025-04-07 20:03:16.469544 | 2025-04-07 20:03:16.469630 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-07 20:03:17.208190 | ubuntu-noble | changed 2025-04-07 20:03:17.217487 | 2025-04-07 20:03:17.217587 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-07 20:03:17.243443 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 20:03:17.265845 | 2025-04-07 20:03:17.265946 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-07 20:03:17.637078 | ubuntu-noble -> localhost | changed 2025-04-07 20:03:17.651245 | 2025-04-07 20:03:17.651340 | TASK [add-build-sshkey : Add back temp key] 2025-04-07 20:03:17.959590 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/33c43de830dd460bb459d15278bc87a7/work/33c43de830dd460bb459d15278bc87a7_id_rsa (zuul-build-sshkey) 2025-04-07 20:03:17.959760 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007895 2025-04-07 20:03:17.965645 | 2025-04-07 20:03:17.965722 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-07 20:03:18.399552 | ubuntu-noble | ok 2025-04-07 20:03:18.407993 | 2025-04-07 20:03:18.408107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-07 20:03:18.431966 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 20:03:18.447154 | 2025-04-07 20:03:18.447242 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-07 20:03:18.882807 | ubuntu-noble | ok 2025-04-07 20:03:18.899238 | 2025-04-07 20:03:18.899339 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-07 20:03:18.946154 | ubuntu-noble | ok 2025-04-07 20:03:18.954263 | 2025-04-07 20:03:18.954363 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-07 20:03:19.286571 | ubuntu-noble -> localhost | ok 2025-04-07 20:03:19.293878 | 2025-04-07 20:03:19.293985 | TASK [validate-host : Collect information about the host] 2025-04-07 20:03:20.442723 | ubuntu-noble | ok 2025-04-07 20:03:20.454649 | 2025-04-07 20:03:20.454740 | TASK [validate-host : Sanitize hostname] 2025-04-07 20:03:20.513912 | ubuntu-noble | ok 2025-04-07 20:03:20.520151 | 2025-04-07 20:03:20.520240 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-07 20:03:21.042922 | ubuntu-noble -> localhost | changed 2025-04-07 20:03:21.049598 | 2025-04-07 20:03:21.049696 | TASK [validate-host : Collect information about zuul worker] 2025-04-07 20:03:21.541865 | ubuntu-noble | ok 2025-04-07 20:03:21.551087 | 2025-04-07 20:03:21.551201 | TASK [validate-host : Write out all zuul information for each host] 2025-04-07 20:03:22.046398 | ubuntu-noble -> localhost | changed 2025-04-07 20:03:22.058284 | 2025-04-07 20:03:22.058373 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-07 20:03:22.360231 | ubuntu-noble | ok 2025-04-07 20:03:22.369302 | 2025-04-07 20:03:22.369420 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-07 20:03:23.670870 | ubuntu-noble | changed: 2025-04-07 20:03:23.671088 | ubuntu-noble | cd+++++++++ src/ 2025-04-07 20:03:23.671125 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-07 20:03:23.671150 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-07 20:03:23.671171 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-07 20:03:23.671192 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008161 2025-04-07 20:03:56.580122 | 2025-04-07 20:03:56.580258 | TASK [upload-logs : Upload logs to log server] 2025-04-07 20:03:57.195063 | localhost | Output suppressed because no_log was given 2025-04-07 20:03:57.198207 | 2025-04-07 20:03:57.198313 | LOOP [upload-logs : Compress console log and json output] 2025-04-07 20:03:57.265004 | localhost | skipping: Conditional result was False 2025-04-07 20:03:57.281957 | localhost | skipping: Conditional result was False 2025-04-07 20:03:57.291922 | 2025-04-07 20:03:57.292180 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-07 20:03:57.353354 | localhost | skipping: Conditional result was False 2025-04-07 20:03:57.353649 | 2025-04-07 20:03:57.363115 | localhost | skipping: Conditional result was False 2025-04-07 20:03:57.371523 | 2025-04-07 20:03:57.371641 | LOOP [upload-logs : Upload console log and json output]