2026-06-03 01:27:55.799875 | Job console starting 2026-06-03 01:27:55.817268 | Updating git repos 2026-06-03 01:27:55.892780 | Cloning repos into workspace 2026-06-03 01:27:57.266916 | Restoring repo states 2026-06-03 01:27:57.274212 | Merging changes 2026-06-03 01:27:57.556871 | Checking out repos 2026-06-03 01:27:57.593250 | Preparing playbooks 2026-06-03 01:27:58.708739 | Running Ansible setup 2026-06-03 01:28:03.262201 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-03 01:28:03.931779 | 2026-06-03 01:28:03.931921 | PLAY [localhost] 2026-06-03 01:28:03.940066 | 2026-06-03 01:28:03.940141 | TASK [Gathering Facts] 2026-06-03 01:28:04.849138 | localhost | ok 2026-06-03 01:28:04.856430 | 2026-06-03 01:28:04.856525 | TASK [Setup log path fact] 2026-06-03 01:28:04.876415 | localhost | ok 2026-06-03 01:28:04.886884 | 2026-06-03 01:28:04.886998 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 01:28:04.916538 | localhost | ok 2026-06-03 01:28:04.928266 | 2026-06-03 01:28:04.928432 | TASK [emit-job-header : Print job information] 2026-06-03 01:28:04.978663 | # Job Information 2026-06-03 01:28:04.978857 | Ansible Version: 2.16.18 2026-06-03 01:28:04.978890 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-06-03 01:28:04.978913 | Pipeline: check 2026-06-03 01:28:04.978935 | Executor: 2d72f0692154 2026-06-03 01:28:04.978955 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/133 2026-06-03 01:28:04.978978 | Event ID: 2d998f80-5eeb-11f1-92ca-7829ebcb9ee8 2026-06-03 01:28:04.982601 | 2026-06-03 01:28:04.982781 | LOOP [emit-job-header : Print node information] 2026-06-03 01:28:05.079272 | localhost | ok: 2026-06-03 01:28:05.615298 | localhost | # Node Information 2026-06-03 01:28:05.615525 | localhost | Inventory Hostname: rockylinux-9 2026-06-03 01:28:05.615583 | localhost | Hostname: np0000178356 2026-06-03 01:28:05.615629 | localhost | Username: zuul 2026-06-03 01:28:05.615680 | localhost | Distro: Rocky 9.7 2026-06-03 01:28:05.615724 | localhost | Provider: yul1 2026-06-03 01:28:05.615766 | localhost | Region: ca-ymq-1 2026-06-03 01:28:05.615807 | localhost | Label: rockylinux-9 2026-06-03 01:28:05.615846 | localhost | Product Name: OpenStack Nova 2026-06-03 01:28:05.615886 | localhost | Interface IP: 199.19.213.183 2026-06-03 01:28:05.632399 | 2026-06-03 01:28:05.632562 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-03 01:28:06.031527 | localhost -> localhost | changed 2026-06-03 01:28:06.041436 | 2026-06-03 01:28:06.041563 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-03 01:28:08.818925 | localhost -> localhost | changed 2026-06-03 01:28:08.825485 | 2026-06-03 01:28:08.825539 | PLAY [all] 2026-06-03 01:28:08.839011 | 2026-06-03 01:28:08.839106 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-03 01:28:09.450947 | rockylinux-9 -> localhost | ok 2026-06-03 01:28:09.456999 | 2026-06-03 01:28:09.457078 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-03 01:28:09.489017 | rockylinux-9 | ok 2026-06-03 01:28:09.506084 | rockylinux-9 | included: /var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-03 01:28:09.512815 | 2026-06-03 01:28:09.512883 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-03 01:28:10.505231 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-06-03 01:28:10.505461 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/0deb5bb486194cc0ac2d073c37451dbe_id_rsa 2026-06-03 01:28:10.505511 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/0deb5bb486194cc0ac2d073c37451dbe_id_rsa.pub 2026-06-03 01:28:10.505549 | rockylinux-9 -> localhost | The key fingerprint is: 2026-06-03 01:28:10.505584 | rockylinux-9 -> localhost | SHA256:3ZU62nhEAV5dXizED1YZYFqR4aDk+0yoL5tTFWQYFrw zuul-build-sshkey 2026-06-03 01:28:10.505632 | rockylinux-9 -> localhost | The key's randomart image is: 2026-06-03 01:28:10.505667 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-06-03 01:28:10.505709 | rockylinux-9 -> localhost | | .=*=oX*=*| 2026-06-03 01:28:10.505746 | rockylinux-9 -> localhost | | ++oo*o*+o| 2026-06-03 01:28:10.505780 | rockylinux-9 -> localhost | | oo.ooo+.| 2026-06-03 01:28:10.505810 | rockylinux-9 -> localhost | | Eo+ o .| 2026-06-03 01:28:10.505842 | rockylinux-9 -> localhost | | Soo.= | 2026-06-03 01:28:10.505874 | rockylinux-9 -> localhost | | ..+= . | 2026-06-03 01:28:10.505907 | rockylinux-9 -> localhost | | .. ooo | 2026-06-03 01:28:10.505941 | rockylinux-9 -> localhost | | oo . | 2026-06-03 01:28:10.505977 | rockylinux-9 -> localhost | | o+. | 2026-06-03 01:28:10.506008 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-06-03 01:28:10.506093 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.496128 2026-06-03 01:28:10.514063 | 2026-06-03 01:28:10.514207 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-03 01:28:10.557693 | rockylinux-9 | ok 2026-06-03 01:28:10.576331 | rockylinux-9 | included: /var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-03 01:28:10.590549 | 2026-06-03 01:28:10.590708 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-03 01:28:10.665524 | rockylinux-9 | skipping: Conditional result was False 2026-06-03 01:28:10.678448 | 2026-06-03 01:28:10.678592 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-03 01:28:11.195153 | rockylinux-9 | changed 2026-06-03 01:28:11.203634 | 2026-06-03 01:28:11.203699 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-03 01:28:11.446589 | rockylinux-9 | ok 2026-06-03 01:28:11.510307 | 2026-06-03 01:28:11.510408 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-03 01:28:12.409919 | rockylinux-9 | changed 2026-06-03 01:28:12.416535 | 2026-06-03 01:28:12.416618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-03 01:28:13.362887 | rockylinux-9 | changed 2026-06-03 01:28:13.372522 | 2026-06-03 01:28:13.372679 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-03 01:28:13.399882 | rockylinux-9 | skipping: Conditional result was False 2026-06-03 01:28:13.406255 | 2026-06-03 01:28:13.406341 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-03 01:28:15.739152 | rockylinux-9 -> localhost | changed 2026-06-03 01:28:15.748606 | 2026-06-03 01:28:15.749487 | TASK [add-build-sshkey : Add back temp key] 2026-06-03 01:28:16.077254 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/0deb5bb486194cc0ac2d073c37451dbe_id_rsa (zuul-build-sshkey) 2026-06-03 01:28:16.077452 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.018257 2026-06-03 01:28:16.082263 | 2026-06-03 01:28:16.082329 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-03 01:28:16.517412 | rockylinux-9 | ok 2026-06-03 01:28:16.575016 | 2026-06-03 01:28:16.575125 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-03 01:28:16.601495 | rockylinux-9 | skipping: Conditional result was False 2026-06-03 01:28:16.612776 | 2026-06-03 01:28:16.612852 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-03 01:28:17.032028 | rockylinux-9 | ok 2026-06-03 01:28:17.039259 | 2026-06-03 01:28:17.039472 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-03 01:28:18.074801 | rockylinux-9 | Output suppressed because no_log was given 2026-06-03 01:28:18.085716 | 2026-06-03 01:28:18.085870 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-03 01:28:18.364157 | rockylinux-9 | ok: "logs" 2026-06-03 01:28:18.364425 | rockylinux-9 | ok: All items complete 2026-06-03 01:28:18.364454 | 2026-06-03 01:28:18.563912 | rockylinux-9 | ok: "artifacts" 2026-06-03 01:28:18.775869 | rockylinux-9 | ok: "docs" 2026-06-03 01:28:18.786178 | 2026-06-03 01:28:18.786331 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-03 01:28:19.038683 | rockylinux-9 | changed: "logs" 2026-06-03 01:28:19.324368 | rockylinux-9 | changed: "artifacts" 2026-06-03 01:28:19.463246 | rockylinux-9 | changed: "docs" 2026-06-03 01:28:19.469750 | 2026-06-03 01:28:19.469797 | PLAY RECAP 2026-06-03 01:28:19.469838 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 01:28:19.469867 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-03 01:28:19.469887 | 2026-06-03 01:28:19.604184 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-03 01:28:19.605754 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-03 01:28:20.207021 | 2026-06-03 01:28:20.207183 | PLAY [all] 2026-06-03 01:28:20.220046 | 2026-06-03 01:28:20.220187 | TASK [setup-uv : Extract archive] 2026-06-03 01:28:23.196116 | rockylinux-9 | changed 2026-06-03 01:28:23.203375 | 2026-06-03 01:28:23.203480 | TASK [setup-uv : Print version] 2026-06-03 01:28:23.225722 | [rockylinux-9] Waiting on logger 2026-06-03 01:28:23.741125 | rockylinux-9 | ok: Runtime: 0:00:00.015425 2026-06-03 01:28:23.750537 | 2026-06-03 01:28:23.750660 | TASK [Install Ansible collection siblings] 2026-06-03 01:28:24.206093 | rockylinux-9 | ok: 2026-06-03 01:28:24.206287 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-06-03 01:28:24.206328 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-06-03 01:28:24.208826 | 2026-06-03 01:28:24.208889 | PLAY RECAP 2026-06-03 01:28:24.208947 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 01:28:24.209003 | 2026-06-03 01:28:24.341975 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-03 01:28:24.344273 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-03 01:28:25.004023 | 2026-06-03 01:28:25.004198 | PLAY [all] 2026-06-03 01:28:25.018037 | 2026-06-03 01:28:25.018201 | TASK [Copy inventory file for Zuul] 2026-06-03 01:28:26.347301 | rockylinux-9 | changed 2026-06-03 01:28:26.353965 | 2026-06-03 01:28:26.354056 | TASK [Switch "ansible_host" to private IP] 2026-06-03 01:28:26.805676 | rockylinux-9 | changed: 1 replacements made 2026-06-03 01:28:26.908333 | 2026-06-03 01:28:26.908490 | TASK [Run Molecule scenario] 2026-06-03 01:28:26.933668 | [rockylinux-9] Waiting on logger 2026-06-03 01:28:35.081775 | [rockylinux-9] Waiting on logger 2026-06-03 01:28:44.241153 | [rockylinux-9] Waiting on logger 2026-06-03 01:28:54.406131 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:04.613882 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:14.374004 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:24.549998 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:34.726095 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:44.901969 | [rockylinux-9] Waiting on logger 2026-06-03 01:29:55.078163 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:04.235514 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:14.438057 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:24.614261 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:34.790113 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:44.966255 | [rockylinux-9] Waiting on logger 2026-06-03 01:30:55.146304 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:04.303600 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:14.473989 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:24.645965 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:34.826242 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:45.002015 | [rockylinux-9] Waiting on logger 2026-06-03 01:31:55.174341 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:04.336294 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:14.501718 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:24.682020 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:34.854127 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:45.030335 | [rockylinux-9] Waiting on logger 2026-06-03 01:32:55.205985 | [rockylinux-9] Waiting on logger 2026-06-03 01:33:04.357971 | [rockylinux-9] Waiting on logger 2026-06-03 01:33:14.533922 | [rockylinux-9] Waiting on logger 2026-06-03 01:33:24.710171 | [rockylinux-9] Waiting on logger 2026-06-03 01:33:34.885943 | [rockylinux-9] Waiting on logger 2026-06-03 01:33:36.013219 | rockylinux-9 | ok: Runtime: 0:05:08.525162 2026-06-03 01:33:36.021962 | 2026-06-03 01:33:36.022027 | PLAY RECAP 2026-06-03 01:33:36.022088 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-03 01:33:36.022124 | 2026-06-03 01:33:36.149392 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-03 01:33:36.151977 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 01:33:36.713683 | 2026-06-03 01:33:36.713814 | PLAY [all] 2026-06-03 01:33:36.723933 | 2026-06-03 01:33:36.724008 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-03 01:33:36.760038 | rockylinux-9 | skipping: Conditional result was False 2026-06-03 01:33:36.769241 | 2026-06-03 01:33:36.769315 | TASK [fetch-output : Set log path for single node] 2026-06-03 01:33:36.811681 | rockylinux-9 | ok 2026-06-03 01:33:36.817763 | 2026-06-03 01:33:36.817849 | LOOP [fetch-output : Ensure local output dirs] 2026-06-03 01:33:37.182315 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/logs" 2026-06-03 01:33:37.405676 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/artifacts" 2026-06-03 01:33:37.628733 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/0deb5bb486194cc0ac2d073c37451dbe/work/docs" 2026-06-03 01:33:37.644264 | 2026-06-03 01:33:37.644366 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-03 01:33:38.325996 | rockylinux-9 | changed: .d..t...... ./ 2026-06-03 01:33:38.326279 | rockylinux-9 | changed: All items complete 2026-06-03 01:33:38.326314 | 2026-06-03 01:33:38.834732 | rockylinux-9 | changed: .d..t...... ./ 2026-06-03 01:33:39.341851 | rockylinux-9 | changed: .d..t...... ./ 2026-06-03 01:33:39.368813 | 2026-06-03 01:33:39.369037 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-03 01:33:39.788865 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007129 2026-06-03 01:33:40.011828 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007433 2026-06-03 01:33:40.030954 | 2026-06-03 01:33:40.031145 | PLAY [all] 2026-06-03 01:33:40.037499 | 2026-06-03 01:33:40.037571 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-03 01:33:40.513428 | rockylinux-9 | changed 2026-06-03 01:33:40.518607 | 2026-06-03 01:33:40.518663 | PLAY RECAP 2026-06-03 01:33:40.518710 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-03 01:33:40.518731 | 2026-06-03 01:33:40.669258 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-03 01:33:40.671549 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-03 01:33:41.273871 | 2026-06-03 01:33:41.274018 | PLAY [localhost] 2026-06-03 01:33:41.285111 | 2026-06-03 01:33:41.285184 | TASK [Generate Zuul manifest] 2026-06-03 01:33:41.304810 | localhost | ok 2026-06-03 01:33:41.321824 | 2026-06-03 01:33:41.321897 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-03 01:33:41.694447 | localhost | changed 2026-06-03 01:33:41.706699 | 2026-06-03 01:33:41.706774 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-03 01:33:41.741345 | localhost | ok 2026-06-03 01:33:41.750707 | 2026-06-03 01:33:41.750773 | TASK [Upload logs] 2026-06-03 01:33:41.774425 | localhost | ok 2026-06-03 01:33:41.838167 | 2026-06-03 01:33:41.838298 | TASK [Set zuul-log-path fact] 2026-06-03 01:33:41.861054 | localhost | ok 2026-06-03 01:33:41.873250 | 2026-06-03 01:33:41.873317 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-03 01:33:41.904001 | localhost | ok 2026-06-03 01:33:41.913271 | 2026-06-03 01:33:41.913367 | TASK [upload-logs : Create log directories] 2026-06-03 01:33:42.340940 | localhost | changed 2026-06-03 01:33:42.354611 | 2026-06-03 01:33:42.354758 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-03 01:33:42.792633 | localhost -> localhost | ok: Runtime: 0:00:00.005251 2026-06-03 01:33:42.799425 | 2026-06-03 01:33:42.799518 | TASK [upload-logs : Upload logs to log server] 2026-06-03 01:33:43.263906 | localhost | Output suppressed because no_log was given 2026-06-03 01:33:43.267699 | 2026-06-03 01:33:43.267762 | LOOP [upload-logs : Compress console log and json output] 2026-06-03 01:33:43.314190 | localhost | skipping: Conditional result was False 2026-06-03 01:33:43.320908 | localhost | skipping: Conditional result was False 2026-06-03 01:33:43.334142 | 2026-06-03 01:33:43.334332 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-03 01:33:43.377368 | localhost | skipping: Conditional result was False 2026-06-03 01:33:43.377781 | 2026-06-03 01:33:43.381337 | localhost | skipping: Conditional result was False 2026-06-03 01:33:43.399368 | 2026-06-03 01:33:43.399549 | LOOP [upload-logs : Upload console log and json output]