2026-06-09 16:14:45.315668 | Job console starting 2026-06-09 16:14:45.327869 | Updating git repos 2026-06-09 16:14:45.377399 | Cloning repos into workspace 2026-06-09 16:14:45.439804 | Restoring repo states 2026-06-09 16:14:45.451795 | Merging changes 2026-06-09 16:14:46.178833 | Checking out repos 2026-06-09 16:14:46.224345 | Preparing playbooks 2026-06-09 16:14:48.004915 | Running Ansible setup 2026-06-09 16:14:52.084399 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 16:14:52.775220 | 2026-06-09 16:14:52.817519 | PLAY [localhost] 2026-06-09 16:14:52.830882 | 2026-06-09 16:14:52.830988 | TASK [Gathering Facts] 2026-06-09 16:14:53.857941 | localhost | ok 2026-06-09 16:14:53.864915 | 2026-06-09 16:14:53.865016 | TASK [Setup log path fact] 2026-06-09 16:14:53.886983 | localhost | ok 2026-06-09 16:14:53.897868 | 2026-06-09 16:14:53.897940 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 16:14:53.933176 | localhost | ok 2026-06-09 16:14:54.187978 | 2026-06-09 16:14:54.188108 | TASK [emit-job-header : Print job information] 2026-06-09 16:14:54.235448 | # Job Information 2026-06-09 16:14:54.235636 | Ansible Version: 2.16.18 2026-06-09 16:14:54.235669 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-06-09 16:14:54.235692 | Pipeline: check 2026-06-09 16:14:54.235712 | Executor: 2d72f0692154 2026-06-09 16:14:54.235732 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/135 2026-06-09 16:14:54.235756 | Event ID: 2cce4c70-641e-11f1-8c62-24e0191aa320 2026-06-09 16:14:54.242174 | 2026-06-09 16:14:54.242253 | LOOP [emit-job-header : Print node information] 2026-06-09 16:14:54.351583 | localhost | ok: 2026-06-09 16:14:54.351799 | localhost | # Node Information 2026-06-09 16:14:54.351839 | localhost | Inventory Hostname: rockylinux-9 2026-06-09 16:14:54.351869 | localhost | Hostname: np0000179211 2026-06-09 16:14:54.351897 | localhost | Username: zuul 2026-06-09 16:14:54.351928 | localhost | Distro: Rocky 9.7 2026-06-09 16:14:54.351957 | localhost | Provider: yul1 2026-06-09 16:14:54.351983 | localhost | Region: ca-ymq-1 2026-06-09 16:14:54.352008 | localhost | Label: rockylinux-9 2026-06-09 16:14:54.352034 | localhost | Product Name: OpenStack Nova 2026-06-09 16:14:54.352059 | localhost | Interface IP: 199.204.45.205 2026-06-09 16:14:54.359343 | 2026-06-09 16:14:54.359489 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-09 16:14:54.830355 | localhost -> localhost | changed 2026-06-09 16:14:54.837131 | 2026-06-09 16:14:54.837207 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-09 16:14:55.837893 | localhost -> localhost | changed 2026-06-09 16:14:55.848635 | 2026-06-09 16:14:55.848708 | PLAY [all] 2026-06-09 16:14:55.865617 | 2026-06-09 16:14:55.865700 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-09 16:14:56.103975 | rockylinux-9 -> localhost | ok 2026-06-09 16:14:56.110014 | 2026-06-09 16:14:56.110090 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-09 16:14:56.142820 | rockylinux-9 | ok 2026-06-09 16:14:56.158842 | rockylinux-9 | included: /var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-09 16:14:56.165932 | 2026-06-09 16:14:56.166016 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-09 16:14:57.703481 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-06-09 16:14:57.703657 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/9ad2d1ee04bc4f6aa13af9b06af4a961_id_rsa 2026-06-09 16:14:57.703687 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/9ad2d1ee04bc4f6aa13af9b06af4a961_id_rsa.pub 2026-06-09 16:14:57.703709 | rockylinux-9 -> localhost | The key fingerprint is: 2026-06-09 16:14:57.703731 | rockylinux-9 -> localhost | SHA256:gVRHHHXeRWL0YJJejV/dMKtpKEAng0YZXpKXyzaZY5E zuul-build-sshkey 2026-06-09 16:14:57.703761 | rockylinux-9 -> localhost | The key's randomart image is: 2026-06-09 16:14:57.703783 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-06-09 16:14:57.703810 | rockylinux-9 -> localhost | | .+=*+oo+oooX==| 2026-06-09 16:14:57.703832 | rockylinux-9 -> localhost | | .==E= .. .*oB*| 2026-06-09 16:14:57.703852 | rockylinux-9 -> localhost | | ..oo=. . .o.+| 2026-06-09 16:14:57.703873 | rockylinux-9 -> localhost | | X. . ..o .| 2026-06-09 16:14:57.703893 | rockylinux-9 -> localhost | | o oS . + | 2026-06-09 16:14:57.703913 | rockylinux-9 -> localhost | | . . | 2026-06-09 16:14:57.703932 | rockylinux-9 -> localhost | | | 2026-06-09 16:14:57.703952 | rockylinux-9 -> localhost | | | 2026-06-09 16:14:57.703974 | rockylinux-9 -> localhost | | | 2026-06-09 16:14:57.703994 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-06-09 16:14:57.704041 | rockylinux-9 -> localhost | ok: Runtime: 0:00:01.053339 2026-06-09 16:14:57.708543 | 2026-06-09 16:14:57.708604 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-09 16:14:57.726622 | rockylinux-9 | ok 2026-06-09 16:14:57.734298 | rockylinux-9 | included: /var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-09 16:14:57.742509 | 2026-06-09 16:14:57.742573 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-09 16:14:57.765052 | rockylinux-9 | skipping: Conditional result was False 2026-06-09 16:14:57.774270 | 2026-06-09 16:14:57.774355 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-09 16:14:58.306145 | rockylinux-9 | changed 2026-06-09 16:14:58.314083 | 2026-06-09 16:14:58.314220 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-09 16:14:58.558788 | rockylinux-9 | ok 2026-06-09 16:14:58.563580 | 2026-06-09 16:14:58.563649 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-09 16:14:59.509734 | rockylinux-9 | changed 2026-06-09 16:14:59.518275 | 2026-06-09 16:14:59.518356 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-09 16:15:00.472593 | rockylinux-9 | changed 2026-06-09 16:15:00.478943 | 2026-06-09 16:15:00.479037 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-09 16:15:00.503072 | rockylinux-9 | skipping: Conditional result was False 2026-06-09 16:15:00.512696 | 2026-06-09 16:15:00.512809 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-09 16:15:00.969797 | rockylinux-9 -> localhost | changed 2026-06-09 16:15:00.981762 | 2026-06-09 16:15:00.981854 | TASK [add-build-sshkey : Add back temp key] 2026-06-09 16:15:01.273749 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/9ad2d1ee04bc4f6aa13af9b06af4a961_id_rsa (zuul-build-sshkey) 2026-06-09 16:15:01.273960 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.008375 2026-06-09 16:15:01.278557 | 2026-06-09 16:15:01.278619 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-09 16:15:01.677432 | rockylinux-9 | ok 2026-06-09 16:15:01.682890 | 2026-06-09 16:15:01.682978 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-09 16:15:01.711235 | rockylinux-9 | skipping: Conditional result was False 2026-06-09 16:15:01.727670 | 2026-06-09 16:15:01.727734 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-09 16:15:02.149635 | rockylinux-9 | ok 2026-06-09 16:15:02.158228 | 2026-06-09 16:15:02.158305 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-09 16:15:03.135109 | rockylinux-9 | Output suppressed because no_log was given 2026-06-09 16:15:03.143053 | 2026-06-09 16:15:03.143119 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-09 16:15:03.399412 | rockylinux-9 | ok: "logs" 2026-06-09 16:15:03.399826 | rockylinux-9 | ok: All items complete 2026-06-09 16:15:03.399869 | 2026-06-09 16:15:03.614599 | rockylinux-9 | ok: "artifacts" 2026-06-09 16:15:03.843806 | rockylinux-9 | ok: "docs" 2026-06-09 16:15:03.855094 | 2026-06-09 16:15:03.855241 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-09 16:15:04.114172 | rockylinux-9 | changed: "logs" 2026-06-09 16:15:04.373883 | rockylinux-9 | changed: "artifacts" 2026-06-09 16:15:04.569624 | rockylinux-9 | changed: "docs" 2026-06-09 16:15:04.580815 | 2026-06-09 16:15:04.581002 | PLAY RECAP 2026-06-09 16:15:04.581051 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 16:15:04.581084 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-09 16:15:04.581106 | 2026-06-09 16:15:04.749400 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 16:15:04.750580 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-09 16:15:05.409112 | 2026-06-09 16:15:05.409581 | PLAY [all] 2026-06-09 16:15:05.420763 | 2026-06-09 16:15:05.420889 | TASK [setup-uv : Extract archive] 2026-06-09 16:15:08.175543 | rockylinux-9 | changed 2026-06-09 16:15:08.182866 | 2026-06-09 16:15:08.182987 | TASK [setup-uv : Print version] 2026-06-09 16:15:08.216887 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:08.733122 | rockylinux-9 | ok: Runtime: 0:00:00.016588 2026-06-09 16:15:08.741355 | 2026-06-09 16:15:08.741435 | TASK [Install Ansible collection siblings] 2026-06-09 16:15:09.204640 | rockylinux-9 | ok: 2026-06-09 16:15:09.205053 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-06-09 16:15:09.205123 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-06-09 16:15:09.207582 | 2026-06-09 16:15:09.207665 | PLAY RECAP 2026-06-09 16:15:09.207761 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 16:15:09.207814 | 2026-06-09 16:15:09.383447 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-09 16:15:09.385783 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-09 16:15:09.989070 | 2026-06-09 16:15:09.989276 | PLAY [all] 2026-06-09 16:15:10.006579 | 2026-06-09 16:15:10.006780 | TASK [Copy inventory file for Zuul] 2026-06-09 16:15:11.337995 | rockylinux-9 | changed 2026-06-09 16:15:11.345034 | 2026-06-09 16:15:11.345151 | TASK [Switch "ansible_host" to private IP] 2026-06-09 16:15:11.772768 | rockylinux-9 | changed: 1 replacements made 2026-06-09 16:15:11.780014 | 2026-06-09 16:15:11.780110 | TASK [Run Molecule scenario] 2026-06-09 16:15:11.804089 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:19.941859 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:30.122075 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:39.275727 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:49.446383 | [rockylinux-9] Waiting on logger 2026-06-09 16:15:59.626143 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:09.797981 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:19.974080 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:30.150238 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:39.307532 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:49.478197 | [rockylinux-9] Waiting on logger 2026-06-09 16:16:59.654110 | [rockylinux-9] Waiting on logger 2026-06-09 16:17:09.830082 | [rockylinux-9] Waiting on logger 2026-06-09 16:17:13.198181 | rockylinux-9 | ok: Runtime: 0:02:00.750159 2026-06-09 16:17:13.204858 | 2026-06-09 16:17:13.204910 | PLAY RECAP 2026-06-09 16:17:13.204970 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 16:17:13.204996 | 2026-06-09 16:17:13.339884 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-09 16:17:13.709634 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 16:17:14.323108 | 2026-06-09 16:17:14.323240 | PLAY [all] 2026-06-09 16:17:14.336630 | 2026-06-09 16:17:14.337070 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-09 16:17:14.386127 | rockylinux-9 | skipping: Conditional result was False 2026-06-09 16:17:14.393780 | 2026-06-09 16:17:14.393887 | TASK [fetch-output : Set log path for single node] 2026-06-09 16:17:14.437486 | rockylinux-9 | ok 2026-06-09 16:17:14.443775 | 2026-06-09 16:17:14.443880 | LOOP [fetch-output : Ensure local output dirs] 2026-06-09 16:17:14.886630 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/logs" 2026-06-09 16:17:15.111289 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/artifacts" 2026-06-09 16:17:15.322124 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9ad2d1ee04bc4f6aa13af9b06af4a961/work/docs" 2026-06-09 16:17:15.347282 | 2026-06-09 16:17:15.347445 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-09 16:17:16.057180 | rockylinux-9 | changed: .d..t...... ./ 2026-06-09 16:17:16.057398 | rockylinux-9 | changed: All items complete 2026-06-09 16:17:16.057425 | 2026-06-09 16:17:16.592697 | rockylinux-9 | changed: .d..t...... ./ 2026-06-09 16:17:17.117701 | rockylinux-9 | changed: .d..t...... ./ 2026-06-09 16:17:17.139613 | 2026-06-09 16:17:17.139719 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-09 16:17:17.581147 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008971 2026-06-09 16:17:17.818820 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008244 2026-06-09 16:17:17.836619 | 2026-06-09 16:17:17.836769 | PLAY [all] 2026-06-09 16:17:17.844329 | 2026-06-09 16:17:17.844412 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-09 16:17:18.334527 | rockylinux-9 | changed 2026-06-09 16:17:18.339860 | 2026-06-09 16:17:18.339913 | PLAY RECAP 2026-06-09 16:17:18.339960 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-09 16:17:18.339981 | 2026-06-09 16:17:18.468787 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 16:17:18.470102 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-09 16:17:19.110032 | 2026-06-09 16:17:19.110576 | PLAY [localhost] 2026-06-09 16:17:19.122150 | 2026-06-09 16:17:19.122226 | TASK [Generate Zuul manifest] 2026-06-09 16:17:19.166372 | localhost | ok 2026-06-09 16:17:19.183990 | 2026-06-09 16:17:19.184082 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-09 16:17:19.571703 | localhost | changed 2026-06-09 16:17:19.585332 | 2026-06-09 16:17:19.585425 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-09 16:17:19.619450 | localhost | ok 2026-06-09 16:17:19.626833 | 2026-06-09 16:17:19.626896 | TASK [Upload logs] 2026-06-09 16:17:19.648815 | localhost | ok 2026-06-09 16:17:19.714065 | 2026-06-09 16:17:19.714233 | TASK [Set zuul-log-path fact] 2026-06-09 16:17:19.734590 | localhost | ok 2026-06-09 16:17:19.756333 | 2026-06-09 16:17:19.756511 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 16:17:19.789902 | localhost | ok 2026-06-09 16:17:19.798507 | 2026-06-09 16:17:19.798578 | TASK [upload-logs : Create log directories] 2026-06-09 16:17:20.225299 | localhost | changed 2026-06-09 16:17:20.233333 | 2026-06-09 16:17:20.233407 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-09 16:17:20.653420 | localhost -> localhost | ok: Runtime: 0:00:00.006614 2026-06-09 16:17:20.658747 | 2026-06-09 16:17:20.658815 | TASK [upload-logs : Upload logs to log server] 2026-06-09 16:17:21.128098 | localhost | Output suppressed because no_log was given 2026-06-09 16:17:21.132077 | 2026-06-09 16:17:21.132149 | LOOP [upload-logs : Compress console log and json output] 2026-06-09 16:17:21.180172 | localhost | skipping: Conditional result was False 2026-06-09 16:17:21.187474 | localhost | skipping: Conditional result was False 2026-06-09 16:17:21.201366 | 2026-06-09 16:17:21.201518 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-09 16:17:21.245823 | localhost | skipping: Conditional result was False 2026-06-09 16:17:21.246246 | 2026-06-09 16:17:21.249553 | localhost | skipping: Conditional result was False 2026-06-09 16:17:21.264929 | 2026-06-09 16:17:21.265121 | LOOP [upload-logs : Upload console log and json output]