2025-01-10 16:48:58.629326 | Job console starting... 2025-01-10 16:48:58.649519 | Updating repositories 2025-01-10 16:48:58.691255 | Preparing job workspace 2025-01-10 16:49:00.541814 | Running Ansible setup... 2025-01-10 16:49:06.189055 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-10 16:49:06.952093 | 2025-01-10 16:49:06.952280 | PLAY [Base pre] 2025-01-10 16:49:07.005227 | 2025-01-10 16:49:07.005567 | TASK [Setup log path fact] 2025-01-10 16:49:07.051605 | ubuntu-noble | ok 2025-01-10 16:49:07.079546 | 2025-01-10 16:49:07.079717 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-10 16:49:07.133411 | ubuntu-noble | ok 2025-01-10 16:49:07.144614 | 2025-01-10 16:49:07.144762 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-10 16:49:07.203749 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.212094 | 2025-01-10 16:49:07.212265 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-10 16:49:07.278742 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.286672 | 2025-01-10 16:49:07.286808 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-10 16:49:07.334482 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.342226 | 2025-01-10 16:49:07.342353 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-10 16:49:07.378361 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.386460 | 2025-01-10 16:49:07.386583 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-10 16:49:07.412675 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.428841 | 2025-01-10 16:49:07.428956 | TASK [emit-job-header : Print job information] 2025-01-10 16:49:07.481085 | # Job Information 2025-01-10 16:49:07.481288 | Ansible Version: 2.15.3 2025-01-10 16:49:07.481323 | Job: ansible-lint 2025-01-10 16:49:07.481353 | Pipeline: check 2025-01-10 16:49:07.481374 | Executor: 7d211f194f6a 2025-01-10 16:49:07.481393 | Triggered by: https://github.com/osism/testbed/pull/2577 2025-01-10 16:49:07.481412 | Event ID: c43d2e60-cf72-11ef-9671-e6a74987f0d2 2025-01-10 16:49:07.489054 | 2025-01-10 16:49:07.489182 | LOOP [emit-job-header : Print node information] 2025-01-10 16:49:07.671534 | ubuntu-noble | ok: 2025-01-10 16:49:07.671766 | ubuntu-noble | # Node Information 2025-01-10 16:49:07.671800 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-10 16:49:07.671823 | ubuntu-noble | Hostname: ubuntu 2025-01-10 16:49:07.671844 | ubuntu-noble | Username: zuul 2025-01-10 16:49:07.671864 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-10 16:49:07.671884 | ubuntu-noble | Provider: regiocloud-a 2025-01-10 16:49:07.671903 | ubuntu-noble | Label: ubuntu-noble 2025-01-10 16:49:07.671923 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-10 16:49:07.671944 | ubuntu-noble | Interface IP: 81.163.193.200 2025-01-10 16:49:07.699056 | 2025-01-10 16:49:07.699208 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-10 16:49:08.201981 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:08.210879 | 2025-01-10 16:49:08.211011 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-10 16:49:09.270385 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:09.284652 | 2025-01-10 16:49:09.284766 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-10 16:49:09.574591 | ubuntu-noble -> localhost | ok 2025-01-10 16:49:09.583849 | 2025-01-10 16:49:09.583951 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-10 16:49:09.605131 | ubuntu-noble | ok 2025-01-10 16:49:09.621343 | ubuntu-noble | included: /var/lib/zuul/builds/a3bc9df4d1534f1b861848a45272690d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-10 16:49:09.629025 | 2025-01-10 16:49:09.629126 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-10 16:49:10.286674 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-10 16:49:10.286923 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a3bc9df4d1534f1b861848a45272690d/work/a3bc9df4d1534f1b861848a45272690d_id_rsa 2025-01-10 16:49:10.286963 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a3bc9df4d1534f1b861848a45272690d/work/a3bc9df4d1534f1b861848a45272690d_id_rsa.pub 2025-01-10 16:49:10.286988 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-10 16:49:10.287012 | ubuntu-noble -> localhost | SHA256:audNXfgH+1r6DLCuYhCTX0jyMNfTX2QPqMBMRNZbWiI zuul-build-sshkey 2025-01-10 16:49:10.287034 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-10 16:49:10.287059 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-10 16:49:10.287081 | ubuntu-noble -> localhost | | *=o . ...o| 2025-01-10 16:49:10.287112 | ubuntu-noble -> localhost | | +.E = = oo| 2025-01-10 16:49:10.287133 | ubuntu-noble -> localhost | | O + O . ..| 2025-01-10 16:49:10.287154 | ubuntu-noble -> localhost | | + o = .. | 2025-01-10 16:49:10.287173 | ubuntu-noble -> localhost | | +S. o o | 2025-01-10 16:49:10.287192 | ubuntu-noble -> localhost | | ... . = o | 2025-01-10 16:49:10.287212 | ubuntu-noble -> localhost | | o.. . o + o| 2025-01-10 16:49:10.287232 | ubuntu-noble -> localhost | | . ooo . B | 2025-01-10 16:49:10.287251 | ubuntu-noble -> localhost | | ...o.. oo+| 2025-01-10 16:49:10.287270 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-10 16:49:10.287320 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.172745 2025-01-10 16:49:10.301491 | 2025-01-10 16:49:10.301608 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-10 16:49:10.333327 | ubuntu-noble | ok 2025-01-10 16:49:10.345565 | ubuntu-noble | included: /var/lib/zuul/builds/a3bc9df4d1534f1b861848a45272690d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-10 16:49:10.355193 | 2025-01-10 16:49:10.355279 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-10 16:49:10.379830 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:10.387259 | 2025-01-10 16:49:10.387356 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-10 16:49:11.100550 | ubuntu-noble | changed 2025-01-10 16:49:11.107526 | 2025-01-10 16:49:11.107608 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-10 16:49:11.391614 | ubuntu-noble | ok 2025-01-10 16:49:11.399435 | 2025-01-10 16:49:11.399522 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-10 16:49:12.133368 | ubuntu-noble | changed 2025-01-10 16:49:12.141117 | 2025-01-10 16:49:12.141224 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-10 16:49:12.842823 | ubuntu-noble | changed 2025-01-10 16:49:12.849714 | 2025-01-10 16:49:12.849805 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-10 16:49:12.888898 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:12.896318 | 2025-01-10 16:49:12.896413 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-10 16:49:13.327187 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:13.342200 | 2025-01-10 16:49:13.342301 | TASK [add-build-sshkey : Add back temp key] 2025-01-10 16:49:13.660487 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a3bc9df4d1534f1b861848a45272690d/work/a3bc9df4d1534f1b861848a45272690d_id_rsa (zuul-build-sshkey) 2025-01-10 16:49:13.660708 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010360 2025-01-10 16:49:13.668285 | 2025-01-10 16:49:13.668382 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-10 16:49:14.106788 | ubuntu-noble | ok 2025-01-10 16:49:14.113595 | 2025-01-10 16:49:14.113679 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-10 16:49:14.147907 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:14.160641 | 2025-01-10 16:49:14.160735 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-10 16:49:14.561474 | ubuntu-noble | ok 2025-01-10 16:49:14.573564 | 2025-01-10 16:49:14.573655 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-10 16:49:14.604470 | ubuntu-noble | ok 2025-01-10 16:49:14.611058 | 2025-01-10 16:49:14.611171 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-10 16:49:14.868320 | ubuntu-noble -> localhost | ok 2025-01-10 16:49:14.875853 | 2025-01-10 16:49:14.875944 | TASK [validate-host : Collect information about the host] 2025-01-10 16:49:16.017443 | ubuntu-noble | ok 2025-01-10 16:49:16.029324 | 2025-01-10 16:49:16.029418 | TASK [validate-host : Sanitize hostname] 2025-01-10 16:49:16.097403 | ubuntu-noble | ok 2025-01-10 16:49:16.106590 | 2025-01-10 16:49:16.106713 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-10 16:49:16.600515 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:16.607740 | 2025-01-10 16:49:16.607841 | TASK [validate-host : Collect information about zuul worker] 2025-01-10 16:49:17.082087 | ubuntu-noble | ok 2025-01-10 16:49:17.089512 | 2025-01-10 16:49:17.089610 | TASK [validate-host : Write out all zuul information for each host] 2025-01-10 16:49:17.676781 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:17.694431 | 2025-01-10 16:49:17.694543 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-10 16:49:18.020129 | ubuntu-noble | ok 2025-01-10 16:49:18.035237 | 2025-01-10 16:49:18.035411 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-10 16:49:19.445184 | ubuntu-noble | changed: 2025-01-10 16:49:19.445450 | ubuntu-noble | cd+++++++++ src/ 2025-01-10 16:49:19.445488 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-10 16:49:19.445511 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-10 16:49:19.445532 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-10 16:49:19.445552 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008240 2025-01-10 16:50:44.766331 | 2025-01-10 16:50:44.766480 | TASK [upload-logs : Upload logs to log server] 2025-01-10 16:50:45.372738 | localhost | Output suppressed because no_log was given 2025-01-10 16:50:45.377366 | 2025-01-10 16:50:45.377505 | LOOP [upload-logs : Compress console log and json output] 2025-01-10 16:50:45.450211 | localhost | skipping: Conditional result was False 2025-01-10 16:50:45.481406 | localhost | skipping: Conditional result was False 2025-01-10 16:50:45.493631 | 2025-01-10 16:50:45.493870 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-10 16:50:45.567513 | localhost | skipping: Conditional result was False 2025-01-10 16:50:45.568371 | 2025-01-10 16:50:45.580077 | localhost | skipping: Conditional result was False 2025-01-10 16:50:45.594044 | 2025-01-10 16:50:45.594234 | LOOP [upload-logs : Upload console log and json output]