2025-03-14 15:33:35.663488 | Job console starting... 2025-03-14 15:33:35.674508 | Updating repositories 2025-03-14 15:33:35.727157 | Preparing job workspace 2025-03-14 15:33:37.844848 | Running Ansible setup... 2025-03-14 15:33:43.852238 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-14 15:33:44.906115 | 2025-03-14 15:33:44.906376 | PLAY [Base pre] 2025-03-14 15:33:44.944122 | 2025-03-14 15:33:44.944271 | TASK [Setup log path fact] 2025-03-14 15:33:44.989540 | ubuntu-noble | ok 2025-03-14 15:33:45.028477 | 2025-03-14 15:33:45.028665 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-14 15:33:45.082716 | ubuntu-noble | ok 2025-03-14 15:33:45.091198 | 2025-03-14 15:33:45.091322 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-14 15:33:45.129551 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:45.138698 | 2025-03-14 15:33:45.138828 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-14 15:33:45.243645 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:45.289131 | 2025-03-14 15:33:45.289709 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-14 15:33:45.363775 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:45.384352 | 2025-03-14 15:33:45.384498 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-14 15:33:45.429892 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:45.446052 | 2025-03-14 15:33:45.446151 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-14 15:33:45.480988 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:45.501422 | 2025-03-14 15:33:45.501916 | TASK [emit-job-header : Print job information] 2025-03-14 15:33:45.577064 | # Job Information 2025-03-14 15:33:45.577201 | Ansible Version: 2.15.3 2025-03-14 15:33:45.577230 | Job: yamllint 2025-03-14 15:33:45.577255 | Pipeline: check 2025-03-14 15:33:45.577274 | Executor: 7d211f194f6a 2025-03-14 15:33:45.577290 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-14 15:33:45.577318 | Event ID: ac6dc3a0-00e9-11f0-927b-59bd5e151cc7 2025-03-14 15:33:45.587615 | 2025-03-14 15:33:45.587719 | LOOP [emit-job-header : Print node information] 2025-03-14 15:33:45.755037 | ubuntu-noble | ok: 2025-03-14 15:33:45.755307 | ubuntu-noble | # Node Information 2025-03-14 15:33:45.755363 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-14 15:33:45.755387 | ubuntu-noble | Hostname: ubuntu 2025-03-14 15:33:45.755406 | ubuntu-noble | Username: zuul 2025-03-14 15:33:45.755423 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-14 15:33:45.755439 | ubuntu-noble | Provider: regiocloud-a 2025-03-14 15:33:45.755462 | ubuntu-noble | Label: ubuntu-noble 2025-03-14 15:33:45.755531 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-14 15:33:45.755551 | ubuntu-noble | Interface IP: 81.163.193.161 2025-03-14 15:33:45.835615 | 2025-03-14 15:33:45.836603 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-14 15:33:46.747016 | ubuntu-noble -> localhost | changed 2025-03-14 15:33:46.756145 | 2025-03-14 15:33:46.756242 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-14 15:33:48.067210 | ubuntu-noble -> localhost | changed 2025-03-14 15:33:48.089297 | 2025-03-14 15:33:48.089404 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-14 15:33:48.446011 | ubuntu-noble -> localhost | ok 2025-03-14 15:33:48.451894 | 2025-03-14 15:33:48.451971 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-14 15:33:48.498668 | ubuntu-noble | ok 2025-03-14 15:33:48.526300 | ubuntu-noble | included: /var/lib/zuul/builds/d7fcd22280d54a38b1b47824245b8861/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-14 15:33:48.536752 | 2025-03-14 15:33:48.536841 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-14 15:33:49.345164 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-14 15:33:49.345319 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d7fcd22280d54a38b1b47824245b8861/work/d7fcd22280d54a38b1b47824245b8861_id_rsa 2025-03-14 15:33:49.345351 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d7fcd22280d54a38b1b47824245b8861/work/d7fcd22280d54a38b1b47824245b8861_id_rsa.pub 2025-03-14 15:33:49.345373 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-14 15:33:49.345392 | ubuntu-noble -> localhost | SHA256:UyAqbIVsQs1xU0VavM0TDQa/ZD9P6hUWUvC3pVCMavE zuul-build-sshkey 2025-03-14 15:33:49.345411 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-14 15:33:49.345431 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-14 15:33:49.345448 | ubuntu-noble -> localhost | |.oooooo.==.oo+o. | 2025-03-14 15:33:49.345465 | ubuntu-noble -> localhost | |..++....oo+..o+ | 2025-03-14 15:33:49.345481 | ubuntu-noble -> localhost | | o+ . . =Bo. oo| 2025-03-14 15:33:49.345497 | ubuntu-noble -> localhost | | . . o=+E...=| 2025-03-14 15:33:49.345513 | ubuntu-noble -> localhost | | S. ..o.= | 2025-03-14 15:33:49.345528 | ubuntu-noble -> localhost | | . * .| 2025-03-14 15:33:49.345544 | ubuntu-noble -> localhost | | . o | 2025-03-14 15:33:49.345572 | ubuntu-noble -> localhost | | . . | 2025-03-14 15:33:49.345589 | ubuntu-noble -> localhost | | . | 2025-03-14 15:33:49.345605 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-14 15:33:49.345644 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.387323 2025-03-14 15:33:49.352762 | 2025-03-14 15:33:49.352837 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-14 15:33:49.385794 | ubuntu-noble | ok 2025-03-14 15:33:49.402611 | ubuntu-noble | included: /var/lib/zuul/builds/d7fcd22280d54a38b1b47824245b8861/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-14 15:33:49.413916 | 2025-03-14 15:33:49.414001 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-14 15:33:49.439084 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:49.447401 | 2025-03-14 15:33:49.447489 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-14 15:33:50.096646 | ubuntu-noble | changed 2025-03-14 15:33:50.102198 | 2025-03-14 15:33:50.102271 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-14 15:33:50.406176 | ubuntu-noble | ok 2025-03-14 15:33:50.414534 | 2025-03-14 15:33:50.414654 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-14 15:33:51.144259 | ubuntu-noble | ok: file already exists 2025-03-14 15:33:51.154829 | 2025-03-14 15:33:51.154927 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-14 15:33:51.893080 | ubuntu-noble | changed 2025-03-14 15:33:51.899748 | 2025-03-14 15:33:51.899837 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-14 15:33:51.923772 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:51.932026 | 2025-03-14 15:33:51.932119 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-14 15:33:52.478229 | ubuntu-noble -> localhost | changed 2025-03-14 15:33:52.500221 | 2025-03-14 15:33:52.500422 | TASK [add-build-sshkey : Add back temp key] 2025-03-14 15:33:52.956934 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d7fcd22280d54a38b1b47824245b8861/work/d7fcd22280d54a38b1b47824245b8861_id_rsa (zuul-build-sshkey) 2025-03-14 15:33:52.957256 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011424 2025-03-14 15:33:53.002997 | 2025-03-14 15:33:53.003102 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-14 15:33:53.461424 | ubuntu-noble | ok 2025-03-14 15:33:53.468502 | 2025-03-14 15:33:53.468620 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-14 15:33:53.492184 | ubuntu-noble | skipping: Conditional result was False 2025-03-14 15:33:53.505778 | 2025-03-14 15:33:53.505862 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-14 15:33:53.945379 | ubuntu-noble | ok 2025-03-14 15:33:53.959387 | 2025-03-14 15:33:53.959481 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-14 15:33:53.999966 | ubuntu-noble | ok 2025-03-14 15:33:54.007214 | 2025-03-14 15:33:54.007298 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-14 15:33:54.265692 | ubuntu-noble -> localhost | ok 2025-03-14 15:33:54.278016 | 2025-03-14 15:33:54.278201 | TASK [validate-host : Collect information about the host] 2025-03-14 15:33:55.563539 | ubuntu-noble | ok 2025-03-14 15:33:55.580049 | 2025-03-14 15:33:55.580147 | TASK [validate-host : Sanitize hostname] 2025-03-14 15:33:55.644916 | ubuntu-noble | ok 2025-03-14 15:33:55.653714 | 2025-03-14 15:33:55.653828 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-14 15:33:56.278878 | ubuntu-noble -> localhost | changed 2025-03-14 15:33:56.286243 | 2025-03-14 15:33:56.286382 | TASK [validate-host : Collect information about zuul worker] 2025-03-14 15:33:56.874183 | ubuntu-noble | ok 2025-03-14 15:33:56.880672 | 2025-03-14 15:33:56.880748 | TASK [validate-host : Write out all zuul information for each host] 2025-03-14 15:33:57.353983 | ubuntu-noble -> localhost | changed 2025-03-14 15:33:57.369414 | 2025-03-14 15:33:57.369679 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-14 15:33:57.735745 | ubuntu-noble | ok 2025-03-14 15:33:57.773975 | 2025-03-14 15:33:57.775081 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-14 15:33:59.156269 | ubuntu-noble | changed: 2025-03-14 15:33:59.160543 | ubuntu-noble | cd+++++++++ src/ 2025-03-14 15:33:59.160623 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-14 15:33:59.160654 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-14 15:33:59.160677 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-14 15:33:59.160697 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007926 2025-03-14 15:34:35.942296 | 2025-03-14 15:34:35.942437 | TASK [upload-logs : Upload logs to log server] 2025-03-14 15:34:36.595195 | localhost | Output suppressed because no_log was given 2025-03-14 15:34:36.600364 | 2025-03-14 15:34:36.600508 | LOOP [upload-logs : Compress console log and json output] 2025-03-14 15:34:36.711519 | localhost | skipping: Conditional result was False 2025-03-14 15:34:36.730871 | localhost | skipping: Conditional result was False 2025-03-14 15:34:36.739786 | 2025-03-14 15:34:36.739954 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-14 15:34:36.804750 | localhost | skipping: Conditional result was False 2025-03-14 15:34:36.805037 | 2025-03-14 15:34:36.819424 | localhost | skipping: Conditional result was False 2025-03-14 15:34:36.830941 | 2025-03-14 15:34:36.831197 | LOOP [upload-logs : Upload console log and json output]