2025-01-23 00:06:11.708670 | Job console starting... 2025-01-23 00:06:11.721478 | Updating repositories 2025-01-23 00:06:11.760370 | Preparing job workspace 2025-01-23 00:06:13.465489 | Running Ansible setup... 2025-01-23 00:06:20.094135 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-23 00:06:20.926476 | 2025-01-23 00:06:20.926649 | PLAY [Base pre] 2025-01-23 00:06:20.956732 | 2025-01-23 00:06:20.956889 | TASK [Setup log path fact] 2025-01-23 00:06:20.978920 | ubuntu-noble | ok 2025-01-23 00:06:21.001546 | 2025-01-23 00:06:21.001686 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-23 00:06:21.062446 | ubuntu-noble | ok 2025-01-23 00:06:21.071753 | 2025-01-23 00:06:21.071889 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-23 00:06:21.107386 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.123190 | 2025-01-23 00:06:21.123357 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-23 00:06:21.170766 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.186420 | 2025-01-23 00:06:21.186582 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-23 00:06:21.213112 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.220755 | 2025-01-23 00:06:21.220868 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-23 00:06:21.255625 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.265166 | 2025-01-23 00:06:21.265298 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-23 00:06:21.290169 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:21.308901 | 2025-01-23 00:06:21.309042 | TASK [emit-job-header : Print job information] 2025-01-23 00:06:21.380816 | # Job Information 2025-01-23 00:06:21.381094 | Ansible Version: 2.15.3 2025-01-23 00:06:21.381196 | Job: flake8 2025-01-23 00:06:21.381249 | Pipeline: check 2025-01-23 00:06:21.381283 | Executor: 7d211f194f6a 2025-01-23 00:06:21.381314 | Triggered by: https://github.com/osism/testbed/pull/2595 2025-01-23 00:06:21.381345 | Event ID: d3d64a50-d91d-11ef-83bc-9e07bfc4406b 2025-01-23 00:06:21.396208 | 2025-01-23 00:06:21.396464 | LOOP [emit-job-header : Print node information] 2025-01-23 00:06:21.577400 | ubuntu-noble | ok: 2025-01-23 00:06:21.581035 | ubuntu-noble | # Node Information 2025-01-23 00:06:21.581137 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-23 00:06:21.581188 | ubuntu-noble | Hostname: ubuntu 2025-01-23 00:06:21.581212 | ubuntu-noble | Username: zuul 2025-01-23 00:06:21.581234 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-23 00:06:21.581255 | ubuntu-noble | Provider: regiocloud-a 2025-01-23 00:06:21.581275 | ubuntu-noble | Label: ubuntu-noble 2025-01-23 00:06:21.581295 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-23 00:06:21.581316 | ubuntu-noble | Interface IP: 81.163.193.12 2025-01-23 00:06:21.627657 | 2025-01-23 00:06:21.628027 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-23 00:06:22.193062 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:22.210446 | 2025-01-23 00:06:22.210615 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-23 00:06:23.385756 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:23.400673 | 2025-01-23 00:06:23.400807 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-23 00:06:23.704173 | ubuntu-noble -> localhost | ok 2025-01-23 00:06:23.725016 | 2025-01-23 00:06:23.725189 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-23 00:06:23.771618 | ubuntu-noble | ok 2025-01-23 00:06:23.791496 | ubuntu-noble | included: /var/lib/zuul/builds/9b5195a909e641f98fbe81f58104070a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-23 00:06:23.799874 | 2025-01-23 00:06:23.799997 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-23 00:06:24.852535 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-23 00:06:24.852815 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9b5195a909e641f98fbe81f58104070a/work/9b5195a909e641f98fbe81f58104070a_id_rsa 2025-01-23 00:06:24.852857 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9b5195a909e641f98fbe81f58104070a/work/9b5195a909e641f98fbe81f58104070a_id_rsa.pub 2025-01-23 00:06:24.852882 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-23 00:06:24.852906 | ubuntu-noble -> localhost | SHA256:Zk7FPIBeDb9vnVstomKRRKsKfqWGSaFpfqnYv0QjhHw zuul-build-sshkey 2025-01-23 00:06:24.852928 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-23 00:06:24.852954 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-23 00:06:24.852975 | ubuntu-noble -> localhost | | .oo | 2025-01-23 00:06:24.852994 | ubuntu-noble -> localhost | |.. . o=. | 2025-01-23 00:06:24.853013 | ubuntu-noble -> localhost | |...E . o .* | 2025-01-23 00:06:24.853032 | ubuntu-noble -> localhost | | .o . o. o | 2025-01-23 00:06:24.853051 | ubuntu-noble -> localhost | | o..o oS.. | 2025-01-23 00:06:24.853069 | ubuntu-noble -> localhost | |o.oo .o=o . . ..| 2025-01-23 00:06:24.853088 | ubuntu-noble -> localhost | |oo +o+ .. + + o| 2025-01-23 00:06:24.853107 | ubuntu-noble -> localhost | |.o++= o o . + | 2025-01-23 00:06:24.853126 | ubuntu-noble -> localhost | |..++o. . .. . | 2025-01-23 00:06:24.853185 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-23 00:06:24.853246 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.527501 2025-01-23 00:06:24.861636 | 2025-01-23 00:06:24.861756 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-23 00:06:24.905743 | ubuntu-noble | ok 2025-01-23 00:06:24.918011 | ubuntu-noble | included: /var/lib/zuul/builds/9b5195a909e641f98fbe81f58104070a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-23 00:06:24.929495 | 2025-01-23 00:06:24.929613 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-23 00:06:24.965276 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:24.973444 | 2025-01-23 00:06:24.973561 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-23 00:06:25.682842 | ubuntu-noble | changed 2025-01-23 00:06:25.694281 | 2025-01-23 00:06:25.694412 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-23 00:06:25.972528 | ubuntu-noble | ok 2025-01-23 00:06:25.983013 | 2025-01-23 00:06:25.983175 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-23 00:06:26.613997 | ubuntu-noble | changed 2025-01-23 00:06:26.622698 | 2025-01-23 00:06:26.622820 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-23 00:06:27.297712 | ubuntu-noble | changed 2025-01-23 00:06:27.304849 | 2025-01-23 00:06:27.304963 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-23 00:06:27.329437 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:27.336997 | 2025-01-23 00:06:27.337105 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-23 00:06:27.823220 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:27.837558 | 2025-01-23 00:06:27.837693 | TASK [add-build-sshkey : Add back temp key] 2025-01-23 00:06:28.193856 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9b5195a909e641f98fbe81f58104070a/work/9b5195a909e641f98fbe81f58104070a_id_rsa (zuul-build-sshkey) 2025-01-23 00:06:28.194246 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009466 2025-01-23 00:06:28.209032 | 2025-01-23 00:06:28.209190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-23 00:06:28.675605 | ubuntu-noble | ok 2025-01-23 00:06:28.690807 | 2025-01-23 00:06:28.690954 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-23 00:06:28.727879 | ubuntu-noble | skipping: Conditional result was False 2025-01-23 00:06:28.742848 | 2025-01-23 00:06:28.742984 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-23 00:06:29.205955 | ubuntu-noble | ok 2025-01-23 00:06:29.224141 | 2025-01-23 00:06:29.224289 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-23 00:06:29.275443 | ubuntu-noble | ok 2025-01-23 00:06:29.286254 | 2025-01-23 00:06:29.286390 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-23 00:06:29.577979 | ubuntu-noble -> localhost | ok 2025-01-23 00:06:29.586164 | 2025-01-23 00:06:29.586677 | TASK [validate-host : Collect information about the host] 2025-01-23 00:06:30.829750 | ubuntu-noble | ok 2025-01-23 00:06:30.844520 | 2025-01-23 00:06:30.844667 | TASK [validate-host : Sanitize hostname] 2025-01-23 00:06:30.919434 | ubuntu-noble | ok 2025-01-23 00:06:30.930333 | 2025-01-23 00:06:30.930479 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-23 00:06:31.881346 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:31.891116 | 2025-01-23 00:06:31.891298 | TASK [validate-host : Collect information about zuul worker] 2025-01-23 00:06:32.408632 | ubuntu-noble | ok 2025-01-23 00:06:32.416359 | 2025-01-23 00:06:32.416524 | TASK [validate-host : Write out all zuul information for each host] 2025-01-23 00:06:33.026513 | ubuntu-noble -> localhost | changed 2025-01-23 00:06:33.043416 | 2025-01-23 00:06:33.043592 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-23 00:06:33.363803 | ubuntu-noble | ok 2025-01-23 00:06:33.372056 | 2025-01-23 00:06:33.372212 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-23 00:06:34.447543 | ubuntu-noble | changed: 2025-01-23 00:06:34.447772 | ubuntu-noble | cd+++++++++ src/ 2025-01-23 00:06:34.447809 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-23 00:06:34.447835 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-23 00:06:34.447859 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-23 00:06:34.447882 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008392 2025-01-23 00:07:06.526911 | 2025-01-23 00:07:06.527039 | TASK [upload-logs : Upload logs to log server] 2025-01-23 00:07:07.180001 | localhost | Output suppressed because no_log was given 2025-01-23 00:07:07.184769 | 2025-01-23 00:07:07.184902 | LOOP [upload-logs : Compress console log and json output] 2025-01-23 00:07:07.254923 | localhost | skipping: Conditional result was False 2025-01-23 00:07:07.279029 | localhost | skipping: Conditional result was False 2025-01-23 00:07:07.293849 | 2025-01-23 00:07:07.293996 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-23 00:07:07.375068 | localhost | skipping: Conditional result was False 2025-01-23 00:07:07.375811 | 2025-01-23 00:07:07.385911 | localhost | skipping: Conditional result was False 2025-01-23 00:07:07.400352 | 2025-01-23 00:07:07.400514 | LOOP [upload-logs : Upload console log and json output]