2026-04-18 16:36:22.823624 | Job console starting 2026-04-18 16:36:22.854549 | Updating git repos 2026-04-18 16:36:22.883654 | Cloning repos into workspace 2026-04-18 16:36:24.425756 | Restoring repo states 2026-04-18 16:36:24.432180 | Merging changes 2026-04-18 16:36:24.811446 | Checking out repos 2026-04-18 16:36:25.110404 | Preparing playbooks 2026-04-18 16:36:29.297832 | Running Ansible setup 2026-04-18 16:36:35.871049 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:36:36.576501 | 2026-04-18 16:36:36.576722 | PLAY [localhost] 2026-04-18 16:36:36.587385 | 2026-04-18 16:36:36.587653 | TASK [Gathering Facts] 2026-04-18 16:36:37.621365 | localhost | ok 2026-04-18 16:36:37.627951 | 2026-04-18 16:36:37.628026 | TASK [Setup log path fact] 2026-04-18 16:36:37.645091 | localhost | ok 2026-04-18 16:36:38.083603 | 2026-04-18 16:36:38.083910 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:36:38.135391 | localhost | ok 2026-04-18 16:36:38.144091 | 2026-04-18 16:36:38.144390 | TASK [emit-job-header : Print job information] 2026-04-18 16:36:38.184492 | # Job Information 2026-04-18 16:36:38.184719 | Ansible Version: 2.16.16 2026-04-18 16:36:38.185035 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-04-18 16:36:38.185078 | Pipeline: check 2026-04-18 16:36:38.185109 | Executor: 0a8996d2b663 2026-04-18 16:36:38.185140 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/110 2026-04-18 16:36:38.185173 | Event ID: 34c38600-3b44-11f1-92f3-e4509f68404d 2026-04-18 16:36:38.189219 | 2026-04-18 16:36:38.189310 | LOOP [emit-job-header : Print node information] 2026-04-18 16:36:38.278257 | localhost | ok: 2026-04-18 16:36:38.295806 | localhost | # Node Information 2026-04-18 16:36:38.295938 | localhost | Inventory Hostname: rockylinux-9 2026-04-18 16:36:38.295998 | localhost | Hostname: np0000167330 2026-04-18 16:36:38.296050 | localhost | Username: zuul 2026-04-18 16:36:38.296104 | localhost | Distro: Rocky 9.7 2026-04-18 16:36:38.296155 | localhost | Provider: yul1 2026-04-18 16:36:38.296201 | localhost | Region: ca-ymq-1 2026-04-18 16:36:38.296245 | localhost | Label: rockylinux-9 2026-04-18 16:36:38.296292 | localhost | Product Name: OpenStack Nova 2026-04-18 16:36:38.296342 | localhost | Interface IP: 199.19.213.82 2026-04-18 16:36:38.308234 | 2026-04-18 16:36:38.308403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 16:36:38.728315 | localhost -> localhost | changed 2026-04-18 16:36:38.733986 | 2026-04-18 16:36:38.734064 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 16:36:39.636079 | localhost -> localhost | changed 2026-04-18 16:36:39.644161 | 2026-04-18 16:36:39.644258 | PLAY [all] 2026-04-18 16:36:39.651815 | 2026-04-18 16:36:39.651887 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 16:36:39.867662 | rockylinux-9 -> localhost | ok 2026-04-18 16:36:39.878262 | 2026-04-18 16:36:39.878337 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 16:36:39.909264 | rockylinux-9 | ok 2026-04-18 16:36:39.924546 | rockylinux-9 | included: /var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 16:36:39.930638 | 2026-04-18 16:36:39.930702 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 16:36:41.005935 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-18 16:36:41.006100 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/ee8b6b3a397a481c8f795570c6a58fc2_id_rsa 2026-04-18 16:36:41.006141 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/ee8b6b3a397a481c8f795570c6a58fc2_id_rsa.pub 2026-04-18 16:36:41.006169 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-18 16:36:41.006193 | rockylinux-9 -> localhost | SHA256:eTeLHq7jRulBXbUkM8DR6gCjHAHZQUZkjXIHmuU0uMs zuul-build-sshkey 2026-04-18 16:36:41.006227 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-18 16:36:41.006249 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-18 16:36:41.006277 | rockylinux-9 -> localhost | | .O&* .o++.o | 2026-04-18 16:36:41.006300 | rockylinux-9 -> localhost | | +O=.= . o= . | 2026-04-18 16:36:41.006320 | rockylinux-9 -> localhost | | o=.+ o . o . | 2026-04-18 16:36:41.006341 | rockylinux-9 -> localhost | | . o o.o | 2026-04-18 16:36:41.006360 | rockylinux-9 -> localhost | | . . .S+. o | 2026-04-18 16:36:41.006381 | rockylinux-9 -> localhost | | E +..o o | 2026-04-18 16:36:41.006401 | rockylinux-9 -> localhost | | o .o . | 2026-04-18 16:36:41.006420 | rockylinux-9 -> localhost | | +o . | 2026-04-18 16:36:41.006487 | rockylinux-9 -> localhost | | oooo | 2026-04-18 16:36:41.006514 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-18 16:36:41.006564 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.645309 2026-04-18 16:36:41.011259 | 2026-04-18 16:36:41.011326 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 16:36:41.044657 | rockylinux-9 | ok 2026-04-18 16:36:41.063162 | rockylinux-9 | included: /var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 16:36:41.072535 | 2026-04-18 16:36:41.072661 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 16:36:41.097206 | rockylinux-9 | skipping: Conditional result was False 2026-04-18 16:36:41.103431 | 2026-04-18 16:36:41.103577 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 16:36:41.564863 | rockylinux-9 | changed 2026-04-18 16:36:41.569941 | 2026-04-18 16:36:41.570002 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 16:36:41.821538 | rockylinux-9 | ok 2026-04-18 16:36:41.826247 | 2026-04-18 16:36:41.826312 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 16:36:42.717916 | rockylinux-9 | changed 2026-04-18 16:36:42.725219 | 2026-04-18 16:36:42.725310 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 16:36:43.618699 | rockylinux-9 | changed 2026-04-18 16:36:43.887120 | 2026-04-18 16:36:43.887332 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 16:36:43.914055 | rockylinux-9 | skipping: Conditional result was False 2026-04-18 16:36:43.920554 | 2026-04-18 16:36:43.920628 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 16:36:44.280768 | rockylinux-9 -> localhost | changed 2026-04-18 16:36:44.295730 | 2026-04-18 16:36:44.295888 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 16:36:45.289449 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/ee8b6b3a397a481c8f795570c6a58fc2_id_rsa (zuul-build-sshkey) 2026-04-18 16:36:45.289662 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.017456 2026-04-18 16:36:45.298919 | 2026-04-18 16:36:45.298999 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 16:36:45.684359 | rockylinux-9 | ok 2026-04-18 16:36:46.011151 | 2026-04-18 16:36:46.011280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 16:36:46.042735 | rockylinux-9 | skipping: Conditional result was False 2026-04-18 16:36:46.057616 | 2026-04-18 16:36:46.057719 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 16:36:46.454347 | rockylinux-9 | ok 2026-04-18 16:36:46.461122 | 2026-04-18 16:36:46.461222 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 16:36:47.449542 | rockylinux-9 | Output suppressed because no_log was given 2026-04-18 16:36:47.462200 | 2026-04-18 16:36:47.462290 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 16:36:47.719114 | rockylinux-9 | ok: "logs" 2026-04-18 16:36:47.720337 | rockylinux-9 | ok: All items complete 2026-04-18 16:36:47.720407 | 2026-04-18 16:36:47.950550 | rockylinux-9 | ok: "artifacts" 2026-04-18 16:36:48.195112 | rockylinux-9 | ok: "docs" 2026-04-18 16:36:48.218411 | 2026-04-18 16:36:48.218608 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 16:36:48.476940 | rockylinux-9 | changed: "logs" 2026-04-18 16:36:48.713646 | rockylinux-9 | changed: "artifacts" 2026-04-18 16:36:48.943285 | rockylinux-9 | changed: "docs" 2026-04-18 16:36:48.963755 | 2026-04-18 16:36:48.963873 | PLAY RECAP 2026-04-18 16:36:48.963956 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:36:48.964003 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 16:36:48.964034 | 2026-04-18 16:36:49.108843 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:36:49.110120 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:36:49.754629 | 2026-04-18 16:36:49.994589 | PLAY [all] 2026-04-18 16:36:50.017542 | 2026-04-18 16:36:50.017750 | TASK [setup-uv : Extract archive] 2026-04-18 16:36:52.706399 | rockylinux-9 | changed 2026-04-18 16:36:52.720200 | 2026-04-18 16:36:52.720291 | TASK [setup-uv : Print version] 2026-04-18 16:36:52.744160 | [rockylinux-9] Waiting on logger 2026-04-18 16:36:53.255680 | rockylinux-9 | ok: Runtime: 0:00:00.011697 2026-04-18 16:36:53.265229 | 2026-04-18 16:36:53.265403 | PLAY RECAP 2026-04-18 16:36:53.265466 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:36:53.265492 | 2026-04-18 16:36:53.421956 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:36:53.423801 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:36:54.032702 | 2026-04-18 16:36:54.032888 | PLAY [all] 2026-04-18 16:36:54.046795 | 2026-04-18 16:36:54.046927 | TASK [Copy inventory file for Zuul] 2026-04-18 16:36:55.439465 | rockylinux-9 | changed 2026-04-18 16:36:55.444223 | 2026-04-18 16:36:55.444299 | TASK [Switch "ansible_host" to private IP] 2026-04-18 16:36:55.776133 | rockylinux-9 | changed: 1 replacements made 2026-04-18 16:36:55.781989 | 2026-04-18 16:36:55.782059 | TASK [Run Molecule scenario] 2026-04-18 16:36:55.804596 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:03.942005 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:14.118536 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:24.421950 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:34.187624 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:44.357861 | [rockylinux-9] Waiting on logger 2026-04-18 16:37:54.598005 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:03.877826 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:13.743158 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:24.069835 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:34.246323 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:44.421906 | [rockylinux-9] Waiting on logger 2026-04-18 16:38:45.547029 | rockylinux-9 | ok: Runtime: 0:01:48.753963 2026-04-18 16:38:45.554400 | 2026-04-18 16:38:45.554477 | PLAY RECAP 2026-04-18 16:38:45.554537 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:38:45.554569 | 2026-04-18 16:38:45.655224 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:38:45.656877 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:38:46.351241 | 2026-04-18 16:38:46.351452 | PLAY [all] 2026-04-18 16:38:46.364115 | 2026-04-18 16:38:46.364239 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 16:38:46.411733 | rockylinux-9 | skipping: Conditional result was False 2026-04-18 16:38:46.421558 | 2026-04-18 16:38:46.421731 | TASK [fetch-output : Set log path for single node] 2026-04-18 16:38:46.466191 | rockylinux-9 | ok 2026-04-18 16:38:46.474664 | 2026-04-18 16:38:46.474785 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 16:38:46.852784 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/logs" 2026-04-18 16:38:47.065576 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/artifacts" 2026-04-18 16:38:47.281925 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ee8b6b3a397a481c8f795570c6a58fc2/work/docs" 2026-04-18 16:38:47.290915 | 2026-04-18 16:38:47.291073 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 16:38:47.963778 | rockylinux-9 | changed: .d..t...... ./ 2026-04-18 16:38:47.964047 | rockylinux-9 | changed: All items complete 2026-04-18 16:38:47.964083 | 2026-04-18 16:38:48.468672 | rockylinux-9 | changed: .d..t...... ./ 2026-04-18 16:38:48.971625 | rockylinux-9 | changed: .d..t...... ./ 2026-04-18 16:38:48.990308 | 2026-04-18 16:38:48.990407 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 16:38:49.408377 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.006598 2026-04-18 16:38:50.499773 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006970 2026-04-18 16:38:50.522633 | 2026-04-18 16:38:50.522743 | PLAY [all] 2026-04-18 16:38:50.528599 | 2026-04-18 16:38:50.528665 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 16:38:50.972775 | rockylinux-9 | changed 2026-04-18 16:38:50.978619 | 2026-04-18 16:38:50.978671 | PLAY RECAP 2026-04-18 16:38:50.978714 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 16:38:50.978737 | 2026-04-18 16:38:51.078393 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:38:51.168820 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 16:38:51.772518 | 2026-04-18 16:38:52.148913 | PLAY [localhost] 2026-04-18 16:38:52.164403 | 2026-04-18 16:38:52.164521 | TASK [Generate Zuul manifest] 2026-04-18 16:38:52.182505 | localhost | ok 2026-04-18 16:38:52.196959 | 2026-04-18 16:38:52.197069 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 16:38:52.585505 | localhost | changed 2026-04-18 16:38:52.596679 | 2026-04-18 16:38:52.596781 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 16:38:52.628301 | localhost | ok 2026-04-18 16:38:52.635393 | 2026-04-18 16:38:52.635470 | TASK [Upload logs] 2026-04-18 16:38:52.656326 | localhost | ok 2026-04-18 16:38:52.720826 | 2026-04-18 16:38:52.720943 | TASK [Set zuul-log-path fact] 2026-04-18 16:38:52.739204 | localhost | ok 2026-04-18 16:38:52.758889 | 2026-04-18 16:38:52.759010 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:38:52.790901 | localhost | ok 2026-04-18 16:38:52.798859 | 2026-04-18 16:38:52.798926 | TASK [upload-logs : Create log directories] 2026-04-18 16:38:53.237515 | localhost | changed 2026-04-18 16:38:53.242082 | 2026-04-18 16:38:53.242155 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 16:38:53.635201 | localhost -> localhost | ok: Runtime: 0:00:00.004732 2026-04-18 16:38:53.641350 | 2026-04-18 16:38:53.641436 | TASK [upload-logs : Upload logs to log server] 2026-04-18 16:38:54.099591 | localhost | Output suppressed because no_log was given 2026-04-18 16:38:54.103067 | 2026-04-18 16:38:54.103134 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 16:38:54.151269 | localhost | skipping: Conditional result was False 2026-04-18 16:38:54.158247 | localhost | skipping: Conditional result was False 2026-04-18 16:38:54.166100 | 2026-04-18 16:38:54.166253 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 16:38:54.220009 | localhost | skipping: Conditional result was False 2026-04-18 16:38:54.220390 | 2026-04-18 16:38:54.227965 | localhost | skipping: Conditional result was False 2026-04-18 16:38:54.239696 | 2026-04-18 16:38:54.239809 | LOOP [upload-logs : Upload console log and json output]