2025-03-21 18:35:26.089154 | Job console starting... 2025-03-21 18:35:26.100969 | Updating repositories 2025-03-21 18:35:26.132137 | Preparing job workspace 2025-03-21 18:35:27.644596 | Running Ansible setup... 2025-03-21 18:35:32.562018 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-21 18:35:33.311461 | 2025-03-21 18:35:33.311720 | PLAY [Base pre] 2025-03-21 18:35:33.340581 | 2025-03-21 18:35:33.340706 | TASK [Setup log path fact] 2025-03-21 18:35:33.371801 | ubuntu-noble | ok 2025-03-21 18:35:33.393715 | 2025-03-21 18:35:33.393880 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-21 18:35:33.443506 | ubuntu-noble | ok 2025-03-21 18:35:33.457273 | 2025-03-21 18:35:33.457387 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-21 18:35:33.494241 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:33.508169 | 2025-03-21 18:35:33.508309 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-21 18:35:33.563811 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:33.571988 | 2025-03-21 18:35:33.572145 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-21 18:35:33.588020 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:33.595733 | 2025-03-21 18:35:33.595860 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-21 18:35:33.620455 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:33.630574 | 2025-03-21 18:35:33.630686 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-21 18:35:33.655236 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:33.670771 | 2025-03-21 18:35:33.670906 | TASK [emit-job-header : Print job information] 2025-03-21 18:35:33.738639 | # Job Information 2025-03-21 18:35:33.738938 | Ansible Version: 2.15.3 2025-03-21 18:35:33.738999 | Job: yamllint 2025-03-21 18:35:33.739052 | Pipeline: check 2025-03-21 18:35:33.739088 | Executor: 7d211f194f6a 2025-03-21 18:35:33.739118 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-21 18:35:33.739147 | Event ID: 212b3e90-0683-11f0-88f4-a9da1fe16820 2025-03-21 18:35:33.747884 | 2025-03-21 18:35:33.748008 | LOOP [emit-job-header : Print node information] 2025-03-21 18:35:33.905134 | ubuntu-noble | ok: 2025-03-21 18:35:33.905318 | ubuntu-noble | # Node Information 2025-03-21 18:35:33.905353 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-21 18:35:33.905379 | ubuntu-noble | Hostname: ubuntu 2025-03-21 18:35:33.905402 | ubuntu-noble | Username: zuul 2025-03-21 18:35:33.905423 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-21 18:35:33.905443 | ubuntu-noble | Provider: regiocloud-a 2025-03-21 18:35:33.905463 | ubuntu-noble | Label: ubuntu-noble 2025-03-21 18:35:33.905482 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-21 18:35:33.905502 | ubuntu-noble | Interface IP: 81.163.192.114 2025-03-21 18:35:33.929403 | 2025-03-21 18:35:33.929530 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-21 18:35:34.386226 | ubuntu-noble -> localhost | changed 2025-03-21 18:35:34.395125 | 2025-03-21 18:35:34.395243 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-21 18:35:35.498968 | ubuntu-noble -> localhost | changed 2025-03-21 18:35:35.520258 | 2025-03-21 18:35:35.520383 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-21 18:35:35.872026 | ubuntu-noble -> localhost | ok 2025-03-21 18:35:35.881618 | 2025-03-21 18:35:35.881734 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-21 18:35:35.912422 | ubuntu-noble | ok 2025-03-21 18:35:35.929271 | ubuntu-noble | included: /var/lib/zuul/builds/3862ecdc432648c5805da63502f467b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-21 18:35:35.937374 | 2025-03-21 18:35:35.937475 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-21 18:35:36.757606 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-21 18:35:36.758476 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/3862ecdc432648c5805da63502f467b6/work/3862ecdc432648c5805da63502f467b6_id_rsa 2025-03-21 18:35:36.758569 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/3862ecdc432648c5805da63502f467b6/work/3862ecdc432648c5805da63502f467b6_id_rsa.pub 2025-03-21 18:35:36.758625 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-21 18:35:36.758738 | ubuntu-noble -> localhost | SHA256:qRDA6Zm4YwqcETYWsRiKI9t0NEDpluZBOZcIH3V94i4 zuul-build-sshkey 2025-03-21 18:35:36.758789 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-21 18:35:36.758865 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-21 18:35:36.758913 | ubuntu-noble -> localhost | |o*BB+... | 2025-03-21 18:35:36.758957 | ubuntu-noble -> localhost | |+BX+oo o . | 2025-03-21 18:35:36.758999 | ubuntu-noble -> localhost | |O*=*o . o | 2025-03-21 18:35:36.759040 | ubuntu-noble -> localhost | |o*X. . .. | 2025-03-21 18:35:36.759080 | ubuntu-noble -> localhost | |o=+.. .S | 2025-03-21 18:35:36.759119 | ubuntu-noble -> localhost | |++. .E.. | 2025-03-21 18:35:36.759159 | ubuntu-noble -> localhost | |+. .. | 2025-03-21 18:35:36.759202 | ubuntu-noble -> localhost | |. | 2025-03-21 18:35:36.759244 | ubuntu-noble -> localhost | | | 2025-03-21 18:35:36.759339 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-21 18:35:36.759452 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.295799 2025-03-21 18:35:36.774508 | 2025-03-21 18:35:36.774631 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-21 18:35:36.808382 | ubuntu-noble | ok 2025-03-21 18:35:36.820684 | ubuntu-noble | included: /var/lib/zuul/builds/3862ecdc432648c5805da63502f467b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-21 18:35:36.831171 | 2025-03-21 18:35:36.831274 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-21 18:35:36.855852 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:36.863433 | 2025-03-21 18:35:36.863648 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-21 18:35:37.574731 | ubuntu-noble | changed 2025-03-21 18:35:37.582193 | 2025-03-21 18:35:37.582317 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-21 18:35:37.870800 | ubuntu-noble | ok 2025-03-21 18:35:37.878720 | 2025-03-21 18:35:37.878851 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-21 18:35:38.654915 | ubuntu-noble | changed 2025-03-21 18:35:38.664737 | 2025-03-21 18:35:38.664912 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-21 18:35:39.455379 | ubuntu-noble | changed 2025-03-21 18:35:39.466094 | 2025-03-21 18:35:39.466235 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-21 18:35:39.492309 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:39.508432 | 2025-03-21 18:35:39.508557 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-21 18:35:40.009370 | ubuntu-noble -> localhost | changed 2025-03-21 18:35:40.036972 | 2025-03-21 18:35:40.037116 | TASK [add-build-sshkey : Add back temp key] 2025-03-21 18:35:40.439605 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/3862ecdc432648c5805da63502f467b6/work/3862ecdc432648c5805da63502f467b6_id_rsa (zuul-build-sshkey) 2025-03-21 18:35:40.440172 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.017157 2025-03-21 18:35:40.470976 | 2025-03-21 18:35:40.471105 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-21 18:35:40.935569 | ubuntu-noble | ok 2025-03-21 18:35:40.944172 | 2025-03-21 18:35:40.944294 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-21 18:35:40.981983 | ubuntu-noble | skipping: Conditional result was False 2025-03-21 18:35:41.006882 | 2025-03-21 18:35:41.007023 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-21 18:35:41.472176 | ubuntu-noble | ok 2025-03-21 18:35:41.489100 | 2025-03-21 18:35:41.489216 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-21 18:35:41.542336 | ubuntu-noble | ok 2025-03-21 18:35:41.552689 | 2025-03-21 18:35:41.552801 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-21 18:35:41.929436 | ubuntu-noble -> localhost | ok 2025-03-21 18:35:41.944315 | 2025-03-21 18:35:41.944482 | TASK [validate-host : Collect information about the host] 2025-03-21 18:35:43.200236 | ubuntu-noble | ok 2025-03-21 18:35:43.214125 | 2025-03-21 18:35:43.214261 | TASK [validate-host : Sanitize hostname] 2025-03-21 18:35:43.300990 | ubuntu-noble | ok 2025-03-21 18:35:43.307210 | 2025-03-21 18:35:43.307322 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-21 18:35:43.839139 | ubuntu-noble -> localhost | changed 2025-03-21 18:35:43.846502 | 2025-03-21 18:35:43.846617 | TASK [validate-host : Collect information about zuul worker] 2025-03-21 18:35:44.328373 | ubuntu-noble | ok 2025-03-21 18:35:44.338188 | 2025-03-21 18:35:44.338320 | TASK [validate-host : Write out all zuul information for each host] 2025-03-21 18:35:44.895212 | ubuntu-noble -> localhost | changed 2025-03-21 18:35:44.908473 | 2025-03-21 18:35:44.908638 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-21 18:35:45.208792 | ubuntu-noble | ok 2025-03-21 18:35:45.218878 | 2025-03-21 18:35:45.219005 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-21 18:35:46.504909 | ubuntu-noble | changed: 2025-03-21 18:35:46.505102 | ubuntu-noble | cd+++++++++ src/ 2025-03-21 18:35:46.505136 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-21 18:35:46.505160 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-21 18:35:46.505182 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-21 18:35:46.505202 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006850 2025-03-21 18:36:20.569049 | 2025-03-21 18:36:20.569171 | TASK [upload-logs : Upload logs to log server] 2025-03-21 18:36:21.105997 | localhost | Output suppressed because no_log was given 2025-03-21 18:36:21.110755 | 2025-03-21 18:36:21.110910 | LOOP [upload-logs : Compress console log and json output] 2025-03-21 18:36:21.175064 | localhost | skipping: Conditional result was False 2025-03-21 18:36:21.193018 | localhost | skipping: Conditional result was False 2025-03-21 18:36:21.207042 | 2025-03-21 18:36:21.207228 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-21 18:36:21.270452 | localhost | skipping: Conditional result was False 2025-03-21 18:36:21.270752 | 2025-03-21 18:36:21.297514 | localhost | skipping: Conditional result was False 2025-03-21 18:36:21.315520 | 2025-03-21 18:36:21.315711 | LOOP [upload-logs : Upload console log and json output]