2025-03-12 16:19:58.519200 | Job console starting... 2025-03-12 16:19:58.529133 | Updating repositories 2025-03-12 16:19:58.565570 | Preparing job workspace 2025-03-12 16:20:00.008927 | Running Ansible setup... 2025-03-12 16:20:05.410643 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-12 16:20:06.121720 | 2025-03-12 16:20:06.121912 | PLAY [Base pre] 2025-03-12 16:20:06.151344 | 2025-03-12 16:20:06.151487 | TASK [Setup log path fact] 2025-03-12 16:20:06.172279 | ubuntu-noble | ok 2025-03-12 16:20:06.193819 | 2025-03-12 16:20:06.193945 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 16:20:06.244494 | ubuntu-noble | ok 2025-03-12 16:20:06.251075 | 2025-03-12 16:20:06.251183 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 16:20:06.285339 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:06.292456 | 2025-03-12 16:20:06.292568 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 16:20:06.333469 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:06.342005 | 2025-03-12 16:20:06.342142 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-12 16:20:06.371147 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:06.382900 | 2025-03-12 16:20:06.383115 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-12 16:20:06.409079 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:06.420235 | 2025-03-12 16:20:06.420346 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-12 16:20:06.446768 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:06.470840 | 2025-03-12 16:20:06.470958 | TASK [emit-job-header : Print job information] 2025-03-12 16:20:06.522106 | # Job Information 2025-03-12 16:20:06.522275 | Ansible Version: 2.15.3 2025-03-12 16:20:06.522306 | Job: yamllint 2025-03-12 16:20:06.522334 | Pipeline: check 2025-03-12 16:20:06.522353 | Executor: 7d211f194f6a 2025-03-12 16:20:06.522372 | Triggered by: https://github.com/osism/testbed/pull/2630 2025-03-12 16:20:06.522390 | Event ID: c8e99f50-ff5d-11ef-8573-d1d6b37823e0 2025-03-12 16:20:06.528776 | 2025-03-12 16:20:06.528884 | LOOP [emit-job-header : Print node information] 2025-03-12 16:20:06.671237 | ubuntu-noble | ok: 2025-03-12 16:20:06.671503 | ubuntu-noble | # Node Information 2025-03-12 16:20:06.671542 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-12 16:20:06.671566 | ubuntu-noble | Hostname: ubuntu 2025-03-12 16:20:06.671587 | ubuntu-noble | Username: zuul 2025-03-12 16:20:06.671608 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-12 16:20:06.671628 | ubuntu-noble | Provider: regiocloud-a 2025-03-12 16:20:06.671646 | ubuntu-noble | Label: ubuntu-noble 2025-03-12 16:20:06.671666 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-12 16:20:06.671687 | ubuntu-noble | Interface IP: 81.163.192.121 2025-03-12 16:20:06.685217 | 2025-03-12 16:20:06.685333 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-12 16:20:07.191719 | ubuntu-noble -> localhost | changed 2025-03-12 16:20:07.203612 | 2025-03-12 16:20:07.203729 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-12 16:20:08.514236 | ubuntu-noble -> localhost | changed 2025-03-12 16:20:08.528004 | 2025-03-12 16:20:08.528137 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-12 16:20:09.175532 | ubuntu-noble -> localhost | ok 2025-03-12 16:20:09.230159 | 2025-03-12 16:20:09.231334 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-12 16:20:09.371362 | ubuntu-noble | ok 2025-03-12 16:20:09.438649 | ubuntu-noble | included: /var/lib/zuul/builds/d591c7970d254553b934ee45721df6c0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-12 16:20:09.447280 | 2025-03-12 16:20:09.447392 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-12 16:20:10.300628 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-12 16:20:10.300966 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d591c7970d254553b934ee45721df6c0/work/d591c7970d254553b934ee45721df6c0_id_rsa 2025-03-12 16:20:10.301016 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d591c7970d254553b934ee45721df6c0/work/d591c7970d254553b934ee45721df6c0_id_rsa.pub 2025-03-12 16:20:10.301046 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-12 16:20:10.301072 | ubuntu-noble -> localhost | SHA256:X0tLSeLKLDt6a1Td/O5riPGDO8mzXlD1ruD2dw5oUS4 zuul-build-sshkey 2025-03-12 16:20:10.301097 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-12 16:20:10.301126 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-12 16:20:10.301151 | ubuntu-noble -> localhost | | . | 2025-03-12 16:20:10.301175 | ubuntu-noble -> localhost | | . . | 2025-03-12 16:20:10.301197 | ubuntu-noble -> localhost | | ..oo . .| 2025-03-12 16:20:10.301219 | ubuntu-noble -> localhost | | ...+o+ . | 2025-03-12 16:20:10.301241 | ubuntu-noble -> localhost | | .S o E.. .| 2025-03-12 16:20:10.301263 | ubuntu-noble -> localhost | | .o o.* B.. | 2025-03-12 16:20:10.301284 | ubuntu-noble -> localhost | | .. +..*Ooo | 2025-03-12 16:20:10.301307 | ubuntu-noble -> localhost | | +o B++.o.o| 2025-03-12 16:20:10.301329 | ubuntu-noble -> localhost | | .+oo .+= +++o| 2025-03-12 16:20:10.301351 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-12 16:20:10.301409 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.280518 2025-03-12 16:20:10.311910 | 2025-03-12 16:20:10.312022 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-12 16:20:10.347236 | ubuntu-noble | ok 2025-03-12 16:20:10.359615 | ubuntu-noble | included: /var/lib/zuul/builds/d591c7970d254553b934ee45721df6c0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-12 16:20:10.370848 | 2025-03-12 16:20:10.370955 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-12 16:20:10.396158 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:10.413341 | 2025-03-12 16:20:10.413477 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-12 16:20:11.251312 | ubuntu-noble | changed 2025-03-12 16:20:11.259671 | 2025-03-12 16:20:11.259801 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-12 16:20:11.601474 | ubuntu-noble | ok 2025-03-12 16:20:11.637112 | 2025-03-12 16:20:11.637252 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-12 16:20:12.348200 | ubuntu-noble | changed 2025-03-12 16:20:12.358437 | 2025-03-12 16:20:12.358648 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-12 16:20:13.097030 | ubuntu-noble | changed 2025-03-12 16:20:13.104300 | 2025-03-12 16:20:13.104434 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-12 16:20:13.129367 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:13.138933 | 2025-03-12 16:20:13.139065 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-12 16:20:13.669453 | ubuntu-noble -> localhost | changed 2025-03-12 16:20:13.693142 | 2025-03-12 16:20:13.693411 | TASK [add-build-sshkey : Add back temp key] 2025-03-12 16:20:14.182142 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d591c7970d254553b934ee45721df6c0/work/d591c7970d254553b934ee45721df6c0_id_rsa (zuul-build-sshkey) 2025-03-12 16:20:14.182732 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016232 2025-03-12 16:20:14.238835 | 2025-03-12 16:20:14.239051 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-12 16:20:14.675894 | ubuntu-noble | ok 2025-03-12 16:20:14.683464 | 2025-03-12 16:20:14.683578 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-12 16:20:14.717943 | ubuntu-noble | skipping: Conditional result was False 2025-03-12 16:20:14.731157 | 2025-03-12 16:20:14.731274 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-12 16:20:15.211939 | ubuntu-noble | ok 2025-03-12 16:20:15.224449 | 2025-03-12 16:20:15.224576 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-12 16:20:15.270656 | ubuntu-noble | ok 2025-03-12 16:20:15.281838 | 2025-03-12 16:20:15.282079 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-12 16:20:15.636274 | ubuntu-noble -> localhost | ok 2025-03-12 16:20:15.648004 | 2025-03-12 16:20:15.648185 | TASK [validate-host : Collect information about the host] 2025-03-12 16:20:16.956257 | ubuntu-noble | ok 2025-03-12 16:20:16.970102 | 2025-03-12 16:20:16.970220 | TASK [validate-host : Sanitize hostname] 2025-03-12 16:20:17.033172 | ubuntu-noble | ok 2025-03-12 16:20:17.039516 | 2025-03-12 16:20:17.039624 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-12 16:20:17.606131 | ubuntu-noble -> localhost | changed 2025-03-12 16:20:17.615031 | 2025-03-12 16:20:17.615157 | TASK [validate-host : Collect information about zuul worker] 2025-03-12 16:20:18.109471 | ubuntu-noble | ok 2025-03-12 16:20:18.117808 | 2025-03-12 16:20:18.117935 | TASK [validate-host : Write out all zuul information for each host] 2025-03-12 16:20:18.755827 | ubuntu-noble -> localhost | changed 2025-03-12 16:20:18.770138 | 2025-03-12 16:20:18.770251 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-12 16:20:19.172031 | ubuntu-noble | ok 2025-03-12 16:20:19.180943 | 2025-03-12 16:20:19.181064 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-12 16:20:20.210354 | ubuntu-noble | changed: 2025-03-12 16:20:20.210649 | ubuntu-noble | cd+++++++++ src/ 2025-03-12 16:20:20.210698 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-12 16:20:20.210731 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-12 16:20:20.210833 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-12 16:20:20.210866 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006611 2025-03-12 16:20:57.970481 | 2025-03-12 16:20:57.970647 | TASK [upload-logs : Upload logs to log server] 2025-03-12 16:20:58.539736 | localhost | Output suppressed because no_log was given 2025-03-12 16:20:58.543645 | 2025-03-12 16:20:58.543771 | LOOP [upload-logs : Compress console log and json output] 2025-03-12 16:20:58.621826 | localhost | skipping: Conditional result was False 2025-03-12 16:20:58.652282 | localhost | skipping: Conditional result was False 2025-03-12 16:20:58.669613 | 2025-03-12 16:20:58.669823 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-12 16:20:58.749480 | localhost | skipping: Conditional result was False 2025-03-12 16:20:58.749817 | 2025-03-12 16:20:58.776727 | localhost | skipping: Conditional result was False 2025-03-12 16:20:58.783345 | 2025-03-12 16:20:58.783454 | LOOP [upload-logs : Upload console log and json output]