2025-01-11 21:02:11.828936 | Job console starting... 2025-01-11 21:02:11.853168 | Updating repositories 2025-01-11 21:02:11.889297 | Preparing job workspace 2025-01-11 21:02:13.700892 | Running Ansible setup... 2025-01-11 21:02:19.650605 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-11 21:02:20.549732 | 2025-01-11 21:02:20.557974 | PLAY [Base pre] 2025-01-11 21:02:20.617407 | 2025-01-11 21:02:20.617573 | TASK [Setup log path fact] 2025-01-11 21:02:20.649240 | ubuntu-noble | ok 2025-01-11 21:02:20.685751 | 2025-01-11 21:02:20.686308 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-11 21:02:20.730170 | ubuntu-noble | ok 2025-01-11 21:02:20.737433 | 2025-01-11 21:02:20.737566 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-11 21:02:20.785284 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:20.793340 | 2025-01-11 21:02:20.793472 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-11 21:02:20.838469 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:20.846117 | 2025-01-11 21:02:20.846241 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-11 21:02:20.870742 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:20.878075 | 2025-01-11 21:02:20.878197 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-11 21:02:20.896447 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:20.904244 | 2025-01-11 21:02:20.904394 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-11 21:02:20.938748 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:20.954078 | 2025-01-11 21:02:20.954215 | TASK [emit-job-header : Print job information] 2025-01-11 21:02:21.005621 | # Job Information 2025-01-11 21:02:21.005798 | Ansible Version: 2.15.3 2025-01-11 21:02:21.005831 | Job: ansible-lint 2025-01-11 21:02:21.005861 | Pipeline: check 2025-01-11 21:02:21.005881 | Executor: 7d211f194f6a 2025-01-11 21:02:21.005901 | Triggered by: https://github.com/osism/testbed/pull/2579 2025-01-11 21:02:21.005954 | Event ID: 4f3f6540-d05f-11ef-919a-27014f5fb658 2025-01-11 21:02:21.015078 | 2025-01-11 21:02:21.015204 | LOOP [emit-job-header : Print node information] 2025-01-11 21:02:21.164826 | ubuntu-noble | ok: 2025-01-11 21:02:21.165078 | ubuntu-noble | # Node Information 2025-01-11 21:02:21.165115 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-11 21:02:21.165139 | ubuntu-noble | Hostname: ubuntu 2025-01-11 21:02:21.165160 | ubuntu-noble | Username: zuul 2025-01-11 21:02:21.165180 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-11 21:02:21.165199 | ubuntu-noble | Provider: regiocloud-a 2025-01-11 21:02:21.165218 | ubuntu-noble | Label: ubuntu-noble 2025-01-11 21:02:21.165237 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-11 21:02:21.165258 | ubuntu-noble | Interface IP: 81.163.193.183 2025-01-11 21:02:21.186360 | 2025-01-11 21:02:21.186494 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-11 21:02:21.734186 | ubuntu-noble -> localhost | changed 2025-01-11 21:02:21.744268 | 2025-01-11 21:02:21.744427 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-11 21:02:23.145367 | ubuntu-noble -> localhost | changed 2025-01-11 21:02:23.162616 | 2025-01-11 21:02:23.162755 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-11 21:02:23.582286 | ubuntu-noble -> localhost | ok 2025-01-11 21:02:23.594173 | 2025-01-11 21:02:23.594296 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-11 21:02:23.631953 | ubuntu-noble | ok 2025-01-11 21:02:23.667929 | ubuntu-noble | included: /var/lib/zuul/builds/1141d65fa34a44218816fa6118df347b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-11 21:02:23.676118 | 2025-01-11 21:02:23.676242 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-11 21:02:24.695628 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-11 21:02:24.695904 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1141d65fa34a44218816fa6118df347b/work/1141d65fa34a44218816fa6118df347b_id_rsa 2025-01-11 21:02:24.695947 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1141d65fa34a44218816fa6118df347b/work/1141d65fa34a44218816fa6118df347b_id_rsa.pub 2025-01-11 21:02:24.695973 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-11 21:02:24.695996 | ubuntu-noble -> localhost | SHA256:uVd1Tk+2rG/84pG8yevRQtIue56cQGzF/5isez1ZGjk zuul-build-sshkey 2025-01-11 21:02:24.696017 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-11 21:02:24.696042 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-11 21:02:24.696064 | ubuntu-noble -> localhost | | | 2025-01-11 21:02:24.696084 | ubuntu-noble -> localhost | | . | 2025-01-11 21:02:24.696103 | ubuntu-noble -> localhost | | + =| 2025-01-11 21:02:24.696123 | ubuntu-noble -> localhost | | . . +.Bo| 2025-01-11 21:02:24.696141 | ubuntu-noble -> localhost | | S * o++| 2025-01-11 21:02:24.696160 | ubuntu-noble -> localhost | | . + *E=o| 2025-01-11 21:02:24.696179 | ubuntu-noble -> localhost | | . . o.%==| 2025-01-11 21:02:24.696199 | ubuntu-noble -> localhost | | . B*&.| 2025-01-11 21:02:24.696219 | ubuntu-noble -> localhost | | +B&++| 2025-01-11 21:02:24.696238 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-11 21:02:24.696292 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.171427 2025-01-11 21:02:24.705611 | 2025-01-11 21:02:24.705733 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-11 21:02:24.778847 | ubuntu-noble | ok 2025-01-11 21:02:24.790453 | ubuntu-noble | included: /var/lib/zuul/builds/1141d65fa34a44218816fa6118df347b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-11 21:02:24.800628 | 2025-01-11 21:02:24.800744 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-11 21:02:24.836595 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:24.846766 | 2025-01-11 21:02:24.846910 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-11 21:02:25.653177 | ubuntu-noble | changed 2025-01-11 21:02:25.660815 | 2025-01-11 21:02:25.660944 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-11 21:02:25.982895 | ubuntu-noble | ok 2025-01-11 21:02:25.993226 | 2025-01-11 21:02:25.993390 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-11 21:02:26.697784 | ubuntu-noble | changed 2025-01-11 21:02:26.705002 | 2025-01-11 21:02:26.705119 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-11 21:02:27.410251 | ubuntu-noble | changed 2025-01-11 21:02:27.419170 | 2025-01-11 21:02:27.419297 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-11 21:02:27.444037 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:27.452638 | 2025-01-11 21:02:27.452746 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-11 21:02:27.969879 | ubuntu-noble -> localhost | changed 2025-01-11 21:02:27.988166 | 2025-01-11 21:02:27.988292 | TASK [add-build-sshkey : Add back temp key] 2025-01-11 21:02:28.555199 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1141d65fa34a44218816fa6118df347b/work/1141d65fa34a44218816fa6118df347b_id_rsa (zuul-build-sshkey) 2025-01-11 21:02:28.555432 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.018951 2025-01-11 21:02:28.564457 | 2025-01-11 21:02:28.564584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-11 21:02:29.210437 | ubuntu-noble | ok 2025-01-11 21:02:29.238800 | 2025-01-11 21:02:29.243889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-11 21:02:29.341266 | ubuntu-noble | skipping: Conditional result was False 2025-01-11 21:02:29.365004 | 2025-01-11 21:02:29.366128 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-11 21:02:29.903238 | ubuntu-noble | ok 2025-01-11 21:02:29.917858 | 2025-01-11 21:02:29.918005 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-11 21:02:29.970571 | ubuntu-noble | ok 2025-01-11 21:02:29.981654 | 2025-01-11 21:02:29.981775 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-11 21:02:30.358642 | ubuntu-noble -> localhost | ok 2025-01-11 21:02:30.370425 | 2025-01-11 21:02:30.370556 | TASK [validate-host : Collect information about the host] 2025-01-11 21:02:31.645557 | ubuntu-noble | ok 2025-01-11 21:02:31.675136 | 2025-01-11 21:02:31.675289 | TASK [validate-host : Sanitize hostname] 2025-01-11 21:02:31.767547 | ubuntu-noble | ok 2025-01-11 21:02:31.774101 | 2025-01-11 21:02:31.774225 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-11 21:02:32.402235 | ubuntu-noble -> localhost | changed 2025-01-11 21:02:32.409904 | 2025-01-11 21:02:32.410053 | TASK [validate-host : Collect information about zuul worker] 2025-01-11 21:02:32.901150 | ubuntu-noble | ok 2025-01-11 21:02:32.907906 | 2025-01-11 21:02:32.908036 | TASK [validate-host : Write out all zuul information for each host] 2025-01-11 21:02:33.640004 | ubuntu-noble -> localhost | changed 2025-01-11 21:02:33.661741 | 2025-01-11 21:02:33.661887 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-11 21:02:33.998721 | ubuntu-noble | ok 2025-01-11 21:02:34.026378 | 2025-01-11 21:02:34.026541 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-11 21:02:35.512661 | ubuntu-noble | changed: 2025-01-11 21:02:35.513093 | ubuntu-noble | cd+++++++++ src/ 2025-01-11 21:02:35.513152 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-11 21:02:35.513186 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-11 21:02:35.513215 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-01-11 21:02:35.513244 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.005417 2025-01-11 21:03:58.159160 | 2025-01-11 21:03:58.159381 | TASK [upload-logs : Upload logs to log server] 2025-01-11 21:03:58.766837 | localhost | Output suppressed because no_log was given 2025-01-11 21:03:58.773877 | 2025-01-11 21:03:58.774135 | LOOP [upload-logs : Compress console log and json output] 2025-01-11 21:03:58.847889 | localhost | skipping: Conditional result was False 2025-01-11 21:03:58.865262 | localhost | skipping: Conditional result was False 2025-01-11 21:03:58.881236 | 2025-01-11 21:03:58.881502 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-11 21:03:58.944718 | localhost | skipping: Conditional result was False 2025-01-11 21:03:58.945038 | 2025-01-11 21:03:58.957668 | localhost | skipping: Conditional result was False 2025-01-11 21:03:58.969641 | 2025-01-11 21:03:58.969831 | LOOP [upload-logs : Upload console log and json output]