2026-04-10 00:54:08.609147 | Job console starting 2026-04-10 00:54:08.717532 | Updating git repos 2026-04-10 00:54:08.830709 | Cloning repos into workspace 2026-04-10 00:54:09.000702 | Restoring repo states 2026-04-10 00:54:09.017204 | Merging changes 2026-04-10 00:54:09.931569 | Checking out repos 2026-04-10 00:54:10.378270 | Preparing playbooks 2026-04-10 00:54:14.069752 | Running Ansible setup 2026-04-10 00:54:17.983362 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-10 00:54:18.616102 | 2026-04-10 00:54:18.616239 | PLAY [localhost] 2026-04-10 00:54:18.624188 | 2026-04-10 00:54:18.624262 | TASK [Gathering Facts] 2026-04-10 00:54:19.543170 | localhost | ok 2026-04-10 00:54:19.554356 | 2026-04-10 00:54:19.554493 | TASK [Setup log path fact] 2026-04-10 00:54:19.573118 | localhost | ok 2026-04-10 00:54:19.592851 | 2026-04-10 00:54:19.593091 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-10 00:54:19.642312 | localhost | ok 2026-04-10 00:54:19.651528 | 2026-04-10 00:54:19.651723 | TASK [emit-job-header : Print job information] 2026-04-10 00:54:19.699103 | # Job Information 2026-04-10 00:54:19.699524 | Ansible Version: 2.16.16 2026-04-10 00:54:19.699632 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-04-10 00:54:19.699706 | Pipeline: check 2026-04-10 00:54:19.699751 | Executor: 0a8996d2b663 2026-04-10 00:54:19.699775 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/102 2026-04-10 00:54:19.699799 | Event ID: a13b32c0-3477-11f1-8c27-8c298754fe0d 2026-04-10 00:54:19.705415 | 2026-04-10 00:54:19.705598 | LOOP [emit-job-header : Print node information] 2026-04-10 00:54:19.800855 | localhost | ok: 2026-04-10 00:54:19.801798 | localhost | # Node Information 2026-04-10 00:54:19.801840 | localhost | Inventory Hostname: rockylinux-9 2026-04-10 00:54:19.801873 | localhost | Hostname: np0000164750 2026-04-10 00:54:19.801899 | localhost | Username: zuul 2026-04-10 00:54:19.801926 | localhost | Distro: Rocky 9.7 2026-04-10 00:54:19.801951 | localhost | Provider: yul1 2026-04-10 00:54:19.801974 | localhost | Region: ca-ymq-1 2026-04-10 00:54:19.801997 | localhost | Label: rockylinux-9 2026-04-10 00:54:19.802020 | localhost | Product Name: OpenStack Nova 2026-04-10 00:54:19.802044 | localhost | Interface IP: 199.204.45.19 2026-04-10 00:54:19.817009 | 2026-04-10 00:54:19.817239 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-10 00:54:20.349807 | localhost -> localhost | changed 2026-04-10 00:54:20.354879 | 2026-04-10 00:54:20.354965 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-10 00:54:21.428179 | localhost -> localhost | changed 2026-04-10 00:54:21.434578 | 2026-04-10 00:54:21.434640 | PLAY [all] 2026-04-10 00:54:21.441727 | 2026-04-10 00:54:21.441791 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-10 00:54:21.655553 | rockylinux-9 -> localhost | ok 2026-04-10 00:54:21.662310 | 2026-04-10 00:54:21.662392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-10 00:54:21.692532 | rockylinux-9 | ok 2026-04-10 00:54:21.709461 | rockylinux-9 | included: /var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-10 00:54:21.715343 | 2026-04-10 00:54:21.715423 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-10 00:54:22.782968 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-10 00:54:22.783199 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/338a28a88469438c93cdf2af50b6bcfb_id_rsa 2026-04-10 00:54:22.783279 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/338a28a88469438c93cdf2af50b6bcfb_id_rsa.pub 2026-04-10 00:54:22.783432 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-10 00:54:22.783496 | rockylinux-9 -> localhost | SHA256:ad3vjTOGo8CFgK1SFRfouhiMr9WqIeK2dnxhR3PdOfA zuul-build-sshkey 2026-04-10 00:54:22.783550 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-10 00:54:22.783595 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-10 00:54:22.783632 | rockylinux-9 -> localhost | | ooo. | 2026-04-10 00:54:22.783662 | rockylinux-9 -> localhost | | +.. . | 2026-04-10 00:54:22.783689 | rockylinux-9 -> localhost | | o.o . + . | 2026-04-10 00:54:22.783716 | rockylinux-9 -> localhost | | . ..+ = o E | 2026-04-10 00:54:22.783742 | rockylinux-9 -> localhost | | o. ... S o . . | 2026-04-10 00:54:22.783769 | rockylinux-9 -> localhost | |. oo.o + . . | 2026-04-10 00:54:22.783794 | rockylinux-9 -> localhost | |+.ooo.o o .. | 2026-04-10 00:54:22.783820 | rockylinux-9 -> localhost | |+=o+.. . o.+o | 2026-04-10 00:54:22.783850 | rockylinux-9 -> localhost | |==+ . .. ooo.| 2026-04-10 00:54:22.783878 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-10 00:54:22.783945 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.576140 2026-04-10 00:54:22.789301 | 2026-04-10 00:54:22.789380 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-10 00:54:22.824848 | rockylinux-9 | ok 2026-04-10 00:54:22.837283 | rockylinux-9 | included: /var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-10 00:54:22.848829 | 2026-04-10 00:54:22.848910 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-10 00:54:22.873919 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:22.880715 | 2026-04-10 00:54:22.880833 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-10 00:54:23.381822 | rockylinux-9 | changed 2026-04-10 00:54:23.391092 | 2026-04-10 00:54:23.391195 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-10 00:54:23.653461 | rockylinux-9 | ok 2026-04-10 00:54:23.658192 | 2026-04-10 00:54:23.658261 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-10 00:54:24.612617 | rockylinux-9 | changed 2026-04-10 00:54:24.620359 | 2026-04-10 00:54:24.620449 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-10 00:54:25.585223 | rockylinux-9 | changed 2026-04-10 00:54:25.592278 | 2026-04-10 00:54:25.592405 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-10 00:54:25.617637 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:25.627265 | 2026-04-10 00:54:25.627379 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-10 00:54:26.021440 | rockylinux-9 -> localhost | changed 2026-04-10 00:54:26.031424 | 2026-04-10 00:54:26.031495 | TASK [add-build-sshkey : Add back temp key] 2026-04-10 00:54:26.354321 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/338a28a88469438c93cdf2af50b6bcfb_id_rsa (zuul-build-sshkey) 2026-04-10 00:54:26.473007 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015922 2026-04-10 00:54:26.484488 | 2026-04-10 00:54:26.484755 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-10 00:54:26.890989 | rockylinux-9 | ok 2026-04-10 00:54:26.895206 | 2026-04-10 00:54:26.895268 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-10 00:54:26.919118 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:26.927743 | 2026-04-10 00:54:26.927825 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-10 00:54:27.315274 | rockylinux-9 | ok 2026-04-10 00:54:27.324120 | 2026-04-10 00:54:27.324287 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-10 00:54:28.282670 | rockylinux-9 | Output suppressed because no_log was given 2026-04-10 00:54:28.293640 | 2026-04-10 00:54:28.293706 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-10 00:54:28.546693 | rockylinux-9 | ok: "logs" 2026-04-10 00:54:28.546928 | rockylinux-9 | ok: All items complete 2026-04-10 00:54:28.546957 | 2026-04-10 00:54:28.781932 | rockylinux-9 | ok: "artifacts" 2026-04-10 00:54:29.001991 | rockylinux-9 | ok: "docs" 2026-04-10 00:54:29.011632 | 2026-04-10 00:54:29.011748 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-10 00:54:29.270198 | rockylinux-9 | changed: "logs" 2026-04-10 00:54:29.513029 | rockylinux-9 | changed: "artifacts" 2026-04-10 00:54:29.735080 | rockylinux-9 | changed: "docs" 2026-04-10 00:54:29.769514 | 2026-04-10 00:54:29.769687 | PLAY RECAP 2026-04-10 00:54:29.769747 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:54:29.769779 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-10 00:54:29.769802 | 2026-04-10 00:54:30.012287 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-10 00:54:30.013476 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-10 00:54:30.747025 | 2026-04-10 00:54:30.747165 | PLAY [all] 2026-04-10 00:54:30.758470 | 2026-04-10 00:54:30.758547 | TASK [setup-uv : Extract archive] 2026-04-10 00:54:33.563699 | rockylinux-9 | changed 2026-04-10 00:54:33.569297 | 2026-04-10 00:54:33.569399 | TASK [setup-uv : Print version] 2026-04-10 00:54:33.594456 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:34.111271 | rockylinux-9 | ok: Runtime: 0:00:00.013175 2026-04-10 00:54:34.119217 | 2026-04-10 00:54:34.119337 | PLAY RECAP 2026-04-10 00:54:34.119385 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:54:34.119410 | 2026-04-10 00:54:34.274858 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-10 00:54:34.276315 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-10 00:54:34.943343 | 2026-04-10 00:54:34.943577 | PLAY [all] 2026-04-10 00:54:34.955049 | 2026-04-10 00:54:34.955186 | TASK [Copy inventory file for Zuul] 2026-04-10 00:54:36.334826 | rockylinux-9 | changed 2026-04-10 00:54:36.418636 | 2026-04-10 00:54:36.418806 | TASK [Switch "ansible_host" to private IP] 2026-04-10 00:54:36.774534 | rockylinux-9 | changed: 1 replacements made 2026-04-10 00:54:36.782242 | 2026-04-10 00:54:36.782319 | TASK [Run Molecule scenario] 2026-04-10 00:54:36.804311 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:44.934278 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:55.173810 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:05.354179 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:15.529725 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:24.687598 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:34.853980 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:45.029913 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:55.206091 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:05.381989 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:15.558005 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:24.710398 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:34.885992 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:45.062193 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:55.238095 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:05.414134 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:15.590080 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:24.742052 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:34.918268 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:45.094019 | [rockylinux-9] Waiting on logger 2026-04-10 00:57:55.270023 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:05.446143 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:14.603536 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:24.774022 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:34.949837 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:45.129772 | [rockylinux-9] Waiting on logger 2026-04-10 00:58:55.302096 | [rockylinux-9] Waiting on logger 2026-04-10 00:59:05.485976 | rockylinux-9 | ok: Runtime: 0:04:27.468082 2026-04-10 00:59:05.492164 | 2026-04-10 00:59:05.492218 | PLAY RECAP 2026-04-10 00:59:05.492270 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:59:05.492298 | 2026-04-10 00:59:05.605067 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-10 00:59:05.608430 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-10 00:59:06.203824 | 2026-04-10 00:59:06.204256 | PLAY [all] 2026-04-10 00:59:06.215006 | 2026-04-10 00:59:06.215158 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-10 00:59:06.272140 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:59:06.281577 | 2026-04-10 00:59:06.281661 | TASK [fetch-output : Set log path for single node] 2026-04-10 00:59:06.323908 | rockylinux-9 | ok 2026-04-10 00:59:06.329511 | 2026-04-10 00:59:06.329583 | LOOP [fetch-output : Ensure local output dirs] 2026-04-10 00:59:06.765508 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/logs" 2026-04-10 00:59:06.982816 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/artifacts" 2026-04-10 00:59:07.198485 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/338a28a88469438c93cdf2af50b6bcfb/work/docs" 2026-04-10 00:59:07.210715 | 2026-04-10 00:59:07.210883 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-10 00:59:07.952717 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:59:07.953162 | rockylinux-9 | changed: All items complete 2026-04-10 00:59:07.953217 | 2026-04-10 00:59:08.479451 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:59:08.997019 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:59:09.010071 | 2026-04-10 00:59:09.010583 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-10 00:59:10.475289 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007884 2026-04-10 00:59:10.710940 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008645 2026-04-10 00:59:10.721499 | 2026-04-10 00:59:10.721659 | PLAY [all] 2026-04-10 00:59:10.727979 | 2026-04-10 00:59:10.728048 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-10 00:59:11.231677 | rockylinux-9 | changed 2026-04-10 00:59:11.236693 | 2026-04-10 00:59:11.236744 | PLAY RECAP 2026-04-10 00:59:11.236789 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-10 00:59:11.236813 | 2026-04-10 00:59:11.397984 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-10 00:59:11.400180 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-10 00:59:12.004864 | 2026-04-10 00:59:12.005373 | PLAY [localhost] 2026-04-10 00:59:12.015435 | 2026-04-10 00:59:12.015521 | TASK [Generate Zuul manifest] 2026-04-10 00:59:12.033395 | localhost | ok 2026-04-10 00:59:12.047433 | 2026-04-10 00:59:12.047537 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-10 00:59:12.433859 | localhost | changed 2026-04-10 00:59:12.447388 | 2026-04-10 00:59:12.447542 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-10 00:59:12.508022 | localhost | ok 2026-04-10 00:59:12.517290 | 2026-04-10 00:59:12.517432 | TASK [Upload logs] 2026-04-10 00:59:12.540210 | localhost | ok 2026-04-10 00:59:12.607374 | 2026-04-10 00:59:12.607597 | TASK [Set zuul-log-path fact] 2026-04-10 00:59:12.630855 | localhost | ok 2026-04-10 00:59:12.646638 | 2026-04-10 00:59:12.646834 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-10 00:59:12.678293 | localhost | ok 2026-04-10 00:59:12.687861 | 2026-04-10 00:59:12.688006 | TASK [upload-logs : Create log directories] 2026-04-10 00:59:13.248848 | localhost | changed 2026-04-10 00:59:13.255613 | 2026-04-10 00:59:13.255718 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-10 00:59:13.763924 | localhost -> localhost | ok: Runtime: 0:00:00.061731 2026-04-10 00:59:13.771304 | 2026-04-10 00:59:13.771413 | TASK [upload-logs : Upload logs to log server] 2026-04-10 00:59:14.247019 | localhost | Output suppressed because no_log was given 2026-04-10 00:59:14.253577 | 2026-04-10 00:59:14.253708 | LOOP [upload-logs : Compress console log and json output] 2026-04-10 00:59:14.303155 | localhost | skipping: Conditional result was False 2026-04-10 00:59:14.311693 | localhost | skipping: Conditional result was False 2026-04-10 00:59:14.330332 | 2026-04-10 00:59:14.330564 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-10 00:59:14.375720 | localhost | skipping: Conditional result was False 2026-04-10 00:59:14.376117 | 2026-04-10 00:59:14.381871 | localhost | skipping: Conditional result was False 2026-04-10 00:59:14.393624 | 2026-04-10 00:59:14.393842 | LOOP [upload-logs : Upload console log and json output]