2025-01-22 21:13:33.521056 | Job console starting... 2025-01-22 21:13:33.529747 | Updating repositories 2025-01-22 21:13:33.577717 | Preparing job workspace 2025-01-22 21:13:35.149481 | Running Ansible setup... 2025-01-22 21:13:40.402691 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-22 21:13:41.129811 | 2025-01-22 21:13:41.129975 | PLAY [Base pre] 2025-01-22 21:13:41.162403 | 2025-01-22 21:13:41.162679 | TASK [Setup log path fact] 2025-01-22 21:13:41.207281 | ubuntu-noble | ok 2025-01-22 21:13:41.233924 | 2025-01-22 21:13:41.234085 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 21:13:41.297646 | ubuntu-noble | ok 2025-01-22 21:13:41.306100 | 2025-01-22 21:13:41.306234 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 21:13:41.341471 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:41.349361 | 2025-01-22 21:13:41.349490 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 21:13:41.404897 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:41.419909 | 2025-01-22 21:13:41.420074 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-22 21:13:41.456087 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:41.467289 | 2025-01-22 21:13:41.467438 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-22 21:13:41.504512 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:41.522786 | 2025-01-22 21:13:41.522964 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-22 21:13:41.548982 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:41.571085 | 2025-01-22 21:13:41.571225 | TASK [emit-job-header : Print job information] 2025-01-22 21:13:41.641809 | # Job Information 2025-01-22 21:13:41.642069 | Ansible Version: 2.15.3 2025-01-22 21:13:41.642124 | Job: python-black 2025-01-22 21:13:41.642171 | Pipeline: check 2025-01-22 21:13:41.642206 | Executor: 7d211f194f6a 2025-01-22 21:13:41.642238 | Triggered by: https://github.com/osism/container-images-kolla/pull/534 2025-01-22 21:13:41.642270 | Event ID: b79e6650-d905-11ef-86e3-84215a4b2ecb 2025-01-22 21:13:41.651590 | 2025-01-22 21:13:41.651723 | LOOP [emit-job-header : Print node information] 2025-01-22 21:13:41.795153 | ubuntu-noble | ok: 2025-01-22 21:13:41.795351 | ubuntu-noble | # Node Information 2025-01-22 21:13:41.795386 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-22 21:13:41.795411 | ubuntu-noble | Hostname: ubuntu 2025-01-22 21:13:41.795433 | ubuntu-noble | Username: zuul 2025-01-22 21:13:41.795454 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-22 21:13:41.795474 | ubuntu-noble | Provider: regiocloud-a 2025-01-22 21:13:41.795495 | ubuntu-noble | Label: ubuntu-noble 2025-01-22 21:13:41.795514 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-22 21:13:41.795536 | ubuntu-noble | Interface IP: 81.163.193.166 2025-01-22 21:13:41.815902 | 2025-01-22 21:13:41.816044 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-22 21:13:42.318962 | ubuntu-noble -> localhost | changed 2025-01-22 21:13:42.338814 | 2025-01-22 21:13:42.338976 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-22 21:13:43.482354 | ubuntu-noble -> localhost | changed 2025-01-22 21:13:43.504031 | 2025-01-22 21:13:43.504178 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-22 21:13:43.797871 | ubuntu-noble -> localhost | ok 2025-01-22 21:13:43.808201 | 2025-01-22 21:13:43.808324 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-22 21:13:43.877449 | ubuntu-noble | ok 2025-01-22 21:13:43.899142 | ubuntu-noble | included: /var/lib/zuul/builds/d3f75d2c2b3e4290b7b45ca8b12d1c49/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-22 21:13:43.907997 | 2025-01-22 21:13:43.908111 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-22 21:13:44.771880 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-22 21:13:44.772285 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d3f75d2c2b3e4290b7b45ca8b12d1c49/work/d3f75d2c2b3e4290b7b45ca8b12d1c49_id_rsa 2025-01-22 21:13:44.772355 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d3f75d2c2b3e4290b7b45ca8b12d1c49/work/d3f75d2c2b3e4290b7b45ca8b12d1c49_id_rsa.pub 2025-01-22 21:13:44.772426 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-22 21:13:44.772468 | ubuntu-noble -> localhost | SHA256:xYcGjwgeBVMi5RLQYJkCyfWjWk9U5VapioD9U4SpoqY zuul-build-sshkey 2025-01-22 21:13:44.772506 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-22 21:13:44.772550 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-22 21:13:44.772588 | ubuntu-noble -> localhost | |***oB+=.o. .. | 2025-01-22 21:13:44.772623 | ubuntu-noble -> localhost | |++.=.B.o.=.o | 2025-01-22 21:13:44.772657 | ubuntu-noble -> localhost | |. + ++o .oB . | 2025-01-22 21:13:44.772690 | ubuntu-noble -> localhost | | o =o ...+ . | 2025-01-22 21:13:44.772722 | ubuntu-noble -> localhost | |. .oo.o S | 2025-01-22 21:13:44.772961 | ubuntu-noble -> localhost | |..o o+ . | 2025-01-22 21:13:44.773019 | ubuntu-noble -> localhost | |o. .. | 2025-01-22 21:13:44.773060 | ubuntu-noble -> localhost | |E | 2025-01-22 21:13:44.773097 | ubuntu-noble -> localhost | | | 2025-01-22 21:13:44.773133 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-22 21:13:44.773215 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.298710 2025-01-22 21:13:44.788407 | 2025-01-22 21:13:44.788527 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-22 21:13:44.869922 | ubuntu-noble | ok 2025-01-22 21:13:44.888303 | ubuntu-noble | included: /var/lib/zuul/builds/d3f75d2c2b3e4290b7b45ca8b12d1c49/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-22 21:13:44.899482 | 2025-01-22 21:13:44.899596 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-22 21:13:44.937195 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:44.950539 | 2025-01-22 21:13:44.950762 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-22 21:13:45.685850 | ubuntu-noble | changed 2025-01-22 21:13:45.694171 | 2025-01-22 21:13:45.694283 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-22 21:13:46.022669 | ubuntu-noble | ok 2025-01-22 21:13:46.034201 | 2025-01-22 21:13:46.034331 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-22 21:13:46.748464 | ubuntu-noble | changed 2025-01-22 21:13:46.762770 | 2025-01-22 21:13:46.762935 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-22 21:13:47.532223 | ubuntu-noble | changed 2025-01-22 21:13:47.543134 | 2025-01-22 21:13:47.543274 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-22 21:13:47.578656 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:47.591511 | 2025-01-22 21:13:47.591661 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-22 21:13:48.078583 | ubuntu-noble -> localhost | changed 2025-01-22 21:13:48.096881 | 2025-01-22 21:13:48.097121 | TASK [add-build-sshkey : Add back temp key] 2025-01-22 21:13:48.493516 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d3f75d2c2b3e4290b7b45ca8b12d1c49/work/d3f75d2c2b3e4290b7b45ca8b12d1c49_id_rsa (zuul-build-sshkey) 2025-01-22 21:13:48.493874 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.018980 2025-01-22 21:13:48.510214 | 2025-01-22 21:13:48.510472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-22 21:13:49.007617 | ubuntu-noble | ok 2025-01-22 21:13:49.014664 | 2025-01-22 21:13:49.014798 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-22 21:13:49.040559 | ubuntu-noble | skipping: Conditional result was False 2025-01-22 21:13:49.058539 | 2025-01-22 21:13:49.058668 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-22 21:13:49.530343 | ubuntu-noble | ok 2025-01-22 21:13:49.548104 | 2025-01-22 21:13:49.548233 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-22 21:13:49.597319 | ubuntu-noble | ok 2025-01-22 21:13:49.606665 | 2025-01-22 21:13:49.606834 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-22 21:13:49.938029 | ubuntu-noble -> localhost | ok 2025-01-22 21:13:49.957467 | 2025-01-22 21:13:49.957654 | TASK [validate-host : Collect information about the host] 2025-01-22 21:13:51.255639 | ubuntu-noble | ok 2025-01-22 21:13:51.274978 | 2025-01-22 21:13:51.275134 | TASK [validate-host : Sanitize hostname] 2025-01-22 21:13:51.363501 | ubuntu-noble | ok 2025-01-22 21:13:51.372935 | 2025-01-22 21:13:51.373331 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-22 21:13:52.163317 | ubuntu-noble -> localhost | changed 2025-01-22 21:13:52.170641 | 2025-01-22 21:13:52.170765 | TASK [validate-host : Collect information about zuul worker] 2025-01-22 21:13:52.700003 | ubuntu-noble | ok 2025-01-22 21:13:52.708903 | 2025-01-22 21:13:52.709031 | TASK [validate-host : Write out all zuul information for each host] 2025-01-22 21:13:53.345496 | ubuntu-noble -> localhost | changed 2025-01-22 21:13:53.358686 | 2025-01-22 21:13:53.358862 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-22 21:13:53.686609 | ubuntu-noble | ok 2025-01-22 21:13:53.697185 | 2025-01-22 21:13:53.697323 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-22 21:13:54.644969 | ubuntu-noble | changed: 2025-01-22 21:13:54.645204 | ubuntu-noble | cd+++++++++ src/ 2025-01-22 21:13:54.645251 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-22 21:13:54.645285 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-22 21:13:54.645316 | ubuntu-noble | cd+++++++++ src/github.com/osism/container-images-kolla/ 2025-01-22 21:13:54.645344 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008218 2025-01-22 21:14:27.557712 | 2025-01-22 21:14:27.557914 | TASK [upload-logs : Upload logs to log server] 2025-01-22 21:14:28.141263 | localhost | Output suppressed because no_log was given 2025-01-22 21:14:28.144972 | 2025-01-22 21:14:28.145103 | LOOP [upload-logs : Compress console log and json output] 2025-01-22 21:14:28.224185 | localhost | skipping: Conditional result was False 2025-01-22 21:14:28.247516 | localhost | skipping: Conditional result was False 2025-01-22 21:14:28.257743 | 2025-01-22 21:14:28.257907 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-22 21:14:28.342547 | localhost | skipping: Conditional result was False 2025-01-22 21:14:28.342920 | 2025-01-22 21:14:28.356619 | localhost | skipping: Conditional result was False 2025-01-22 21:14:28.370726 | 2025-01-22 21:14:28.370957 | LOOP [upload-logs : Upload console log and json output]