2025-03-13 18:52:02.161971 | Job console starting... 2025-03-13 18:52:02.188165 | Updating repositories 2025-03-13 18:52:02.232202 | Preparing job workspace 2025-03-13 18:52:03.959216 | Running Ansible setup... 2025-03-13 18:52:09.432906 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-13 18:52:10.281641 | 2025-03-13 18:52:10.281804 | PLAY [Base pre] 2025-03-13 18:52:10.315549 | 2025-03-13 18:52:10.315700 | TASK [Setup log path fact] 2025-03-13 18:52:10.357219 | ubuntu-noble | ok 2025-03-13 18:52:10.379429 | 2025-03-13 18:52:10.379586 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-13 18:52:10.447612 | ubuntu-noble | ok 2025-03-13 18:52:10.460289 | 2025-03-13 18:52:10.460727 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-13 18:52:10.496878 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:10.504462 | 2025-03-13 18:52:10.504605 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-13 18:52:10.549656 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:10.558188 | 2025-03-13 18:52:10.558359 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-13 18:52:10.584044 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:10.591403 | 2025-03-13 18:52:10.591524 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-13 18:52:10.615723 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:10.623253 | 2025-03-13 18:52:10.623416 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-13 18:52:10.647470 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:10.662545 | 2025-03-13 18:52:10.662670 | TASK [emit-job-header : Print job information] 2025-03-13 18:52:10.723800 | # Job Information 2025-03-13 18:52:10.723981 | Ansible Version: 2.15.3 2025-03-13 18:52:10.724014 | Job: flake8 2025-03-13 18:52:10.724041 | Pipeline: check 2025-03-13 18:52:10.724062 | Executor: 7d211f194f6a 2025-03-13 18:52:10.724081 | Triggered by: https://github.com/osism/testbed/pull/2615 2025-03-13 18:52:10.724099 | Event ID: 3b03d4f0-003c-11f0-9b86-6045dff4364b 2025-03-13 18:52:10.730630 | 2025-03-13 18:52:10.730747 | LOOP [emit-job-header : Print node information] 2025-03-13 18:52:10.876713 | ubuntu-noble | ok: 2025-03-13 18:52:10.877027 | ubuntu-noble | # Node Information 2025-03-13 18:52:10.877128 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-13 18:52:10.877159 | ubuntu-noble | Hostname: ubuntu 2025-03-13 18:52:10.877182 | ubuntu-noble | Username: zuul 2025-03-13 18:52:10.877203 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-13 18:52:10.877223 | ubuntu-noble | Provider: regiocloud-a 2025-03-13 18:52:10.877242 | ubuntu-noble | Label: ubuntu-noble 2025-03-13 18:52:10.877261 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-13 18:52:10.877297 | ubuntu-noble | Interface IP: 81.163.192.218 2025-03-13 18:52:10.909225 | 2025-03-13 18:52:10.909379 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-13 18:52:11.445173 | ubuntu-noble -> localhost | changed 2025-03-13 18:52:11.451587 | 2025-03-13 18:52:11.451687 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-13 18:52:12.499597 | ubuntu-noble -> localhost | changed 2025-03-13 18:52:12.510313 | 2025-03-13 18:52:12.510400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-13 18:52:12.778068 | ubuntu-noble -> localhost | ok 2025-03-13 18:52:12.784788 | 2025-03-13 18:52:12.784875 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-13 18:52:12.803277 | ubuntu-noble | ok 2025-03-13 18:52:12.821467 | ubuntu-noble | included: /var/lib/zuul/builds/11580dd188444a4e9e81b531c924149a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-13 18:52:12.827534 | 2025-03-13 18:52:12.827612 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-13 18:52:13.377817 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-13 18:52:13.377975 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/11580dd188444a4e9e81b531c924149a/work/11580dd188444a4e9e81b531c924149a_id_rsa 2025-03-13 18:52:13.378006 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/11580dd188444a4e9e81b531c924149a/work/11580dd188444a4e9e81b531c924149a_id_rsa.pub 2025-03-13 18:52:13.378028 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-13 18:52:13.378047 | ubuntu-noble -> localhost | SHA256:bwH4fMO4003X9POZVSRo/HrpVCqdoc8ajL6QZ8xWwbM zuul-build-sshkey 2025-03-13 18:52:13.378066 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-13 18:52:13.378086 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-13 18:52:13.378104 | ubuntu-noble -> localhost | | . .. .| 2025-03-13 18:52:13.378121 | ubuntu-noble -> localhost | | . .+ o | 2025-03-13 18:52:13.378137 | ubuntu-noble -> localhost | | . . .+. o| 2025-03-13 18:52:13.378153 | ubuntu-noble -> localhost | | o + +oo+| 2025-03-13 18:52:13.378168 | ubuntu-noble -> localhost | | S = E+.B+| 2025-03-13 18:52:13.378184 | ubuntu-noble -> localhost | | O O+.B *| 2025-03-13 18:52:13.378200 | ubuntu-noble -> localhost | | = @ +B o.| 2025-03-13 18:52:13.378217 | ubuntu-noble -> localhost | | O .+ | 2025-03-13 18:52:13.378234 | ubuntu-noble -> localhost | | o... | 2025-03-13 18:52:13.378250 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-13 18:52:13.378298 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.127237 2025-03-13 18:52:13.384541 | 2025-03-13 18:52:13.384626 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-13 18:52:13.443538 | ubuntu-noble | ok 2025-03-13 18:52:13.453479 | ubuntu-noble | included: /var/lib/zuul/builds/11580dd188444a4e9e81b531c924149a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-13 18:52:13.465978 | 2025-03-13 18:52:13.466115 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-13 18:52:13.490148 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:13.497530 | 2025-03-13 18:52:13.497627 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-13 18:52:14.324656 | ubuntu-noble | changed 2025-03-13 18:52:14.338171 | 2025-03-13 18:52:14.338328 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-13 18:52:14.676783 | ubuntu-noble | ok 2025-03-13 18:52:14.685712 | 2025-03-13 18:52:14.685812 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-13 18:52:15.473235 | ubuntu-noble | changed 2025-03-13 18:52:15.483143 | 2025-03-13 18:52:15.483253 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-13 18:52:16.252974 | ubuntu-noble | changed 2025-03-13 18:52:16.260013 | 2025-03-13 18:52:16.260097 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-13 18:52:16.294192 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:16.305202 | 2025-03-13 18:52:16.305323 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-13 18:52:16.789048 | ubuntu-noble -> localhost | changed 2025-03-13 18:52:16.811192 | 2025-03-13 18:52:16.811319 | TASK [add-build-sshkey : Add back temp key] 2025-03-13 18:52:17.378379 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/11580dd188444a4e9e81b531c924149a/work/11580dd188444a4e9e81b531c924149a_id_rsa (zuul-build-sshkey) 2025-03-13 18:52:17.378631 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011493 2025-03-13 18:52:17.386804 | 2025-03-13 18:52:17.386924 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-13 18:52:18.001842 | ubuntu-noble | ok 2025-03-13 18:52:18.010609 | 2025-03-13 18:52:18.010711 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-13 18:52:18.044773 | ubuntu-noble | skipping: Conditional result was False 2025-03-13 18:52:18.066163 | 2025-03-13 18:52:18.066316 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-13 18:52:18.574412 | ubuntu-noble | ok 2025-03-13 18:52:18.587252 | 2025-03-13 18:52:18.587369 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-13 18:52:18.626725 | ubuntu-noble | ok 2025-03-13 18:52:18.633117 | 2025-03-13 18:52:18.633201 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-13 18:52:18.995754 | ubuntu-noble -> localhost | ok 2025-03-13 18:52:19.006740 | 2025-03-13 18:52:19.006922 | TASK [validate-host : Collect information about the host] 2025-03-13 18:52:20.322393 | ubuntu-noble | ok 2025-03-13 18:52:20.334456 | 2025-03-13 18:52:20.334557 | TASK [validate-host : Sanitize hostname] 2025-03-13 18:52:20.394166 | ubuntu-noble | ok 2025-03-13 18:52:20.400029 | 2025-03-13 18:52:20.400118 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-13 18:52:20.931999 | ubuntu-noble -> localhost | changed 2025-03-13 18:52:20.940668 | 2025-03-13 18:52:20.940810 | TASK [validate-host : Collect information about zuul worker] 2025-03-13 18:52:21.520700 | ubuntu-noble | ok 2025-03-13 18:52:21.528311 | 2025-03-13 18:52:21.528428 | TASK [validate-host : Write out all zuul information for each host] 2025-03-13 18:52:22.100803 | ubuntu-noble -> localhost | changed 2025-03-13 18:52:22.118192 | 2025-03-13 18:52:22.118319 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-13 18:52:22.456237 | ubuntu-noble | ok 2025-03-13 18:52:22.464942 | 2025-03-13 18:52:22.465058 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-13 18:52:23.650889 | ubuntu-noble | changed: 2025-03-13 18:52:23.651089 | ubuntu-noble | cd+++++++++ src/ 2025-03-13 18:52:23.651121 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-13 18:52:23.651145 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-13 18:52:23.651167 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-13 18:52:23.651187 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.010492 2025-03-13 18:53:01.844130 | 2025-03-13 18:53:01.844314 | TASK [upload-logs : Upload logs to log server] 2025-03-13 18:53:02.424810 | localhost | Output suppressed because no_log was given 2025-03-13 18:53:02.432033 | 2025-03-13 18:53:02.432211 | LOOP [upload-logs : Compress console log and json output] 2025-03-13 18:53:02.505413 | localhost | skipping: Conditional result was False 2025-03-13 18:53:02.526382 | localhost | skipping: Conditional result was False 2025-03-13 18:53:02.545300 | 2025-03-13 18:53:02.545492 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-13 18:53:02.613079 | localhost | skipping: Conditional result was False 2025-03-13 18:53:02.613605 | 2025-03-13 18:53:02.626689 | localhost | skipping: Conditional result was False 2025-03-13 18:53:02.640303 | 2025-03-13 18:53:02.640490 | LOOP [upload-logs : Upload console log and json output]