2025-01-18 19:50:57.680845 | Job console starting... 2025-01-18 19:50:57.711132 | Updating repositories 2025-01-18 19:50:57.769332 | Preparing job workspace 2025-01-18 19:50:59.576696 | Running Ansible setup... 2025-01-18 19:51:04.776500 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-18 19:51:05.578041 | 2025-01-18 19:51:05.578209 | PLAY [Base pre] 2025-01-18 19:51:05.611598 | 2025-01-18 19:51:05.611760 | TASK [Setup log path fact] 2025-01-18 19:51:05.654382 | ubuntu-noble | ok 2025-01-18 19:51:05.683544 | 2025-01-18 19:51:05.683704 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-18 19:51:05.740190 | ubuntu-noble | ok 2025-01-18 19:51:05.747176 | 2025-01-18 19:51:05.747302 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-18 19:51:05.782091 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:05.793056 | 2025-01-18 19:51:05.793206 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-18 19:51:05.840455 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:05.848324 | 2025-01-18 19:51:05.848488 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-18 19:51:05.873121 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:05.880567 | 2025-01-18 19:51:05.880691 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-18 19:51:05.915655 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:05.923489 | 2025-01-18 19:51:05.923622 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-18 19:51:05.950018 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:05.966933 | 2025-01-18 19:51:05.967088 | TASK [emit-job-header : Print job information] 2025-01-18 19:51:06.028353 | # Job Information 2025-01-18 19:51:06.028592 | Ansible Version: 2.15.3 2025-01-18 19:51:06.028627 | Job: yamllint 2025-01-18 19:51:06.028656 | Pipeline: check 2025-01-18 19:51:06.028678 | Executor: 7d211f194f6a 2025-01-18 19:51:06.028697 | Triggered by: https://github.com/osism/testbed/pull/2589 2025-01-18 19:51:06.028716 | Event ID: 82e91b40-d5d5-11ef-8aed-1c890ddc9876 2025-01-18 19:51:06.035148 | 2025-01-18 19:51:06.035262 | LOOP [emit-job-header : Print node information] 2025-01-18 19:51:06.187204 | ubuntu-noble | ok: 2025-01-18 19:51:06.187397 | ubuntu-noble | # Node Information 2025-01-18 19:51:06.187430 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-18 19:51:06.187453 | ubuntu-noble | Hostname: ubuntu 2025-01-18 19:51:06.187473 | ubuntu-noble | Username: zuul 2025-01-18 19:51:06.187492 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-18 19:51:06.187510 | ubuntu-noble | Provider: regiocloud-a 2025-01-18 19:51:06.187529 | ubuntu-noble | Label: ubuntu-noble 2025-01-18 19:51:06.187547 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-18 19:51:06.187567 | ubuntu-noble | Interface IP: 81.163.192.238 2025-01-18 19:51:06.206719 | 2025-01-18 19:51:06.206848 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-18 19:51:06.762345 | ubuntu-noble -> localhost | changed 2025-01-18 19:51:06.773825 | 2025-01-18 19:51:06.773978 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-18 19:51:07.891232 | ubuntu-noble -> localhost | changed 2025-01-18 19:51:07.906523 | 2025-01-18 19:51:07.906725 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-18 19:51:08.248123 | ubuntu-noble -> localhost | ok 2025-01-18 19:51:08.263134 | 2025-01-18 19:51:08.263297 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-18 19:51:08.294772 | ubuntu-noble | ok 2025-01-18 19:51:08.311585 | ubuntu-noble | included: /var/lib/zuul/builds/5cf190c4b2244dbe93f9c8dfe42002b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-18 19:51:08.319545 | 2025-01-18 19:51:08.319679 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-18 19:51:09.391041 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-18 19:51:09.391307 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/5cf190c4b2244dbe93f9c8dfe42002b3/work/5cf190c4b2244dbe93f9c8dfe42002b3_id_rsa 2025-01-18 19:51:09.391346 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/5cf190c4b2244dbe93f9c8dfe42002b3/work/5cf190c4b2244dbe93f9c8dfe42002b3_id_rsa.pub 2025-01-18 19:51:09.391372 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-18 19:51:09.391395 | ubuntu-noble -> localhost | SHA256:Ybld+s73KNtMbdawNMz8ZN7z2Se2s3JIF7h0mknqgYc zuul-build-sshkey 2025-01-18 19:51:09.391417 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-18 19:51:09.391443 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-18 19:51:09.391464 | ubuntu-noble -> localhost | | | 2025-01-18 19:51:09.391485 | ubuntu-noble -> localhost | | . | 2025-01-18 19:51:09.391505 | ubuntu-noble -> localhost | | + .. | 2025-01-18 19:51:09.391525 | ubuntu-noble -> localhost | | . + o++o | 2025-01-18 19:51:09.391544 | ubuntu-noble -> localhost | | Soo+ *B.o| 2025-01-18 19:51:09.391564 | ubuntu-noble -> localhost | | E +.*..Xo| 2025-01-18 19:51:09.391583 | ubuntu-noble -> localhost | | o o.oo.O| 2025-01-18 19:51:09.391603 | ubuntu-noble -> localhost | | .o++*+*| 2025-01-18 19:51:09.391623 | ubuntu-noble -> localhost | | +B*B=| 2025-01-18 19:51:09.391642 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-18 19:51:09.391690 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.505174 2025-01-18 19:51:09.400709 | 2025-01-18 19:51:09.400830 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-18 19:51:09.432573 | ubuntu-noble | ok 2025-01-18 19:51:09.443700 | ubuntu-noble | included: /var/lib/zuul/builds/5cf190c4b2244dbe93f9c8dfe42002b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-18 19:51:09.453558 | 2025-01-18 19:51:09.453664 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-18 19:51:09.478255 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:09.486114 | 2025-01-18 19:51:09.486248 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-18 19:51:10.263276 | ubuntu-noble | changed 2025-01-18 19:51:10.274163 | 2025-01-18 19:51:10.274286 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-18 19:51:10.571249 | ubuntu-noble | ok 2025-01-18 19:51:10.578859 | 2025-01-18 19:51:10.578996 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-18 19:51:11.342692 | ubuntu-noble | changed 2025-01-18 19:51:11.352726 | 2025-01-18 19:51:11.352855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-18 19:51:12.067202 | ubuntu-noble | changed 2025-01-18 19:51:12.080103 | 2025-01-18 19:51:12.080258 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-18 19:51:12.105720 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:12.114309 | 2025-01-18 19:51:12.114455 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-18 19:51:12.580614 | ubuntu-noble -> localhost | changed 2025-01-18 19:51:12.594676 | 2025-01-18 19:51:12.594821 | TASK [add-build-sshkey : Add back temp key] 2025-01-18 19:51:12.979613 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/5cf190c4b2244dbe93f9c8dfe42002b3/work/5cf190c4b2244dbe93f9c8dfe42002b3_id_rsa (zuul-build-sshkey) 2025-01-18 19:51:12.979863 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010225 2025-01-18 19:51:12.996814 | 2025-01-18 19:51:12.996972 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-18 19:51:13.437464 | ubuntu-noble | ok 2025-01-18 19:51:13.443906 | 2025-01-18 19:51:13.444037 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-18 19:51:13.478590 | ubuntu-noble | skipping: Conditional result was False 2025-01-18 19:51:13.492843 | 2025-01-18 19:51:13.492994 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-18 19:51:13.901578 | ubuntu-noble | ok 2025-01-18 19:51:13.916362 | 2025-01-18 19:51:13.916508 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-18 19:51:13.947725 | ubuntu-noble | ok 2025-01-18 19:51:13.960447 | 2025-01-18 19:51:13.960565 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-18 19:51:14.281821 | ubuntu-noble -> localhost | ok 2025-01-18 19:51:14.293512 | 2025-01-18 19:51:14.293669 | TASK [validate-host : Collect information about the host] 2025-01-18 19:51:15.485940 | ubuntu-noble | ok 2025-01-18 19:51:15.498675 | 2025-01-18 19:51:15.498819 | TASK [validate-host : Sanitize hostname] 2025-01-18 19:51:15.580309 | ubuntu-noble | ok 2025-01-18 19:51:15.586898 | 2025-01-18 19:51:15.587040 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-18 19:51:16.163133 | ubuntu-noble -> localhost | changed 2025-01-18 19:51:16.170888 | 2025-01-18 19:51:16.171036 | TASK [validate-host : Collect information about zuul worker] 2025-01-18 19:51:16.649420 | ubuntu-noble | ok 2025-01-18 19:51:16.659364 | 2025-01-18 19:51:16.659493 | TASK [validate-host : Write out all zuul information for each host] 2025-01-18 19:51:17.294015 | ubuntu-noble -> localhost | changed 2025-01-18 19:51:17.306594 | 2025-01-18 19:51:17.306716 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-18 19:51:17.637432 | ubuntu-noble | ok 2025-01-18 19:51:17.646098 | 2025-01-18 19:51:17.646216 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-18 19:51:18.936606 | ubuntu-noble | changed: 2025-01-18 19:51:18.936857 | ubuntu-noble | cd+++++++++ src/ 2025-01-18 19:51:18.936891 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-18 19:51:18.936955 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-18 19:51:18.936979 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-18 19:51:18.936999 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006839 2025-01-18 19:51:49.948692 | 2025-01-18 19:51:49.948949 | TASK [upload-logs : Upload logs to log server] 2025-01-18 19:51:50.580685 | localhost | Output suppressed because no_log was given 2025-01-18 19:51:50.583813 | 2025-01-18 19:51:50.583935 | LOOP [upload-logs : Compress console log and json output] 2025-01-18 19:51:50.665955 | localhost | skipping: Conditional result was False 2025-01-18 19:51:50.683405 | localhost | skipping: Conditional result was False 2025-01-18 19:51:50.691077 | 2025-01-18 19:51:50.691192 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-18 19:51:50.770872 | localhost | skipping: Conditional result was False 2025-01-18 19:51:50.771202 | 2025-01-18 19:51:50.784643 | localhost | skipping: Conditional result was False 2025-01-18 19:51:50.790849 | 2025-01-18 19:51:50.790992 | LOOP [upload-logs : Upload console log and json output]