2025-01-10 16:48:58.747261 | Job console starting... 2025-01-10 16:48:58.770282 | Updating repositories 2025-01-10 16:48:58.810623 | Preparing job workspace 2025-01-10 16:49:00.666158 | Running Ansible setup... 2025-01-10 16:49:06.020487 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-10 16:49:06.769388 | 2025-01-10 16:49:06.769574 | PLAY [Base pre] 2025-01-10 16:49:06.814199 | 2025-01-10 16:49:06.814372 | TASK [Setup log path fact] 2025-01-10 16:49:06.856912 | ubuntu-noble | ok 2025-01-10 16:49:06.899407 | 2025-01-10 16:49:06.899606 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-10 16:49:06.951860 | ubuntu-noble | ok 2025-01-10 16:49:06.961409 | 2025-01-10 16:49:06.961546 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-10 16:49:07.017337 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.024996 | 2025-01-10 16:49:07.025153 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-10 16:49:07.099171 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.107726 | 2025-01-10 16:49:07.107871 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-10 16:49:07.156433 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.165458 | 2025-01-10 16:49:07.178063 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-10 16:49:07.204209 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.213271 | 2025-01-10 16:49:07.213424 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-10 16:49:07.250000 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:07.266289 | 2025-01-10 16:49:07.266418 | TASK [emit-job-header : Print job information] 2025-01-10 16:49:07.340220 | # Job Information 2025-01-10 16:49:07.340409 | Ansible Version: 2.15.3 2025-01-10 16:49:07.340441 | Job: flake8 2025-01-10 16:49:07.340468 | Pipeline: check 2025-01-10 16:49:07.340489 | Executor: 7d211f194f6a 2025-01-10 16:49:07.340508 | Triggered by: https://github.com/osism/testbed/pull/2577 2025-01-10 16:49:07.340527 | Event ID: c43d2e60-cf72-11ef-9671-e6a74987f0d2 2025-01-10 16:49:07.347290 | 2025-01-10 16:49:07.347404 | LOOP [emit-job-header : Print node information] 2025-01-10 16:49:07.513464 | ubuntu-noble | ok: 2025-01-10 16:49:07.513693 | ubuntu-noble | # Node Information 2025-01-10 16:49:07.513729 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-10 16:49:07.513754 | ubuntu-noble | Hostname: ubuntu 2025-01-10 16:49:07.513775 | ubuntu-noble | Username: zuul 2025-01-10 16:49:07.513795 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-10 16:49:07.513815 | ubuntu-noble | Provider: regiocloud-a 2025-01-10 16:49:07.513833 | ubuntu-noble | Label: ubuntu-noble 2025-01-10 16:49:07.513852 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-10 16:49:07.513873 | ubuntu-noble | Interface IP: 81.163.193.154 2025-01-10 16:49:07.530472 | 2025-01-10 16:49:07.530619 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-10 16:49:08.089057 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:08.099522 | 2025-01-10 16:49:08.099652 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-10 16:49:09.304222 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:09.317548 | 2025-01-10 16:49:09.317646 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-10 16:49:09.555316 | ubuntu-noble -> localhost | ok 2025-01-10 16:49:09.562556 | 2025-01-10 16:49:09.562636 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-10 16:49:09.590692 | ubuntu-noble | ok 2025-01-10 16:49:09.603624 | ubuntu-noble | included: /var/lib/zuul/builds/ca5ca7ceab524f07b5b7d260e8b90047/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-10 16:49:09.609717 | 2025-01-10 16:49:09.609784 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-10 16:49:10.252971 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-10 16:49:10.253216 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ca5ca7ceab524f07b5b7d260e8b90047/work/ca5ca7ceab524f07b5b7d260e8b90047_id_rsa 2025-01-10 16:49:10.253255 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ca5ca7ceab524f07b5b7d260e8b90047/work/ca5ca7ceab524f07b5b7d260e8b90047_id_rsa.pub 2025-01-10 16:49:10.253280 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-10 16:49:10.253302 | ubuntu-noble -> localhost | SHA256:14arqW8Tq4LIQA/6VhI4DpcTccZ99A3SqciCG6LPIdE zuul-build-sshkey 2025-01-10 16:49:10.253323 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-10 16:49:10.253349 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-10 16:49:10.253370 | ubuntu-noble -> localhost | | .oo. .o... | 2025-01-10 16:49:10.253390 | ubuntu-noble -> localhost | | .o. . .ooo | 2025-01-10 16:49:10.253409 | ubuntu-noble -> localhost | | o + . o .. . | 2025-01-10 16:49:10.253429 | ubuntu-noble -> localhost | |*oE . o . o | 2025-01-10 16:49:10.253447 | ubuntu-noble -> localhost | |*=o= . S o o | 2025-01-10 16:49:10.253467 | ubuntu-noble -> localhost | |=.+.. .. o | 2025-01-10 16:49:10.253486 | ubuntu-noble -> localhost | |o* = o. | 2025-01-10 16:49:10.253506 | ubuntu-noble -> localhost | |..* . +o | 2025-01-10 16:49:10.253526 | ubuntu-noble -> localhost | | . .o=+. | 2025-01-10 16:49:10.253545 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-10 16:49:10.253591 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.219852 2025-01-10 16:49:10.268356 | 2025-01-10 16:49:10.268473 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-10 16:49:10.299123 | ubuntu-noble | ok 2025-01-10 16:49:10.309860 | ubuntu-noble | included: /var/lib/zuul/builds/ca5ca7ceab524f07b5b7d260e8b90047/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-10 16:49:10.318991 | 2025-01-10 16:49:10.319075 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-10 16:49:10.342601 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:10.349527 | 2025-01-10 16:49:10.349609 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-10 16:49:11.067548 | ubuntu-noble | changed 2025-01-10 16:49:11.076520 | 2025-01-10 16:49:11.076623 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-10 16:49:11.410527 | ubuntu-noble | ok 2025-01-10 16:49:11.417387 | 2025-01-10 16:49:11.417478 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-10 16:49:12.177956 | ubuntu-noble | changed 2025-01-10 16:49:12.191549 | 2025-01-10 16:49:12.191784 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-10 16:49:12.895429 | ubuntu-noble | changed 2025-01-10 16:49:12.902173 | 2025-01-10 16:49:12.902265 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-10 16:49:12.926593 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:12.934018 | 2025-01-10 16:49:12.934130 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-10 16:49:13.376564 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:13.390020 | 2025-01-10 16:49:13.390132 | TASK [add-build-sshkey : Add back temp key] 2025-01-10 16:49:13.736400 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/ca5ca7ceab524f07b5b7d260e8b90047/work/ca5ca7ceab524f07b5b7d260e8b90047_id_rsa (zuul-build-sshkey) 2025-01-10 16:49:13.736623 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.020888 2025-01-10 16:49:13.744065 | 2025-01-10 16:49:13.744179 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-10 16:49:14.184274 | ubuntu-noble | ok 2025-01-10 16:49:14.191218 | 2025-01-10 16:49:14.191306 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-10 16:49:14.227071 | ubuntu-noble | skipping: Conditional result was False 2025-01-10 16:49:14.240557 | 2025-01-10 16:49:14.240656 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-10 16:49:14.649157 | ubuntu-noble | ok 2025-01-10 16:49:14.663353 | 2025-01-10 16:49:14.663445 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-10 16:49:14.693211 | ubuntu-noble | ok 2025-01-10 16:49:14.699618 | 2025-01-10 16:49:14.699698 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-10 16:49:14.957152 | ubuntu-noble -> localhost | ok 2025-01-10 16:49:14.964958 | 2025-01-10 16:49:14.965053 | TASK [validate-host : Collect information about the host] 2025-01-10 16:49:16.158715 | ubuntu-noble | ok 2025-01-10 16:49:16.171052 | 2025-01-10 16:49:16.171174 | TASK [validate-host : Sanitize hostname] 2025-01-10 16:49:16.241577 | ubuntu-noble | ok 2025-01-10 16:49:16.247516 | 2025-01-10 16:49:16.247605 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-10 16:49:16.774429 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:16.781584 | 2025-01-10 16:49:16.781680 | TASK [validate-host : Collect information about zuul worker] 2025-01-10 16:49:17.275984 | ubuntu-noble | ok 2025-01-10 16:49:17.282874 | 2025-01-10 16:49:17.282992 | TASK [validate-host : Write out all zuul information for each host] 2025-01-10 16:49:17.855483 | ubuntu-noble -> localhost | changed 2025-01-10 16:49:17.871423 | 2025-01-10 16:49:17.871553 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-10 16:49:18.200552 | ubuntu-noble | ok 2025-01-10 16:49:18.208094 | 2025-01-10 16:49:18.218041 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-10 16:49:19.379833 | ubuntu-noble | changed: 2025-01-10 16:49:19.380079 | ubuntu-noble | cd+++++++++ src/ 2025-01-10 16:49:19.380130 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-10 16:49:19.380155 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-10 16:49:19.380177 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-10 16:49:19.380198 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008160 2025-01-10 16:49:54.457484 | 2025-01-10 16:49:54.457677 | TASK [upload-logs : Upload logs to log server] 2025-01-10 16:49:55.048465 | localhost | Output suppressed because no_log was given 2025-01-10 16:49:55.051907 | 2025-01-10 16:49:55.052024 | LOOP [upload-logs : Compress console log and json output] 2025-01-10 16:49:55.128657 | localhost | skipping: Conditional result was False 2025-01-10 16:49:55.146989 | localhost | skipping: Conditional result was False 2025-01-10 16:49:55.158403 | 2025-01-10 16:49:55.158614 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-10 16:49:55.223208 | localhost | skipping: Conditional result was False 2025-01-10 16:49:55.223531 | 2025-01-10 16:49:55.236422 | localhost | skipping: Conditional result was False 2025-01-10 16:49:55.251262 | 2025-01-10 16:49:55.251421 | LOOP [upload-logs : Upload console log and json output]