2025-01-09 08:02:19.486514 | Job console starting... 2025-01-09 08:02:19.496034 | Updating repositories 2025-01-09 08:02:19.549282 | Preparing job workspace 2025-01-09 08:02:22.575145 | Running Ansible setup... 2025-01-09 08:02:29.143142 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-09 08:02:30.036505 | 2025-01-09 08:02:30.036684 | PLAY [Base pre] 2025-01-09 08:02:30.067864 | 2025-01-09 08:02:30.068043 | TASK [Setup log path fact] 2025-01-09 08:02:30.111944 | ubuntu-noble | ok 2025-01-09 08:02:30.139596 | 2025-01-09 08:02:30.139814 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:02:30.193168 | ubuntu-noble | ok 2025-01-09 08:02:30.200725 | 2025-01-09 08:02:30.200864 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:02:30.250382 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:30.258115 | 2025-01-09 08:02:30.258257 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:02:30.303900 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:30.311645 | 2025-01-09 08:02:30.311787 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-09 08:02:30.346889 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:30.354441 | 2025-01-09 08:02:30.354573 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-09 08:02:30.393062 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:30.400675 | 2025-01-09 08:02:30.400826 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-09 08:02:30.480014 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:30.501509 | 2025-01-09 08:02:30.501639 | TASK [emit-job-header : Print job information] 2025-01-09 08:02:30.574098 | # Job Information 2025-01-09 08:02:30.574254 | Ansible Version: 2.15.3 2025-01-09 08:02:30.574285 | Job: ansible-lint 2025-01-09 08:02:30.574314 | Pipeline: check 2025-01-09 08:02:30.574336 | Executor: 7d211f194f6a 2025-01-09 08:02:30.574355 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1735 2025-01-09 08:02:30.574374 | Event ID: 074e9ef0-ce60-11ef-9879-677b5b032314 2025-01-09 08:02:30.580409 | 2025-01-09 08:02:30.580495 | LOOP [emit-job-header : Print node information] 2025-01-09 08:02:30.854124 | ubuntu-noble | ok: 2025-01-09 08:02:30.863594 | ubuntu-noble | # Node Information 2025-01-09 08:02:30.863694 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-09 08:02:30.863753 | ubuntu-noble | Hostname: ubuntu 2025-01-09 08:02:30.863778 | ubuntu-noble | Username: zuul 2025-01-09 08:02:30.863799 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-09 08:02:30.863820 | ubuntu-noble | Provider: regiocloud-a 2025-01-09 08:02:30.863839 | ubuntu-noble | Label: ubuntu-noble 2025-01-09 08:02:30.863859 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-09 08:02:30.863880 | ubuntu-noble | Interface IP: 81.163.193.93 2025-01-09 08:02:30.885204 | 2025-01-09 08:02:30.885307 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-09 08:02:31.404028 | ubuntu-noble -> localhost | changed 2025-01-09 08:02:31.410568 | 2025-01-09 08:02:31.410774 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-09 08:02:32.647376 | ubuntu-noble -> localhost | changed 2025-01-09 08:02:32.658113 | 2025-01-09 08:02:32.658205 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-09 08:02:33.020381 | ubuntu-noble -> localhost | ok 2025-01-09 08:02:33.030931 | 2025-01-09 08:02:33.031016 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-09 08:02:33.065995 | ubuntu-noble | ok 2025-01-09 08:02:33.084518 | ubuntu-noble | included: /var/lib/zuul/builds/a65cab32a5cc4b088ef5473321f4386b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-09 08:02:33.099611 | 2025-01-09 08:02:33.099741 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-09 08:02:34.363076 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-09 08:02:34.363269 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a65cab32a5cc4b088ef5473321f4386b/work/a65cab32a5cc4b088ef5473321f4386b_id_rsa 2025-01-09 08:02:34.363300 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a65cab32a5cc4b088ef5473321f4386b/work/a65cab32a5cc4b088ef5473321f4386b_id_rsa.pub 2025-01-09 08:02:34.363321 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-09 08:02:34.363339 | ubuntu-noble -> localhost | SHA256:kRTQOeiC4d6L9h1/tztnCi95Hjef3uxbf2uj/W3MzCk zuul-build-sshkey 2025-01-09 08:02:34.363357 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-09 08:02:34.363377 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-09 08:02:34.363395 | ubuntu-noble -> localhost | | .+oo | 2025-01-09 08:02:34.363412 | ubuntu-noble -> localhost | | . ..+. | 2025-01-09 08:02:34.363428 | ubuntu-noble -> localhost | | . o . o. | 2025-01-09 08:02:34.363457 | ubuntu-noble -> localhost | | o . . . | 2025-01-09 08:02:34.363474 | ubuntu-noble -> localhost | | . . . S | 2025-01-09 08:02:34.363490 | ubuntu-noble -> localhost | | . . | 2025-01-09 08:02:34.363506 | ubuntu-noble -> localhost | | . .. ... o=o| 2025-01-09 08:02:34.363523 | ubuntu-noble -> localhost | | o .. o +o+E+B&| 2025-01-09 08:02:34.363539 | ubuntu-noble -> localhost | | . .. . .. =*O=O#| 2025-01-09 08:02:34.363555 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-09 08:02:34.363595 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.688348 2025-01-09 08:02:34.370759 | 2025-01-09 08:02:34.370854 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-09 08:02:34.401897 | ubuntu-noble | ok 2025-01-09 08:02:34.411472 | ubuntu-noble | included: /var/lib/zuul/builds/a65cab32a5cc4b088ef5473321f4386b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-09 08:02:34.422464 | 2025-01-09 08:02:34.422536 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-09 08:02:34.436418 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:34.443637 | 2025-01-09 08:02:34.443743 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-09 08:02:35.268060 | ubuntu-noble | changed 2025-01-09 08:02:35.279780 | 2025-01-09 08:02:35.279885 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-09 08:02:35.578564 | ubuntu-noble | ok 2025-01-09 08:02:35.593041 | 2025-01-09 08:02:35.593141 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-09 08:02:36.350692 | ubuntu-noble | changed 2025-01-09 08:02:36.360261 | 2025-01-09 08:02:36.360369 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-09 08:02:37.077563 | ubuntu-noble | changed 2025-01-09 08:02:37.084510 | 2025-01-09 08:02:37.084615 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-09 08:02:37.140314 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:37.148181 | 2025-01-09 08:02:37.148282 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-09 08:02:38.250690 | ubuntu-noble -> localhost | changed 2025-01-09 08:02:38.355911 | 2025-01-09 08:02:38.356044 | TASK [add-build-sshkey : Add back temp key] 2025-01-09 08:02:38.987309 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a65cab32a5cc4b088ef5473321f4386b/work/a65cab32a5cc4b088ef5473321f4386b_id_rsa (zuul-build-sshkey) 2025-01-09 08:02:38.987520 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.028597 2025-01-09 08:02:39.009071 | 2025-01-09 08:02:39.009187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-09 08:02:39.446293 | ubuntu-noble | ok 2025-01-09 08:02:39.453110 | 2025-01-09 08:02:39.453210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-09 08:02:39.476907 | ubuntu-noble | skipping: Conditional result was False 2025-01-09 08:02:39.490101 | 2025-01-09 08:02:39.490208 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-09 08:02:39.941472 | ubuntu-noble | ok 2025-01-09 08:02:39.975829 | 2025-01-09 08:02:39.975942 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-09 08:02:40.028311 | ubuntu-noble | ok 2025-01-09 08:02:40.034971 | 2025-01-09 08:02:40.035064 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-09 08:02:40.530590 | ubuntu-noble -> localhost | ok 2025-01-09 08:02:40.539138 | 2025-01-09 08:02:40.539233 | TASK [validate-host : Collect information about the host] 2025-01-09 08:02:41.810774 | ubuntu-noble | ok 2025-01-09 08:02:41.828132 | 2025-01-09 08:02:41.828239 | TASK [validate-host : Sanitize hostname] 2025-01-09 08:02:41.929501 | ubuntu-noble | ok 2025-01-09 08:02:41.967042 | 2025-01-09 08:02:41.967158 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-09 08:02:42.575272 | ubuntu-noble -> localhost | changed 2025-01-09 08:02:42.581773 | 2025-01-09 08:02:42.581862 | TASK [validate-host : Collect information about zuul worker] 2025-01-09 08:02:43.090775 | ubuntu-noble | ok 2025-01-09 08:02:43.096647 | 2025-01-09 08:02:43.096764 | TASK [validate-host : Write out all zuul information for each host] 2025-01-09 08:02:43.714605 | ubuntu-noble -> localhost | changed 2025-01-09 08:02:43.727224 | 2025-01-09 08:02:43.727324 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-09 08:02:44.049443 | ubuntu-noble | ok 2025-01-09 08:02:44.056145 | 2025-01-09 08:02:44.056237 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-09 08:02:45.307765 | ubuntu-noble | changed: 2025-01-09 08:02:45.308029 | ubuntu-noble | cd+++++++++ src/ 2025-01-09 08:02:45.308066 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-09 08:02:45.308091 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-09 08:02:45.308112 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-01-09 08:02:45.308132 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.006773 2025-01-09 08:04:33.213896 | 2025-01-09 08:04:33.214251 | TASK [upload-logs : Upload logs to log server] 2025-01-09 08:04:33.788504 | localhost | Output suppressed because no_log was given 2025-01-09 08:04:33.794652 | 2025-01-09 08:04:33.794874 | LOOP [upload-logs : Compress console log and json output] 2025-01-09 08:04:33.869080 | localhost | skipping: Conditional result was False 2025-01-09 08:04:33.888408 | localhost | skipping: Conditional result was False 2025-01-09 08:04:33.901124 | 2025-01-09 08:04:33.901311 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-09 08:04:33.974533 | localhost | skipping: Conditional result was False 2025-01-09 08:04:33.975423 | 2025-01-09 08:04:33.996296 | localhost | skipping: Conditional result was False 2025-01-09 08:04:34.005139 | 2025-01-09 08:04:34.005271 | LOOP [upload-logs : Upload console log and json output]