2026-04-14 02:38:53.659165 | Job console starting 2026-04-14 02:38:53.714162 | Updating git repos 2026-04-14 02:38:53.770624 | Cloning repos into workspace 2026-04-14 02:38:55.585910 | Restoring repo states 2026-04-14 02:38:55.610584 | Merging changes 2026-04-14 02:38:57.913562 | Checking out repos 2026-04-14 02:38:58.230989 | Preparing playbooks 2026-04-14 02:39:09.674304 | Running Ansible setup 2026-04-14 02:39:13.717004 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:39:14.402109 | 2026-04-14 02:39:14.402245 | PLAY [localhost] 2026-04-14 02:39:14.409712 | 2026-04-14 02:39:14.409782 | TASK [Gathering Facts] 2026-04-14 02:39:15.359609 | localhost | ok 2026-04-14 02:39:15.366429 | 2026-04-14 02:39:15.366522 | TASK [Setup log path fact] 2026-04-14 02:39:15.386221 | localhost | ok 2026-04-14 02:39:15.400075 | 2026-04-14 02:39:15.400187 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:39:15.430137 | localhost | ok 2026-04-14 02:39:15.450526 | 2026-04-14 02:39:15.450682 | TASK [emit-job-header : Print job information] 2026-04-14 02:39:15.501922 | # Job Information 2026-04-14 02:39:15.502129 | Ansible Version: 2.16.16 2026-04-14 02:39:15.502176 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-04-14 02:39:15.502279 | Pipeline: check 2026-04-14 02:39:15.502331 | Executor: 0a8996d2b663 2026-04-14 02:39:15.502362 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/111 2026-04-14 02:39:15.502395 | Event ID: ed477fd0-37aa-11f1-9375-ba961ffa0837 2026-04-14 02:39:15.506009 | 2026-04-14 02:39:15.506089 | LOOP [emit-job-header : Print node information] 2026-04-14 02:39:15.683753 | localhost | ok: 2026-04-14 02:39:15.683985 | localhost | # Node Information 2026-04-14 02:39:15.684022 | localhost | Inventory Hostname: rockylinux-9 2026-04-14 02:39:15.684049 | localhost | Hostname: np0000165994 2026-04-14 02:39:15.684071 | localhost | Username: zuul 2026-04-14 02:39:15.684095 | localhost | Distro: Rocky 9.7 2026-04-14 02:39:15.684116 | localhost | Provider: yul1 2026-04-14 02:39:15.684135 | localhost | Region: ca-ymq-1 2026-04-14 02:39:15.684154 | localhost | Label: rockylinux-9 2026-04-14 02:39:15.684174 | localhost | Product Name: OpenStack Nova 2026-04-14 02:39:15.684193 | localhost | Interface IP: 199.19.213.134 2026-04-14 02:39:15.691442 | 2026-04-14 02:39:15.691716 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-14 02:39:16.120283 | localhost -> localhost | changed 2026-04-14 02:39:16.127994 | 2026-04-14 02:39:16.128070 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-14 02:39:17.097768 | localhost -> localhost | changed 2026-04-14 02:39:17.107957 | 2026-04-14 02:39:17.108021 | PLAY [all] 2026-04-14 02:39:17.115717 | 2026-04-14 02:39:17.115783 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-14 02:39:17.373013 | rockylinux-9 -> localhost | ok 2026-04-14 02:39:17.380343 | 2026-04-14 02:39:17.380434 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-14 02:39:17.411962 | rockylinux-9 | ok 2026-04-14 02:39:17.439976 | rockylinux-9 | included: /var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-14 02:39:17.445923 | 2026-04-14 02:39:17.446000 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-14 02:39:18.235373 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-14 02:39:18.235608 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/1ed3590d56fc4f6ba6e4f740b6e020b2_id_rsa 2026-04-14 02:39:18.235642 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/1ed3590d56fc4f6ba6e4f740b6e020b2_id_rsa.pub 2026-04-14 02:39:18.235665 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-14 02:39:18.235687 | rockylinux-9 -> localhost | SHA256:7PUezzcitvSTObEW7tBozOd/+BU1Clx500E51VGxYqA zuul-build-sshkey 2026-04-14 02:39:18.235726 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-14 02:39:18.235748 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-14 02:39:18.235771 | rockylinux-9 -> localhost | | . .o=%| 2026-04-14 02:39:18.235793 | rockylinux-9 -> localhost | | o o. =+| 2026-04-14 02:39:18.235814 | rockylinux-9 -> localhost | | E o o.o+| 2026-04-14 02:39:18.235834 | rockylinux-9 -> localhost | | . o o o| 2026-04-14 02:39:18.235854 | rockylinux-9 -> localhost | | S . . . | 2026-04-14 02:39:18.235874 | rockylinux-9 -> localhost | | . .o.oo .| 2026-04-14 02:39:18.235893 | rockylinux-9 -> localhost | | . B+o*..| 2026-04-14 02:39:18.235913 | rockylinux-9 -> localhost | | o+=&..+| 2026-04-14 02:39:18.235935 | rockylinux-9 -> localhost | | ..*+B++| 2026-04-14 02:39:18.235955 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-14 02:39:18.236007 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.349926 2026-04-14 02:39:18.241158 | 2026-04-14 02:39:18.241223 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-14 02:39:18.285669 | rockylinux-9 | ok 2026-04-14 02:39:18.295175 | rockylinux-9 | included: /var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-14 02:39:18.304050 | 2026-04-14 02:39:18.304174 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-14 02:39:18.329322 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:39:18.336558 | 2026-04-14 02:39:18.336734 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-14 02:39:18.827001 | rockylinux-9 | changed 2026-04-14 02:39:18.831607 | 2026-04-14 02:39:18.831670 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-14 02:39:19.086201 | rockylinux-9 | ok 2026-04-14 02:39:19.094152 | 2026-04-14 02:39:19.095424 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-14 02:39:20.004771 | rockylinux-9 | changed 2026-04-14 02:39:20.011220 | 2026-04-14 02:39:20.011289 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-14 02:39:20.935449 | rockylinux-9 | changed 2026-04-14 02:39:20.940454 | 2026-04-14 02:39:20.940519 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-14 02:39:20.964578 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:39:20.977615 | 2026-04-14 02:39:20.977707 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-14 02:39:21.524914 | rockylinux-9 -> localhost | changed 2026-04-14 02:39:21.551480 | 2026-04-14 02:39:21.551650 | TASK [add-build-sshkey : Add back temp key] 2026-04-14 02:39:21.926288 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/1ed3590d56fc4f6ba6e4f740b6e020b2_id_rsa (zuul-build-sshkey) 2026-04-14 02:39:21.926520 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014261 2026-04-14 02:39:21.933705 | 2026-04-14 02:39:21.933781 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-14 02:39:22.343474 | rockylinux-9 | ok 2026-04-14 02:39:22.350736 | 2026-04-14 02:39:22.350808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-14 02:39:22.375753 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:39:22.390718 | 2026-04-14 02:39:22.390790 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-14 02:39:22.805726 | rockylinux-9 | ok 2026-04-14 02:39:22.811353 | 2026-04-14 02:39:22.811417 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-14 02:39:23.752933 | rockylinux-9 | Output suppressed because no_log was given 2026-04-14 02:39:23.771819 | 2026-04-14 02:39:23.771941 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-14 02:39:24.033129 | rockylinux-9 | ok: "logs" 2026-04-14 02:39:24.033783 | rockylinux-9 | ok: All items complete 2026-04-14 02:39:24.033819 | 2026-04-14 02:39:24.262594 | rockylinux-9 | ok: "artifacts" 2026-04-14 02:39:24.494104 | rockylinux-9 | ok: "docs" 2026-04-14 02:39:24.507964 | 2026-04-14 02:39:24.508110 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-14 02:39:24.780870 | rockylinux-9 | changed: "logs" 2026-04-14 02:39:25.012008 | rockylinux-9 | changed: "artifacts" 2026-04-14 02:39:25.265495 | rockylinux-9 | changed: "docs" 2026-04-14 02:39:25.279927 | 2026-04-14 02:39:25.280063 | PLAY RECAP 2026-04-14 02:39:25.280146 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:39:25.280204 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-14 02:39:25.280239 | 2026-04-14 02:39:25.405203 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:39:25.406382 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:39:26.012724 | 2026-04-14 02:39:26.013270 | PLAY [all] 2026-04-14 02:39:26.030842 | 2026-04-14 02:39:26.030918 | TASK [setup-uv : Extract archive] 2026-04-14 02:39:28.855118 | rockylinux-9 | changed 2026-04-14 02:39:28.863462 | 2026-04-14 02:39:28.863585 | TASK [setup-uv : Print version] 2026-04-14 02:39:28.891441 | [rockylinux-9] Waiting on logger 2026-04-14 02:39:29.403392 | rockylinux-9 | ok: Runtime: 0:00:00.016290 2026-04-14 02:39:29.413219 | 2026-04-14 02:39:29.413429 | PLAY RECAP 2026-04-14 02:39:29.413533 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:39:29.413589 | 2026-04-14 02:39:29.547999 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:39:29.550281 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:39:30.149324 | 2026-04-14 02:39:30.149510 | PLAY [all] 2026-04-14 02:39:30.160522 | 2026-04-14 02:39:30.160621 | TASK [Copy inventory file for Zuul] 2026-04-14 02:39:31.554385 | rockylinux-9 | changed 2026-04-14 02:39:31.559168 | 2026-04-14 02:39:31.559248 | TASK [Switch "ansible_host" to private IP] 2026-04-14 02:39:31.926781 | rockylinux-9 | changed: 1 replacements made 2026-04-14 02:39:31.934294 | 2026-04-14 02:39:31.934362 | TASK [Run Molecule scenario] 2026-04-14 02:39:31.954858 | [rockylinux-9] Waiting on logger 2026-04-14 02:39:40.102284 | [rockylinux-9] Waiting on logger 2026-04-14 02:39:50.278146 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:00.454322 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:10.630173 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:20.806096 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:29.963375 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:40.134043 | [rockylinux-9] Waiting on logger 2026-04-14 02:40:50.309932 | [rockylinux-9] Waiting on logger 2026-04-14 02:41:00.486153 | [rockylinux-9] Waiting on logger 2026-04-14 02:41:10.662218 | [rockylinux-9] Waiting on logger 2026-04-14 02:41:19.725568 | rockylinux-9 | ok: Runtime: 0:01:47.082800 2026-04-14 02:41:19.731701 | 2026-04-14 02:41:19.731768 | PLAY RECAP 2026-04-14 02:41:19.731834 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:41:19.731859 | 2026-04-14 02:41:19.857309 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:41:19.859518 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:41:20.500024 | 2026-04-14 02:41:20.500260 | PLAY [all] 2026-04-14 02:41:20.511467 | 2026-04-14 02:41:20.511550 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-14 02:41:20.557700 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:41:20.566554 | 2026-04-14 02:41:20.566673 | TASK [fetch-output : Set log path for single node] 2026-04-14 02:41:20.611282 | rockylinux-9 | ok 2026-04-14 02:41:20.616980 | 2026-04-14 02:41:20.617051 | LOOP [fetch-output : Ensure local output dirs] 2026-04-14 02:41:20.983197 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/logs" 2026-04-14 02:41:21.192139 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/artifacts" 2026-04-14 02:41:21.396377 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/1ed3590d56fc4f6ba6e4f740b6e020b2/work/docs" 2026-04-14 02:41:21.412284 | 2026-04-14 02:41:21.412417 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-14 02:41:22.097640 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:41:22.097956 | rockylinux-9 | changed: All items complete 2026-04-14 02:41:22.097999 | 2026-04-14 02:41:22.624666 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:41:23.158218 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:41:23.181752 | 2026-04-14 02:41:23.181901 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-14 02:41:23.591674 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008597 2026-04-14 02:41:23.838557 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008460 2026-04-14 02:41:23.851284 | 2026-04-14 02:41:23.851406 | PLAY [all] 2026-04-14 02:41:23.857059 | 2026-04-14 02:41:23.857127 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-14 02:41:24.376272 | rockylinux-9 | changed 2026-04-14 02:41:24.382735 | 2026-04-14 02:41:24.382787 | PLAY RECAP 2026-04-14 02:41:24.382834 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-14 02:41:24.382857 | 2026-04-14 02:41:24.489158 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:41:24.491422 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-14 02:41:25.079827 | 2026-04-14 02:41:25.085522 | PLAY [localhost] 2026-04-14 02:41:25.103014 | 2026-04-14 02:41:25.103178 | TASK [Generate Zuul manifest] 2026-04-14 02:41:25.124786 | localhost | ok 2026-04-14 02:41:25.142723 | 2026-04-14 02:41:25.142899 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-14 02:41:25.457358 | localhost | changed 2026-04-14 02:41:25.477047 | 2026-04-14 02:41:25.477160 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-14 02:41:25.510127 | localhost | ok 2026-04-14 02:41:25.517887 | 2026-04-14 02:41:25.517968 | TASK [Upload logs] 2026-04-14 02:41:25.539581 | localhost | ok 2026-04-14 02:41:25.601376 | 2026-04-14 02:41:25.601497 | TASK [Set zuul-log-path fact] 2026-04-14 02:41:25.624094 | localhost | ok 2026-04-14 02:41:25.635571 | 2026-04-14 02:41:25.635642 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:41:25.666998 | localhost | ok 2026-04-14 02:41:25.675958 | 2026-04-14 02:41:25.676022 | TASK [upload-logs : Create log directories] 2026-04-14 02:41:26.092858 | localhost | changed 2026-04-14 02:41:26.098487 | 2026-04-14 02:41:26.098556 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-14 02:41:26.511870 | localhost -> localhost | ok: Runtime: 0:00:00.006646 2026-04-14 02:41:26.517036 | 2026-04-14 02:41:26.517142 | TASK [upload-logs : Upload logs to log server] 2026-04-14 02:41:26.991055 | localhost | Output suppressed because no_log was given 2026-04-14 02:41:26.994660 | 2026-04-14 02:41:26.994723 | LOOP [upload-logs : Compress console log and json output] 2026-04-14 02:41:27.040606 | localhost | skipping: Conditional result was False 2026-04-14 02:41:27.047749 | localhost | skipping: Conditional result was False 2026-04-14 02:41:27.055583 | 2026-04-14 02:41:27.055687 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-14 02:41:27.097704 | localhost | skipping: Conditional result was False 2026-04-14 02:41:27.098137 | 2026-04-14 02:41:27.101638 | localhost | skipping: Conditional result was False 2026-04-14 02:41:27.116713 | 2026-04-14 02:41:27.116850 | LOOP [upload-logs : Upload console log and json output]