2026-03-14 00:46:11.257829 | Job console starting 2026-03-14 00:46:11.273094 | Updating git repos 2026-03-14 00:46:11.310747 | Cloning repos into workspace 2026-03-14 00:46:11.401089 | Restoring repo states 2026-03-14 00:46:11.408414 | Merging changes 2026-03-14 00:46:11.952106 | Checking out repos 2026-03-14 00:46:12.025105 | Preparing playbooks 2026-03-14 00:46:14.299133 | Running Ansible setup 2026-03-14 00:46:17.864754 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-14 00:46:18.442442 | 2026-03-14 00:46:18.442584 | PLAY [localhost] 2026-03-14 00:46:18.450272 | 2026-03-14 00:46:18.450345 | TASK [Gathering Facts] 2026-03-14 00:46:19.275962 | localhost | ok 2026-03-14 00:46:19.282486 | 2026-03-14 00:46:19.282559 | TASK [Setup log path fact] 2026-03-14 00:46:19.301338 | localhost | ok 2026-03-14 00:46:19.314072 | 2026-03-14 00:46:19.314137 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-14 00:46:19.343119 | localhost | ok 2026-03-14 00:46:19.349825 | 2026-03-14 00:46:19.349890 | TASK [emit-job-header : Print job information] 2026-03-14 00:46:19.389892 | # Job Information 2026-03-14 00:46:19.390111 | Ansible Version: 2.16.16 2026-03-14 00:46:19.390181 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-03-14 00:46:19.390230 | Pipeline: check 2026-03-14 00:46:19.390276 | Executor: 0a8996d2b663 2026-03-14 00:46:19.390319 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/100 2026-03-14 00:46:19.390367 | Event ID: ef854cc0-1f3e-11f1-85d0-e7c2c9645e81 2026-03-14 00:46:19.395166 | 2026-03-14 00:46:19.395228 | LOOP [emit-job-header : Print node information] 2026-03-14 00:46:19.486919 | localhost | ok: 2026-03-14 00:46:19.487194 | localhost | # Node Information 2026-03-14 00:46:19.487864 | localhost | Inventory Hostname: rockylinux-9 2026-03-14 00:46:19.487932 | localhost | Hostname: np0000158755 2026-03-14 00:46:19.487977 | localhost | Username: zuul 2026-03-14 00:46:19.488031 | localhost | Distro: Rocky 9.7 2026-03-14 00:46:19.488075 | localhost | Provider: yul1 2026-03-14 00:46:19.488116 | localhost | Region: ca-ymq-1 2026-03-14 00:46:19.488156 | localhost | Label: rockylinux-9 2026-03-14 00:46:19.488196 | localhost | Product Name: OpenStack Nova 2026-03-14 00:46:19.488238 | localhost | Interface IP: 199.204.45.157 2026-03-14 00:46:19.503889 | 2026-03-14 00:46:19.504013 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-14 00:46:19.915512 | localhost -> localhost | changed 2026-03-14 00:46:19.924350 | 2026-03-14 00:46:19.924421 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-14 00:46:20.731249 | localhost -> localhost | changed 2026-03-14 00:46:20.740386 | 2026-03-14 00:46:20.740458 | PLAY [all] 2026-03-14 00:46:20.748738 | 2026-03-14 00:46:20.748804 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-14 00:46:20.975187 | rockylinux-9 -> localhost | ok 2026-03-14 00:46:20.983966 | 2026-03-14 00:46:20.984034 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-14 00:46:21.016106 | rockylinux-9 | ok 2026-03-14 00:46:21.031444 | rockylinux-9 | included: /var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-14 00:46:21.036688 | 2026-03-14 00:46:21.036759 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-14 00:46:22.182482 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-03-14 00:46:22.182733 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/8cffdb40d504433b8687e4e38c24af5a_id_rsa 2026-03-14 00:46:22.182802 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/8cffdb40d504433b8687e4e38c24af5a_id_rsa.pub 2026-03-14 00:46:22.182854 | rockylinux-9 -> localhost | The key fingerprint is: 2026-03-14 00:46:22.182902 | rockylinux-9 -> localhost | SHA256:OpBxxMoyf31vtCnPhS4B1QoVoX4GiKpd6dQcOvDXgDI zuul-build-sshkey 2026-03-14 00:46:22.182967 | rockylinux-9 -> localhost | The key's randomart image is: 2026-03-14 00:46:22.183015 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-03-14 00:46:22.183126 | rockylinux-9 -> localhost | | .. .++ | 2026-03-14 00:46:22.183185 | rockylinux-9 -> localhost | | +..... . | 2026-03-14 00:46:22.183301 | rockylinux-9 -> localhost | | E.+.= oo . | 2026-03-14 00:46:22.183327 | rockylinux-9 -> localhost | | o*oO =... | 2026-03-14 00:46:22.183351 | rockylinux-9 -> localhost | | .+X +.S.o | 2026-03-14 00:46:22.183371 | rockylinux-9 -> localhost | | o +.+...oo .. | 2026-03-14 00:46:22.183390 | rockylinux-9 -> localhost | |. . ..o . +.o. | 2026-03-14 00:46:22.183410 | rockylinux-9 -> localhost | | . oo=. | 2026-03-14 00:46:22.183432 | rockylinux-9 -> localhost | | =+ | 2026-03-14 00:46:22.183452 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-03-14 00:46:22.183500 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.741472 2026-03-14 00:46:22.188204 | 2026-03-14 00:46:22.188264 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-14 00:46:22.210259 | rockylinux-9 | ok 2026-03-14 00:46:22.218465 | rockylinux-9 | included: /var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-14 00:46:22.226239 | 2026-03-14 00:46:22.226301 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-14 00:46:22.239621 | rockylinux-9 | skipping: Conditional result was False 2026-03-14 00:46:22.247796 | 2026-03-14 00:46:22.247883 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-14 00:46:22.751035 | rockylinux-9 | changed 2026-03-14 00:46:22.755527 | 2026-03-14 00:46:22.755589 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-14 00:46:23.008207 | rockylinux-9 | ok 2026-03-14 00:46:23.013703 | 2026-03-14 00:46:23.013765 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-14 00:46:23.962815 | rockylinux-9 | changed 2026-03-14 00:46:23.971109 | 2026-03-14 00:46:23.971263 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-14 00:46:24.871837 | rockylinux-9 | changed 2026-03-14 00:46:24.877164 | 2026-03-14 00:46:24.877233 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-14 00:46:24.902227 | rockylinux-9 | skipping: Conditional result was False 2026-03-14 00:46:24.931592 | 2026-03-14 00:46:24.931722 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-14 00:46:25.310239 | rockylinux-9 -> localhost | changed 2026-03-14 00:46:25.320982 | 2026-03-14 00:46:25.321057 | TASK [add-build-sshkey : Add back temp key] 2026-03-14 00:46:25.603002 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/8cffdb40d504433b8687e4e38c24af5a_id_rsa (zuul-build-sshkey) 2026-03-14 00:46:25.603196 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015426 2026-03-14 00:46:25.609486 | 2026-03-14 00:46:25.609548 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-14 00:46:25.975913 | rockylinux-9 | ok 2026-03-14 00:46:25.998951 | 2026-03-14 00:46:25.999187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-14 00:46:26.033674 | rockylinux-9 | skipping: Conditional result was False 2026-03-14 00:46:26.043254 | 2026-03-14 00:46:26.043322 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-14 00:46:26.409441 | rockylinux-9 | ok 2026-03-14 00:46:26.414343 | 2026-03-14 00:46:26.414403 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-14 00:46:27.285761 | rockylinux-9 | Output suppressed because no_log was given 2026-03-14 00:46:27.294239 | 2026-03-14 00:46:27.294311 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-14 00:46:27.548811 | rockylinux-9 | ok: "logs" 2026-03-14 00:46:27.549192 | rockylinux-9 | ok: All items complete 2026-03-14 00:46:27.549233 | 2026-03-14 00:46:27.751665 | rockylinux-9 | ok: "artifacts" 2026-03-14 00:46:27.957407 | rockylinux-9 | ok: "docs" 2026-03-14 00:46:27.973207 | 2026-03-14 00:46:27.973301 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-14 00:46:28.227210 | rockylinux-9 | changed: "logs" 2026-03-14 00:46:28.449068 | rockylinux-9 | changed: "artifacts" 2026-03-14 00:46:28.684433 | rockylinux-9 | changed: "docs" 2026-03-14 00:46:28.701438 | 2026-03-14 00:46:28.701537 | PLAY RECAP 2026-03-14 00:46:28.701596 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-14 00:46:28.701639 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-14 00:46:28.701670 | 2026-03-14 00:46:28.804287 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-14 00:46:28.806643 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-14 00:46:29.389957 | 2026-03-14 00:46:29.390134 | PLAY [all] 2026-03-14 00:46:29.401716 | 2026-03-14 00:46:29.401814 | TASK [setup-uv : Extract archive] 2026-03-14 00:46:32.184564 | rockylinux-9 | changed 2026-03-14 00:46:32.192925 | 2026-03-14 00:46:32.193488 | TASK [setup-uv : Print version] 2026-03-14 00:46:32.219271 | [rockylinux-9] Waiting on logger 2026-03-14 00:46:32.634332 | rockylinux-9 | ok: Runtime: 0:00:00.013556 2026-03-14 00:46:32.639794 | 2026-03-14 00:46:32.639842 | PLAY RECAP 2026-03-14 00:46:32.639886 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-14 00:46:32.639909 | 2026-03-14 00:46:32.751728 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-14 00:46:32.753189 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-14 00:46:33.351513 | 2026-03-14 00:46:33.351640 | PLAY [all] 2026-03-14 00:46:33.362394 | 2026-03-14 00:46:33.362464 | TASK [Copy inventory file for Zuul] 2026-03-14 00:46:34.721085 | rockylinux-9 | changed 2026-03-14 00:46:34.727870 | 2026-03-14 00:46:34.727944 | TASK [Switch "ansible_host" to private IP] 2026-03-14 00:46:35.075253 | rockylinux-9 | changed: 1 replacements made 2026-03-14 00:46:35.083748 | 2026-03-14 00:46:35.083886 | TASK [Run Molecule scenario] 2026-03-14 00:46:35.104626 | [rockylinux-9] Waiting on logger 2026-03-14 00:46:42.219687 | [rockylinux-9] Waiting on logger 2026-03-14 00:46:52.389943 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:02.565986 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:12.742296 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:22.918258 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:33.093947 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:42.252757 | [rockylinux-9] Waiting on logger 2026-03-14 00:47:52.426101 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:02.598086 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:12.774268 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:22.950238 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:33.126388 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:42.283378 | [rockylinux-9] Waiting on logger 2026-03-14 00:48:52.453965 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:02.630358 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:12.810068 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:22.981863 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:33.157993 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:42.315585 | [rockylinux-9] Waiting on logger 2026-03-14 00:49:52.486025 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:02.666132 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:12.837908 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:23.014103 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:33.189930 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:42.342074 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:52.517805 | [rockylinux-9] Waiting on logger 2026-03-14 00:50:53.642898 | rockylinux-9 | ok: Runtime: 0:04:17.983886 2026-03-14 00:50:53.650675 | 2026-03-14 00:50:53.650748 | PLAY RECAP 2026-03-14 00:50:53.650813 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-14 00:50:53.650845 | 2026-03-14 00:50:53.748406 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-14 00:50:53.749682 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-14 00:50:54.343745 | 2026-03-14 00:50:54.343909 | PLAY [all] 2026-03-14 00:50:54.355127 | 2026-03-14 00:50:54.355205 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-14 00:50:54.401709 | rockylinux-9 | skipping: Conditional result was False 2026-03-14 00:50:54.410582 | 2026-03-14 00:50:54.410703 | TASK [fetch-output : Set log path for single node] 2026-03-14 00:50:54.455168 | rockylinux-9 | ok 2026-03-14 00:50:54.463412 | 2026-03-14 00:50:54.463508 | LOOP [fetch-output : Ensure local output dirs] 2026-03-14 00:50:54.817688 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/logs" 2026-03-14 00:50:55.032087 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/artifacts" 2026-03-14 00:50:55.238735 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/8cffdb40d504433b8687e4e38c24af5a/work/docs" 2026-03-14 00:50:55.255618 | 2026-03-14 00:50:55.255811 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-14 00:50:55.925541 | rockylinux-9 | changed: .d..t...... ./ 2026-03-14 00:50:55.925810 | rockylinux-9 | changed: All items complete 2026-03-14 00:50:55.925848 | 2026-03-14 00:50:56.452868 | rockylinux-9 | changed: .d..t...... ./ 2026-03-14 00:50:56.967039 | rockylinux-9 | changed: .d..t...... ./ 2026-03-14 00:50:56.986935 | 2026-03-14 00:50:56.987133 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-14 00:50:57.443333 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.006920 2026-03-14 00:50:57.684814 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007666 2026-03-14 00:50:57.695458 | 2026-03-14 00:50:57.695578 | PLAY [all] 2026-03-14 00:50:57.701552 | 2026-03-14 00:50:57.701614 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-14 00:50:58.156420 | rockylinux-9 | changed 2026-03-14 00:50:58.162840 | 2026-03-14 00:50:58.162886 | PLAY RECAP 2026-03-14 00:50:58.162925 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-14 00:50:58.162946 | 2026-03-14 00:50:58.252526 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-14 00:50:58.253592 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-14 00:50:58.819021 | 2026-03-14 00:50:58.819192 | PLAY [localhost] 2026-03-14 00:50:58.829983 | 2026-03-14 00:50:58.830062 | TASK [Generate Zuul manifest] 2026-03-14 00:50:58.851240 | localhost | ok 2026-03-14 00:50:58.867790 | 2026-03-14 00:50:58.867876 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-14 00:50:59.230192 | localhost | changed 2026-03-14 00:50:59.241678 | 2026-03-14 00:50:59.241761 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-14 00:50:59.272816 | localhost | ok 2026-03-14 00:50:59.282820 | 2026-03-14 00:50:59.282925 | TASK [Upload logs] 2026-03-14 00:50:59.305969 | localhost | ok 2026-03-14 00:50:59.365746 | 2026-03-14 00:50:59.365890 | TASK [Set zuul-log-path fact] 2026-03-14 00:50:59.386319 | localhost | ok 2026-03-14 00:50:59.401554 | 2026-03-14 00:50:59.401708 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-14 00:50:59.435744 | localhost | ok 2026-03-14 00:50:59.445589 | 2026-03-14 00:50:59.445677 | TASK [upload-logs : Create log directories] 2026-03-14 00:50:59.841012 | localhost | changed 2026-03-14 00:50:59.847622 | 2026-03-14 00:50:59.847695 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-14 00:51:00.213063 | localhost -> localhost | ok: Runtime: 0:00:00.004326 2026-03-14 00:51:00.219579 | 2026-03-14 00:51:00.219667 | TASK [upload-logs : Upload logs to log server] 2026-03-14 00:51:00.687240 | localhost | Output suppressed because no_log was given 2026-03-14 00:51:00.690884 | 2026-03-14 00:51:00.690952 | LOOP [upload-logs : Compress console log and json output] 2026-03-14 00:51:00.736142 | localhost | skipping: Conditional result was False 2026-03-14 00:51:00.743174 | localhost | skipping: Conditional result was False 2026-03-14 00:51:00.753814 | 2026-03-14 00:51:00.753937 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-14 00:51:00.800558 | localhost | skipping: Conditional result was False 2026-03-14 00:51:00.801021 | 2026-03-14 00:51:00.804351 | localhost | skipping: Conditional result was False 2026-03-14 00:51:00.816827 | 2026-03-14 00:51:00.817033 | LOOP [upload-logs : Upload console log and json output]