2025-01-16 21:13:20.102275 | Job console starting... 2025-01-16 21:13:20.132012 | Updating repositories 2025-01-16 21:13:20.166669 | Preparing job workspace 2025-01-16 21:13:21.837855 | Running Ansible setup... 2025-01-16 21:13:26.854355 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-16 21:13:27.610712 | 2025-01-16 21:13:27.613232 | PLAY [Base pre] 2025-01-16 21:13:27.643982 | 2025-01-16 21:13:27.644138 | TASK [Setup log path fact] 2025-01-16 21:13:27.686062 | ubuntu-noble | ok 2025-01-16 21:13:27.710534 | 2025-01-16 21:13:27.710722 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 21:13:27.753414 | ubuntu-noble | ok 2025-01-16 21:13:27.764174 | 2025-01-16 21:13:27.764382 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 21:13:27.799373 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:27.806929 | 2025-01-16 21:13:27.807063 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 21:13:27.851881 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:27.859624 | 2025-01-16 21:13:27.859757 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-16 21:13:27.884989 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:27.903282 | 2025-01-16 21:13:27.903471 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-16 21:13:27.929854 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:27.937221 | 2025-01-16 21:13:27.937339 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-16 21:13:27.962184 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:27.978084 | 2025-01-16 21:13:27.978208 | TASK [emit-job-header : Print job information] 2025-01-16 21:13:28.060671 | # Job Information 2025-01-16 21:13:28.060859 | Ansible Version: 2.15.3 2025-01-16 21:13:28.060891 | Job: ansible-lint 2025-01-16 21:13:28.060921 | Pipeline: check 2025-01-16 21:13:28.060941 | Executor: 7d211f194f6a 2025-01-16 21:13:28.060960 | Triggered by: https://github.com/osism/testbed/pull/2584 2025-01-16 21:13:28.060978 | Event ID: b187f670-d44e-11ef-8943-8861078035a4 2025-01-16 21:13:28.067637 | 2025-01-16 21:13:28.067758 | LOOP [emit-job-header : Print node information] 2025-01-16 21:13:28.237818 | ubuntu-noble | ok: 2025-01-16 21:13:28.238126 | ubuntu-noble | # Node Information 2025-01-16 21:13:28.238167 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-16 21:13:28.238192 | ubuntu-noble | Hostname: ubuntu 2025-01-16 21:13:28.238214 | ubuntu-noble | Username: zuul 2025-01-16 21:13:28.238234 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-16 21:13:28.238254 | ubuntu-noble | Provider: regiocloud-a 2025-01-16 21:13:28.238274 | ubuntu-noble | Label: ubuntu-noble 2025-01-16 21:13:28.238293 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-16 21:13:28.238314 | ubuntu-noble | Interface IP: 81.163.193.82 2025-01-16 21:13:28.258926 | 2025-01-16 21:13:28.259061 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-16 21:13:28.776264 | ubuntu-noble -> localhost | changed 2025-01-16 21:13:28.785641 | 2025-01-16 21:13:28.785769 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-16 21:13:29.942393 | ubuntu-noble -> localhost | changed 2025-01-16 21:13:29.959245 | 2025-01-16 21:13:29.959376 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-16 21:13:30.239781 | ubuntu-noble -> localhost | ok 2025-01-16 21:13:30.248424 | 2025-01-16 21:13:30.248543 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-16 21:13:30.279566 | ubuntu-noble | ok 2025-01-16 21:13:30.296525 | ubuntu-noble | included: /var/lib/zuul/builds/3541cad4aa3c4105a49bc3017a43c410/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-16 21:13:30.304356 | 2025-01-16 21:13:30.304467 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-16 21:13:30.887659 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-16 21:13:30.887883 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/3541cad4aa3c4105a49bc3017a43c410/work/3541cad4aa3c4105a49bc3017a43c410_id_rsa 2025-01-16 21:13:30.887919 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/3541cad4aa3c4105a49bc3017a43c410/work/3541cad4aa3c4105a49bc3017a43c410_id_rsa.pub 2025-01-16 21:13:30.887944 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-16 21:13:30.887967 | ubuntu-noble -> localhost | SHA256:vCKIoqRcaR5ciagr2AlVoGTe/72OUxrzRfXn9Yj8viA zuul-build-sshkey 2025-01-16 21:13:30.887989 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-16 21:13:30.888014 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-16 21:13:30.888036 | ubuntu-noble -> localhost | | o.. | 2025-01-16 21:13:30.888057 | ubuntu-noble -> localhost | |+.. . . | 2025-01-16 21:13:30.888077 | ubuntu-noble -> localhost | |.. o . . | 2025-01-16 21:13:30.888096 | ubuntu-noble -> localhost | | o o .. . .o| 2025-01-16 21:13:30.888115 | ubuntu-noble -> localhost | | o . + S .. . o+| 2025-01-16 21:13:30.888135 | ubuntu-noble -> localhost | |o...o .o.o .o . o| 2025-01-16 21:13:30.888154 | ubuntu-noble -> localhost | |=+.B. ..B.E .. | 2025-01-16 21:13:30.888174 | ubuntu-noble -> localhost | |O.* .. +.... .. | 2025-01-16 21:13:30.888194 | ubuntu-noble -> localhost | |=. . .oo .o. | 2025-01-16 21:13:30.888214 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-16 21:13:30.888264 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.068980 2025-01-16 21:13:30.896551 | 2025-01-16 21:13:30.896707 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-16 21:13:30.932020 | ubuntu-noble | ok 2025-01-16 21:13:30.958653 | ubuntu-noble | included: /var/lib/zuul/builds/3541cad4aa3c4105a49bc3017a43c410/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-16 21:13:30.974333 | 2025-01-16 21:13:30.974463 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-16 21:13:31.023995 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:31.038955 | 2025-01-16 21:13:31.039162 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-16 21:13:31.758333 | ubuntu-noble | changed 2025-01-16 21:13:31.765484 | 2025-01-16 21:13:31.765591 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-16 21:13:32.045489 | ubuntu-noble | ok 2025-01-16 21:13:32.053788 | 2025-01-16 21:13:32.053973 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-16 21:13:32.834712 | ubuntu-noble | changed 2025-01-16 21:13:32.844947 | 2025-01-16 21:13:32.845119 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-16 21:13:33.606977 | ubuntu-noble | changed 2025-01-16 21:13:33.617319 | 2025-01-16 21:13:33.617444 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-16 21:13:33.653773 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:33.667247 | 2025-01-16 21:13:33.667393 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-16 21:13:34.175900 | ubuntu-noble -> localhost | changed 2025-01-16 21:13:34.196930 | 2025-01-16 21:13:34.197062 | TASK [add-build-sshkey : Add back temp key] 2025-01-16 21:13:34.570873 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/3541cad4aa3c4105a49bc3017a43c410/work/3541cad4aa3c4105a49bc3017a43c410_id_rsa (zuul-build-sshkey) 2025-01-16 21:13:34.571110 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010475 2025-01-16 21:13:34.578890 | 2025-01-16 21:13:34.579007 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-16 21:13:35.076144 | ubuntu-noble | ok 2025-01-16 21:13:35.082483 | 2025-01-16 21:13:35.082591 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-16 21:13:35.117631 | ubuntu-noble | skipping: Conditional result was False 2025-01-16 21:13:35.138157 | 2025-01-16 21:13:35.138284 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-16 21:13:35.670401 | ubuntu-noble | ok 2025-01-16 21:13:35.691397 | 2025-01-16 21:13:35.691585 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-16 21:13:35.728035 | ubuntu-noble | ok 2025-01-16 21:13:35.736255 | 2025-01-16 21:13:35.736384 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-16 21:13:36.073566 | ubuntu-noble -> localhost | ok 2025-01-16 21:13:36.081975 | 2025-01-16 21:13:36.082093 | TASK [validate-host : Collect information about the host] 2025-01-16 21:13:37.288330 | ubuntu-noble | ok 2025-01-16 21:13:37.303444 | 2025-01-16 21:13:37.303578 | TASK [validate-host : Sanitize hostname] 2025-01-16 21:13:37.382658 | ubuntu-noble | ok 2025-01-16 21:13:37.391412 | 2025-01-16 21:13:37.391539 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-16 21:13:37.978088 | ubuntu-noble -> localhost | changed 2025-01-16 21:13:37.985658 | 2025-01-16 21:13:37.985778 | TASK [validate-host : Collect information about zuul worker] 2025-01-16 21:13:38.522843 | ubuntu-noble | ok 2025-01-16 21:13:38.538849 | 2025-01-16 21:13:38.538990 | TASK [validate-host : Write out all zuul information for each host] 2025-01-16 21:13:39.088767 | ubuntu-noble -> localhost | changed 2025-01-16 21:13:39.105591 | 2025-01-16 21:13:39.105733 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-16 21:13:39.440192 | ubuntu-noble | ok 2025-01-16 21:13:39.452341 | 2025-01-16 21:13:39.452461 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-16 21:13:40.759458 | ubuntu-noble | changed: 2025-01-16 21:13:40.759669 | ubuntu-noble | cd+++++++++ src/ 2025-01-16 21:13:40.759704 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-16 21:13:40.759728 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-16 21:13:40.759750 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-16 21:13:40.759772 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007344 2025-01-16 21:15:02.675384 | 2025-01-16 21:15:02.675546 | TASK [upload-logs : Upload logs to log server] 2025-01-16 21:15:03.244159 | localhost | Output suppressed because no_log was given 2025-01-16 21:15:03.250123 | 2025-01-16 21:15:03.250279 | LOOP [upload-logs : Compress console log and json output] 2025-01-16 21:15:03.324779 | localhost | skipping: Conditional result was False 2025-01-16 21:15:03.341793 | localhost | skipping: Conditional result was False 2025-01-16 21:15:03.358490 | 2025-01-16 21:15:03.358734 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-16 21:15:03.422591 | localhost | skipping: Conditional result was False 2025-01-16 21:15:03.423216 | 2025-01-16 21:15:03.434867 | localhost | skipping: Conditional result was False 2025-01-16 21:15:03.445150 | 2025-01-16 21:15:03.445341 | LOOP [upload-logs : Upload console log and json output]