2026-03-18 00:49:28.729977 | Job console starting 2026-03-18 00:49:29.638203 | Updating git repos 2026-03-18 00:49:29.662530 | Cloning repos into workspace 2026-03-18 00:49:35.354224 | Restoring repo states 2026-03-18 00:49:35.379324 | Merging changes 2026-03-18 00:49:36.681686 | Checking out repos 2026-03-18 00:49:39.577478 | Preparing playbooks 2026-03-18 00:50:02.174425 | Running Ansible setup 2026-03-18 00:50:05.845492 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 00:50:06.500833 | 2026-03-18 00:50:07.120912 | PLAY [localhost] 2026-03-18 00:50:07.134225 | 2026-03-18 00:50:07.134328 | TASK [Gathering Facts] 2026-03-18 00:50:08.056043 | localhost | ok 2026-03-18 00:50:08.069311 | 2026-03-18 00:50:08.069480 | TASK [Setup log path fact] 2026-03-18 00:50:08.103076 | localhost | ok 2026-03-18 00:50:08.141937 | 2026-03-18 00:50:08.142069 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 00:50:08.184023 | localhost | ok 2026-03-18 00:50:08.192850 | 2026-03-18 00:50:08.254052 | TASK [emit-job-header : Print job information] 2026-03-18 00:50:08.296124 | # Job Information 2026-03-18 00:50:08.296538 | Ansible Version: 2.16.16 2026-03-18 00:50:08.296599 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-03-18 00:50:08.296634 | Pipeline: check 2026-03-18 00:50:08.296664 | Executor: 0a8996d2b663 2026-03-18 00:50:08.296691 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/103 2026-03-18 00:50:08.296722 | Event ID: 2ec8c6a0-2264-11f1-8f62-f695a841fb8e 2026-03-18 00:50:08.302190 | 2026-03-18 00:50:08.302285 | LOOP [emit-job-header : Print node information] 2026-03-18 00:50:08.478510 | localhost | ok: 2026-03-18 00:50:08.478678 | localhost | # Node Information 2026-03-18 00:50:08.478708 | localhost | Inventory Hostname: rockylinux-9 2026-03-18 00:50:08.478731 | localhost | Hostname: np0000159732 2026-03-18 00:50:08.478751 | localhost | Username: zuul 2026-03-18 00:50:08.478776 | localhost | Distro: Rocky 9.7 2026-03-18 00:50:08.478800 | localhost | Provider: yul1 2026-03-18 00:50:08.478820 | localhost | Region: ca-ymq-1 2026-03-18 00:50:08.478838 | localhost | Label: rockylinux-9 2026-03-18 00:50:08.478856 | localhost | Product Name: OpenStack Nova 2026-03-18 00:50:08.478875 | localhost | Interface IP: 199.204.45.33 2026-03-18 00:50:08.491234 | 2026-03-18 00:50:08.491383 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-18 00:50:09.348195 | localhost -> localhost | changed 2026-03-18 00:50:09.360760 | 2026-03-18 00:50:09.361037 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-18 00:50:10.342887 | localhost -> localhost | changed 2026-03-18 00:50:10.349052 | 2026-03-18 00:50:10.349109 | PLAY [all] 2026-03-18 00:50:10.357987 | 2026-03-18 00:50:10.358123 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-18 00:50:10.587050 | rockylinux-9 -> localhost | ok 2026-03-18 00:50:10.592591 | 2026-03-18 00:50:10.592663 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-18 00:50:10.623863 | rockylinux-9 | ok 2026-03-18 00:50:10.639565 | rockylinux-9 | included: /var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-18 00:50:10.644602 | 2026-03-18 00:50:10.644663 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-18 00:50:11.575607 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-03-18 00:50:11.575811 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/3ec7602e4c2041fe897a80c583a7bcf7_id_rsa 2026-03-18 00:50:11.575857 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/3ec7602e4c2041fe897a80c583a7bcf7_id_rsa.pub 2026-03-18 00:50:11.575895 | rockylinux-9 -> localhost | The key fingerprint is: 2026-03-18 00:50:11.575926 | rockylinux-9 -> localhost | SHA256:A/grmME5pGj0XRb/N/UYxb/jJOq0MJxr+zs9MIWxBSk zuul-build-sshkey 2026-03-18 00:50:11.575977 | rockylinux-9 -> localhost | The key's randomart image is: 2026-03-18 00:50:11.576008 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-03-18 00:50:11.576048 | rockylinux-9 -> localhost | | . .o ..| 2026-03-18 00:50:11.576080 | rockylinux-9 -> localhost | | . oE o . ..| 2026-03-18 00:50:11.576113 | rockylinux-9 -> localhost | | .. . .o .. = ...| 2026-03-18 00:50:11.576156 | rockylinux-9 -> localhost | |o+....o. .o ..oo| 2026-03-18 00:50:11.576200 | rockylinux-9 -> localhost | |o.=. .. S ..o. o| 2026-03-18 00:50:11.576283 | rockylinux-9 -> localhost | |. = ....o...+ | 2026-03-18 00:50:11.576337 | rockylinux-9 -> localhost | | o . . = .= + .| 2026-03-18 00:50:11.576375 | rockylinux-9 -> localhost | | . .=o.o . | 2026-03-18 00:50:11.576408 | rockylinux-9 -> localhost | | .o+=o . | 2026-03-18 00:50:11.576438 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-03-18 00:50:11.576513 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.455719 2026-03-18 00:50:11.581816 | 2026-03-18 00:50:11.581883 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-18 00:50:11.601797 | rockylinux-9 | ok 2026-03-18 00:50:11.610984 | rockylinux-9 | included: /var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-18 00:50:11.619009 | 2026-03-18 00:50:11.619073 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-18 00:50:11.643379 | rockylinux-9 | skipping: Conditional result was False 2026-03-18 00:50:11.654063 | 2026-03-18 00:50:11.654134 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-18 00:50:12.167702 | rockylinux-9 | changed 2026-03-18 00:50:12.183862 | 2026-03-18 00:50:12.184117 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-18 00:50:12.462997 | rockylinux-9 | ok 2026-03-18 00:50:12.487872 | 2026-03-18 00:50:12.487996 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-18 00:50:13.458167 | rockylinux-9 | changed 2026-03-18 00:50:13.467943 | 2026-03-18 00:50:13.468030 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-18 00:50:14.397643 | rockylinux-9 | changed 2026-03-18 00:50:15.104510 | 2026-03-18 00:50:15.104823 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-18 00:50:15.132640 | rockylinux-9 | skipping: Conditional result was False 2026-03-18 00:50:15.144544 | 2026-03-18 00:50:15.145031 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-18 00:50:15.554292 | rockylinux-9 -> localhost | changed 2026-03-18 00:50:15.571062 | 2026-03-18 00:50:15.571195 | TASK [add-build-sshkey : Add back temp key] 2026-03-18 00:50:16.675962 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/3ec7602e4c2041fe897a80c583a7bcf7_id_rsa (zuul-build-sshkey) 2026-03-18 00:50:16.676287 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.011691 2026-03-18 00:50:16.686213 | 2026-03-18 00:50:16.686302 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-18 00:50:17.089063 | rockylinux-9 | ok 2026-03-18 00:50:17.094729 | 2026-03-18 00:50:17.094823 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-18 00:50:17.119127 | rockylinux-9 | skipping: Conditional result was False 2026-03-18 00:50:17.134643 | 2026-03-18 00:50:17.134758 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-18 00:50:17.553017 | rockylinux-9 | ok 2026-03-18 00:50:17.559022 | 2026-03-18 00:50:17.559141 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-18 00:50:18.501831 | rockylinux-9 | Output suppressed because no_log was given 2026-03-18 00:50:18.524783 | 2026-03-18 00:50:18.524885 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-18 00:50:18.805284 | rockylinux-9 | ok: "logs" 2026-03-18 00:50:18.885278 | rockylinux-9 | ok: All items complete 2026-03-18 00:50:18.885442 | 2026-03-18 00:50:19.022987 | rockylinux-9 | ok: "artifacts" 2026-03-18 00:50:19.239343 | rockylinux-9 | ok: "docs" 2026-03-18 00:50:19.261411 | 2026-03-18 00:50:19.261624 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-18 00:50:19.523202 | rockylinux-9 | changed: "logs" 2026-03-18 00:50:19.757761 | rockylinux-9 | changed: "artifacts" 2026-03-18 00:50:19.997041 | rockylinux-9 | changed: "docs" 2026-03-18 00:50:20.017137 | 2026-03-18 00:50:20.017286 | PLAY RECAP 2026-03-18 00:50:20.017354 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 00:50:20.017397 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-18 00:50:20.017428 | 2026-03-18 00:50:20.169268 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 00:50:20.171599 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 00:50:20.789116 | 2026-03-18 00:50:20.789253 | PLAY [all] 2026-03-18 00:50:20.801002 | 2026-03-18 00:50:20.801178 | TASK [setup-uv : Extract archive] 2026-03-18 00:50:23.632866 | rockylinux-9 | changed 2026-03-18 00:50:23.639357 | 2026-03-18 00:50:23.639433 | TASK [setup-uv : Print version] 2026-03-18 00:50:23.667686 | [rockylinux-9] Waiting on logger 2026-03-18 00:50:24.182330 | rockylinux-9 | ok: Runtime: 0:00:00.015305 2026-03-18 00:50:24.189737 | 2026-03-18 00:50:24.189860 | PLAY RECAP 2026-03-18 00:50:24.189930 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 00:50:24.189973 | 2026-03-18 00:50:24.306843 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 00:50:24.458832 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 00:50:25.106956 | 2026-03-18 00:50:25.107102 | PLAY [all] 2026-03-18 00:50:25.118114 | 2026-03-18 00:50:25.118225 | TASK [Copy inventory file for Zuul] 2026-03-18 00:50:26.500839 | rockylinux-9 | changed 2026-03-18 00:50:26.508293 | 2026-03-18 00:50:26.508501 | TASK [Switch "ansible_host" to private IP] 2026-03-18 00:50:26.855286 | rockylinux-9 | changed: 1 replacements made 2026-03-18 00:50:26.863545 | 2026-03-18 00:50:26.863642 | TASK [Run Molecule scenario] 2026-03-18 00:50:26.885270 | [rockylinux-9] Waiting on logger 2026-03-18 00:50:35.014519 | [rockylinux-9] Waiting on logger 2026-03-18 00:50:45.190128 | [rockylinux-9] Waiting on logger 2026-03-18 00:50:55.366101 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:05.541952 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:14.917921 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:25.094014 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:35.270163 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:45.446173 | [rockylinux-9] Waiting on logger 2026-03-18 00:51:55.621978 | [rockylinux-9] Waiting on logger 2026-03-18 00:52:04.779551 | [rockylinux-9] Waiting on logger 2026-03-18 00:52:05.909586 | rockylinux-9 | ok: Runtime: 0:01:37.758303 2026-03-18 00:52:05.916010 | 2026-03-18 00:52:05.916086 | PLAY RECAP 2026-03-18 00:52:05.916159 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 00:52:05.916193 | 2026-03-18 00:52:06.093646 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 00:52:06.096406 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 00:52:06.674788 | 2026-03-18 00:52:06.675321 | PLAY [all] 2026-03-18 00:52:06.686112 | 2026-03-18 00:52:06.686193 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-18 00:52:06.731430 | rockylinux-9 | skipping: Conditional result was False 2026-03-18 00:52:06.736183 | 2026-03-18 00:52:06.736261 | TASK [fetch-output : Set log path for single node] 2026-03-18 00:52:06.772774 | rockylinux-9 | ok 2026-03-18 00:52:06.777995 | 2026-03-18 00:52:06.778064 | LOOP [fetch-output : Ensure local output dirs] 2026-03-18 00:52:07.171159 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/logs" 2026-03-18 00:52:07.408927 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/artifacts" 2026-03-18 00:52:07.638929 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/3ec7602e4c2041fe897a80c583a7bcf7/work/docs" 2026-03-18 00:52:07.654368 | 2026-03-18 00:52:07.654535 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-18 00:52:08.383465 | rockylinux-9 | changed: .d..t...... ./ 2026-03-18 00:52:08.383711 | rockylinux-9 | changed: All items complete 2026-03-18 00:52:08.383742 | 2026-03-18 00:52:08.911193 | rockylinux-9 | changed: .d..t...... ./ 2026-03-18 00:52:09.434188 | rockylinux-9 | changed: .d..t...... ./ 2026-03-18 00:52:09.448634 | 2026-03-18 00:52:09.448775 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-18 00:52:09.877126 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007978 2026-03-18 00:52:10.112271 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007424 2026-03-18 00:52:10.127004 | 2026-03-18 00:52:10.127068 | PLAY [all] 2026-03-18 00:52:10.133472 | 2026-03-18 00:52:10.133561 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-18 00:52:10.613913 | rockylinux-9 | changed 2026-03-18 00:52:10.620904 | 2026-03-18 00:52:10.620991 | PLAY RECAP 2026-03-18 00:52:10.621054 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 00:52:10.621079 | 2026-03-18 00:52:10.737575 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 00:52:10.738775 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-18 00:52:11.328504 | 2026-03-18 00:52:11.328774 | PLAY [localhost] 2026-03-18 00:52:11.338869 | 2026-03-18 00:52:11.338939 | TASK [Generate Zuul manifest] 2026-03-18 00:52:11.362237 | localhost | ok 2026-03-18 00:52:11.381105 | 2026-03-18 00:52:11.381184 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-18 00:52:11.733635 | localhost | changed 2026-03-18 00:52:11.747551 | 2026-03-18 00:52:11.747678 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-18 00:52:11.777939 | localhost | ok 2026-03-18 00:52:11.786669 | 2026-03-18 00:52:11.786762 | TASK [Upload logs] 2026-03-18 00:52:11.806670 | localhost | ok 2026-03-18 00:52:11.867342 | 2026-03-18 00:52:11.867450 | TASK [Set zuul-log-path fact] 2026-03-18 00:52:11.886593 | localhost | ok 2026-03-18 00:52:11.901133 | 2026-03-18 00:52:11.901199 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 00:52:11.944218 | localhost | ok 2026-03-18 00:52:11.958265 | 2026-03-18 00:52:11.958391 | TASK [upload-logs : Create log directories] 2026-03-18 00:52:12.414515 | localhost | changed 2026-03-18 00:52:12.420758 | 2026-03-18 00:52:12.420830 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-18 00:52:12.877851 | localhost -> localhost | ok: Runtime: 0:00:00.005654 2026-03-18 00:52:12.884641 | 2026-03-18 00:52:12.884715 | TASK [upload-logs : Upload logs to log server] 2026-03-18 00:52:13.383259 | localhost | Output suppressed because no_log was given 2026-03-18 00:52:13.389419 | 2026-03-18 00:52:13.396246 | LOOP [upload-logs : Compress console log and json output] 2026-03-18 00:52:13.444879 | localhost | skipping: Conditional result was False 2026-03-18 00:52:13.464135 | localhost | skipping: Conditional result was False 2026-03-18 00:52:13.478405 | 2026-03-18 00:52:13.478574 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-18 00:52:13.528085 | localhost | skipping: Conditional result was False 2026-03-18 00:52:13.528533 | 2026-03-18 00:52:13.533153 | localhost | skipping: Conditional result was False 2026-03-18 00:52:13.551193 | 2026-03-18 00:52:13.551369 | LOOP [upload-logs : Upload console log and json output]