2025-03-16 09:38:08.836097 | Job console starting... 2025-03-16 09:38:08.857303 | Updating repositories 2025-03-16 09:38:08.891070 | Preparing job workspace 2025-03-16 09:38:10.715992 | Running Ansible setup... 2025-03-16 09:38:16.137904 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-16 09:38:16.957943 | 2025-03-16 09:38:16.958100 | PLAY [Base pre] 2025-03-16 09:38:16.987208 | 2025-03-16 09:38:16.987375 | TASK [Setup log path fact] 2025-03-16 09:38:17.021687 | ubuntu-noble | ok 2025-03-16 09:38:17.054114 | 2025-03-16 09:38:17.054304 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-16 09:38:17.110932 | ubuntu-noble | ok 2025-03-16 09:38:17.120614 | 2025-03-16 09:38:17.120829 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-16 09:38:17.167283 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:17.176742 | 2025-03-16 09:38:17.177000 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-16 09:38:17.232696 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:17.243384 | 2025-03-16 09:38:17.243503 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-03-16 09:38:17.286279 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:17.298904 | 2025-03-16 09:38:17.299026 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-03-16 09:38:17.326091 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:17.341288 | 2025-03-16 09:38:17.342164 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-03-16 09:38:17.368593 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:17.389011 | 2025-03-16 09:38:17.389132 | TASK [emit-job-header : Print job information] 2025-03-16 09:38:17.453573 | # Job Information 2025-03-16 09:38:17.453749 | Ansible Version: 2.15.3 2025-03-16 09:38:17.453782 | Job: ansible-lint 2025-03-16 09:38:17.453811 | Pipeline: check 2025-03-16 09:38:17.453833 | Executor: 7d211f194f6a 2025-03-16 09:38:17.453853 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/711 2025-03-16 09:38:17.453871 | Event ID: 57c4b4f0-024a-11f0-8604-f62bf749a2b9 2025-03-16 09:38:17.461469 | 2025-03-16 09:38:17.461698 | LOOP [emit-job-header : Print node information] 2025-03-16 09:38:17.620031 | ubuntu-noble | ok: 2025-03-16 09:38:17.620427 | ubuntu-noble | # Node Information 2025-03-16 09:38:17.620499 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-16 09:38:17.620526 | ubuntu-noble | Hostname: ubuntu 2025-03-16 09:38:17.620549 | ubuntu-noble | Username: zuul 2025-03-16 09:38:17.620570 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-16 09:38:17.620590 | ubuntu-noble | Provider: regiocloud-a 2025-03-16 09:38:17.620610 | ubuntu-noble | Label: ubuntu-noble 2025-03-16 09:38:17.620629 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-16 09:38:17.620649 | ubuntu-noble | Interface IP: 81.163.192.27 2025-03-16 09:38:17.645895 | 2025-03-16 09:38:17.646006 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-16 09:38:18.184837 | ubuntu-noble -> localhost | changed 2025-03-16 09:38:18.193462 | 2025-03-16 09:38:18.193581 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-16 09:38:19.366555 | ubuntu-noble -> localhost | changed 2025-03-16 09:38:19.391582 | 2025-03-16 09:38:19.391754 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-16 09:38:19.673471 | ubuntu-noble -> localhost | ok 2025-03-16 09:38:19.682034 | 2025-03-16 09:38:19.682151 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-16 09:38:19.712803 | ubuntu-noble | ok 2025-03-16 09:38:19.730335 | ubuntu-noble | included: /var/lib/zuul/builds/24cdca5335f14ebfb43ea967dadfb3f8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-16 09:38:19.738125 | 2025-03-16 09:38:19.738226 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-16 09:38:20.794552 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-16 09:38:20.794990 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/24cdca5335f14ebfb43ea967dadfb3f8/work/24cdca5335f14ebfb43ea967dadfb3f8_id_rsa 2025-03-16 09:38:20.795080 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/24cdca5335f14ebfb43ea967dadfb3f8/work/24cdca5335f14ebfb43ea967dadfb3f8_id_rsa.pub 2025-03-16 09:38:20.795144 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-16 09:38:20.795204 | ubuntu-noble -> localhost | SHA256:4HBgHnJNtgY5kVC4/r05iEW9+CmraloOQ7sJxeOF3yE zuul-build-sshkey 2025-03-16 09:38:20.795281 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-16 09:38:20.795349 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-16 09:38:20.795404 | ubuntu-noble -> localhost | | o+O*o | 2025-03-16 09:38:20.795457 | ubuntu-noble -> localhost | | .=+=.. | 2025-03-16 09:38:20.795507 | ubuntu-noble -> localhost | | .oo= | 2025-03-16 09:38:20.795556 | ubuntu-noble -> localhost | | ....=.. | 2025-03-16 09:38:20.795605 | ubuntu-noble -> localhost | | o=.E.o.S | 2025-03-16 09:38:20.795653 | ubuntu-noble -> localhost | |.oo+oo.. | 2025-03-16 09:38:20.795702 | ubuntu-noble -> localhost | |+.o+.+.. | 2025-03-16 09:38:20.795753 | ubuntu-noble -> localhost | |.*+ + =. | 2025-03-16 09:38:20.795802 | ubuntu-noble -> localhost | |=+o..ooo | 2025-03-16 09:38:20.795851 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-16 09:38:20.795963 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.466870 2025-03-16 09:38:20.818469 | 2025-03-16 09:38:20.818692 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-16 09:38:20.852877 | ubuntu-noble | ok 2025-03-16 09:38:20.867077 | ubuntu-noble | included: /var/lib/zuul/builds/24cdca5335f14ebfb43ea967dadfb3f8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-16 09:38:20.880715 | 2025-03-16 09:38:20.880979 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-16 09:38:20.906554 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:20.916574 | 2025-03-16 09:38:20.916673 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-16 09:38:21.782389 | ubuntu-noble | changed 2025-03-16 09:38:21.792920 | 2025-03-16 09:38:21.793026 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-16 09:38:22.148446 | ubuntu-noble | ok 2025-03-16 09:38:22.157809 | 2025-03-16 09:38:22.157920 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-16 09:38:22.961770 | ubuntu-noble | changed 2025-03-16 09:38:22.972220 | 2025-03-16 09:38:22.972415 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-16 09:38:23.779528 | ubuntu-noble | changed 2025-03-16 09:38:23.789925 | 2025-03-16 09:38:23.790048 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-16 09:38:23.817773 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:23.830889 | 2025-03-16 09:38:23.831122 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-16 09:38:24.352257 | ubuntu-noble -> localhost | changed 2025-03-16 09:38:24.371053 | 2025-03-16 09:38:24.371238 | TASK [add-build-sshkey : Add back temp key] 2025-03-16 09:38:24.849880 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/24cdca5335f14ebfb43ea967dadfb3f8/work/24cdca5335f14ebfb43ea967dadfb3f8_id_rsa (zuul-build-sshkey) 2025-03-16 09:38:24.850078 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.019196 2025-03-16 09:38:24.857008 | 2025-03-16 09:38:24.857119 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-16 09:38:25.278360 | ubuntu-noble | ok 2025-03-16 09:38:25.293653 | 2025-03-16 09:38:25.293796 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-16 09:38:25.342021 | ubuntu-noble | skipping: Conditional result was False 2025-03-16 09:38:25.362932 | 2025-03-16 09:38:25.363055 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-16 09:38:25.783705 | ubuntu-noble | ok 2025-03-16 09:38:25.798626 | 2025-03-16 09:38:25.798757 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-16 09:38:25.840949 | ubuntu-noble | ok 2025-03-16 09:38:25.847531 | 2025-03-16 09:38:25.847632 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-16 09:38:26.160439 | ubuntu-noble -> localhost | ok 2025-03-16 09:38:26.169325 | 2025-03-16 09:38:26.169434 | TASK [validate-host : Collect information about the host] 2025-03-16 09:38:27.546755 | ubuntu-noble | ok 2025-03-16 09:38:27.561929 | 2025-03-16 09:38:27.562061 | TASK [validate-host : Sanitize hostname] 2025-03-16 09:38:27.642170 | ubuntu-noble | ok 2025-03-16 09:38:27.652820 | 2025-03-16 09:38:27.652978 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-16 09:38:28.239509 | ubuntu-noble -> localhost | changed 2025-03-16 09:38:28.248183 | 2025-03-16 09:38:28.248319 | TASK [validate-host : Collect information about zuul worker] 2025-03-16 09:38:28.777018 | ubuntu-noble | ok 2025-03-16 09:38:28.799769 | 2025-03-16 09:38:28.800139 | TASK [validate-host : Write out all zuul information for each host] 2025-03-16 09:38:29.325909 | ubuntu-noble -> localhost | changed 2025-03-16 09:38:29.382972 | 2025-03-16 09:38:29.383106 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-16 09:38:29.778333 | ubuntu-noble | ok 2025-03-16 09:38:29.787921 | 2025-03-16 09:38:29.788035 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-16 09:38:30.557534 | ubuntu-noble | changed: 2025-03-16 09:38:30.557730 | ubuntu-noble | cd+++++++++ src/ 2025-03-16 09:38:30.557764 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-16 09:38:30.557787 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-16 09:38:30.557808 | ubuntu-noble | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-03-16 09:38:30.557828 | ubuntu-noble | Containerfile 2025-03-16 09:38:30.557956 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009333 2025-03-16 09:39:44.247412 | 2025-03-16 09:39:44.247522 | TASK [upload-logs : Upload logs to log server] 2025-03-16 09:39:44.932085 | localhost | Output suppressed because no_log was given 2025-03-16 09:39:44.935507 | 2025-03-16 09:39:44.935617 | LOOP [upload-logs : Compress console log and json output] 2025-03-16 09:39:45.102497 | localhost | skipping: Conditional result was False 2025-03-16 09:39:45.145151 | localhost | skipping: Conditional result was False 2025-03-16 09:39:45.151967 | 2025-03-16 09:39:45.152103 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-16 09:39:45.256231 | localhost | skipping: Conditional result was False 2025-03-16 09:39:45.256612 | 2025-03-16 09:39:45.276158 | localhost | skipping: Conditional result was False 2025-03-16 09:39:45.286915 | 2025-03-16 09:39:45.287037 | LOOP [upload-logs : Upload console log and json output]