2025-02-25 19:16:19.836669 | Job console starting... 2025-02-25 19:16:19.873498 | Updating repositories 2025-02-25 19:16:19.928373 | Preparing job workspace 2025-02-25 19:16:21.475498 | Running Ansible setup... 2025-02-25 19:16:28.456729 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 19:16:29.264671 | 2025-02-25 19:16:29.264785 | PLAY [Base pre] 2025-02-25 19:16:29.289087 | 2025-02-25 19:16:29.289196 | TASK [Setup log path fact] 2025-02-25 19:16:29.329691 | ubuntu-noble | ok 2025-02-25 19:16:29.348155 | 2025-02-25 19:16:29.348265 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 19:16:29.439135 | ubuntu-noble | ok 2025-02-25 19:16:29.445904 | 2025-02-25 19:16:29.445993 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 19:16:29.531584 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:29.537662 | 2025-02-25 19:16:29.537755 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 19:16:29.644711 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:29.651373 | 2025-02-25 19:16:29.651465 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 19:16:29.699200 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:29.705614 | 2025-02-25 19:16:29.705710 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 19:16:29.751153 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:29.760161 | 2025-02-25 19:16:29.760255 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 19:16:29.817057 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:29.833168 | 2025-02-25 19:16:29.833319 | TASK [emit-job-header : Print job information] 2025-02-25 19:16:29.889218 | # Job Information 2025-02-25 19:16:29.889412 | Ansible Version: 2.15.3 2025-02-25 19:16:29.889442 | Job: flake8 2025-02-25 19:16:29.889471 | Pipeline: check 2025-02-25 19:16:29.889501 | Executor: 7d211f194f6a 2025-02-25 19:16:29.889746 | Triggered by: https://github.com/osism/testbed/pull/2613 2025-02-25 19:16:29.889797 | Event ID: de8928b0-f3ac-11ef-8a5b-b160ce8682cc 2025-02-25 19:16:29.898283 | 2025-02-25 19:16:29.898372 | LOOP [emit-job-header : Print node information] 2025-02-25 19:16:30.078788 | ubuntu-noble | ok: 2025-02-25 19:16:30.078923 | ubuntu-noble | # Node Information 2025-02-25 19:16:30.078979 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 19:16:30.079001 | ubuntu-noble | Hostname: ubuntu 2025-02-25 19:16:30.079019 | ubuntu-noble | Username: zuul 2025-02-25 19:16:30.079035 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 19:16:30.079051 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 19:16:30.079066 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 19:16:30.079081 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 19:16:30.079098 | ubuntu-noble | Interface IP: 81.163.192.81 2025-02-25 19:16:30.106127 | 2025-02-25 19:16:30.106229 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 19:16:31.328341 | ubuntu-noble -> localhost | changed 2025-02-25 19:16:31.335164 | 2025-02-25 19:16:31.335250 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 19:16:32.922947 | ubuntu-noble -> localhost | changed 2025-02-25 19:16:32.943999 | 2025-02-25 19:16:32.944093 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 19:16:33.718103 | ubuntu-noble -> localhost | ok 2025-02-25 19:16:33.724040 | 2025-02-25 19:16:33.724126 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 19:16:33.769460 | ubuntu-noble | ok 2025-02-25 19:16:33.782302 | ubuntu-noble | included: /var/lib/zuul/builds/a8db3d1e92674e1fb9631565a0529637/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 19:16:33.812018 | 2025-02-25 19:16:33.812108 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 19:16:35.356509 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 19:16:35.356704 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8db3d1e92674e1fb9631565a0529637/work/a8db3d1e92674e1fb9631565a0529637_id_rsa 2025-02-25 19:16:35.356739 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8db3d1e92674e1fb9631565a0529637/work/a8db3d1e92674e1fb9631565a0529637_id_rsa.pub 2025-02-25 19:16:35.356763 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 19:16:35.356785 | ubuntu-noble -> localhost | SHA256:64mVyePC0w9faZumx1FpBjbFbsRnTZmwOrL8cw4SxqM zuul-build-sshkey 2025-02-25 19:16:35.356806 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 19:16:35.356830 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 19:16:35.356851 | ubuntu-noble -> localhost | | =o.=| 2025-02-25 19:16:35.356871 | ubuntu-noble -> localhost | | + =o+| 2025-02-25 19:16:35.356890 | ubuntu-noble -> localhost | | . * + | 2025-02-25 19:16:35.356908 | ubuntu-noble -> localhost | | . . B | 2025-02-25 19:16:35.356926 | ubuntu-noble -> localhost | | S* o = | 2025-02-25 19:16:35.356944 | ubuntu-noble -> localhost | | .++= o. | 2025-02-25 19:16:35.356963 | ubuntu-noble -> localhost | | . EO+ o+. | 2025-02-25 19:16:35.356982 | ubuntu-noble -> localhost | | +=.=o+=+ | 2025-02-25 19:16:35.357001 | ubuntu-noble -> localhost | | .o+.+=*. | 2025-02-25 19:16:35.357020 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 19:16:35.357066 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.633579 2025-02-25 19:16:35.364652 | 2025-02-25 19:16:35.364752 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 19:16:35.394347 | ubuntu-noble | ok 2025-02-25 19:16:35.409859 | ubuntu-noble | included: /var/lib/zuul/builds/a8db3d1e92674e1fb9631565a0529637/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 19:16:35.429785 | 2025-02-25 19:16:35.429877 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 19:16:35.463574 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:35.469522 | 2025-02-25 19:16:35.469627 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 19:16:36.229421 | ubuntu-noble | changed 2025-02-25 19:16:36.240942 | 2025-02-25 19:16:36.241042 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 19:16:36.566420 | ubuntu-noble | ok 2025-02-25 19:16:36.577289 | 2025-02-25 19:16:36.577413 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 19:16:37.387379 | ubuntu-noble | changed 2025-02-25 19:16:37.395018 | 2025-02-25 19:16:37.395104 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 19:16:38.164911 | ubuntu-noble | changed 2025-02-25 19:16:38.171644 | 2025-02-25 19:16:38.171729 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 19:16:38.195201 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:38.230692 | 2025-02-25 19:16:38.230874 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 19:16:38.629979 | ubuntu-noble -> localhost | changed 2025-02-25 19:16:38.641018 | 2025-02-25 19:16:38.641100 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 19:16:38.999427 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a8db3d1e92674e1fb9631565a0529637/work/a8db3d1e92674e1fb9631565a0529637_id_rsa (zuul-build-sshkey) 2025-02-25 19:16:38.999626 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009387 2025-02-25 19:16:39.005801 | 2025-02-25 19:16:39.005885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 19:16:39.536578 | ubuntu-noble | ok 2025-02-25 19:16:39.544133 | 2025-02-25 19:16:39.544228 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 19:16:39.568503 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 19:16:39.584594 | 2025-02-25 19:16:39.584704 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 19:16:40.064033 | ubuntu-noble | ok 2025-02-25 19:16:40.076044 | 2025-02-25 19:16:40.076153 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 19:16:40.106421 | ubuntu-noble | ok 2025-02-25 19:16:40.114038 | 2025-02-25 19:16:40.114128 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 19:16:40.381702 | ubuntu-noble -> localhost | ok 2025-02-25 19:16:40.389689 | 2025-02-25 19:16:40.389788 | TASK [validate-host : Collect information about the host] 2025-02-25 19:16:41.612174 | ubuntu-noble | ok 2025-02-25 19:16:41.622517 | 2025-02-25 19:16:41.622608 | TASK [validate-host : Sanitize hostname] 2025-02-25 19:16:41.682147 | ubuntu-noble | ok 2025-02-25 19:16:41.688236 | 2025-02-25 19:16:41.688329 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 19:16:42.230105 | ubuntu-noble -> localhost | changed 2025-02-25 19:16:42.236662 | 2025-02-25 19:16:42.236754 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 19:16:42.702138 | ubuntu-noble | ok 2025-02-25 19:16:42.707105 | 2025-02-25 19:16:42.707188 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 19:16:43.107204 | ubuntu-noble -> localhost | changed 2025-02-25 19:16:43.126814 | 2025-02-25 19:16:43.126913 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 19:16:43.477431 | ubuntu-noble | ok 2025-02-25 19:16:43.484134 | 2025-02-25 19:16:43.484229 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 19:16:44.853396 | ubuntu-noble | changed: 2025-02-25 19:16:44.853593 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 19:16:44.853629 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 19:16:44.853666 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 19:16:44.853696 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-02-25 19:16:44.853728 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005111 2025-02-25 19:17:21.950163 | 2025-02-25 19:17:21.950276 | TASK [upload-logs : Upload logs to log server] 2025-02-25 19:17:22.522273 | localhost | Output suppressed because no_log was given 2025-02-25 19:17:22.525603 | 2025-02-25 19:17:22.525820 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 19:17:22.588783 | localhost | skipping: Conditional result was False 2025-02-25 19:17:22.608061 | localhost | skipping: Conditional result was False 2025-02-25 19:17:22.621726 | 2025-02-25 19:17:22.621926 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 19:17:22.696353 | localhost | skipping: Conditional result was False 2025-02-25 19:17:22.696721 | 2025-02-25 19:17:22.716989 | localhost | skipping: Conditional result was False 2025-02-25 19:17:22.727090 | 2025-02-25 19:17:22.727246 | LOOP [upload-logs : Upload console log and json output]