2026-06-04 01:26:06.825662 | Job console starting 2026-06-04 01:26:06.834691 | Updating git repos 2026-06-04 01:26:06.884046 | Cloning repos into workspace 2026-06-04 01:26:07.251999 | Restoring repo states 2026-06-04 01:26:07.271658 | Merging changes 2026-06-04 01:26:07.511746 | Checking out repos 2026-06-04 01:26:07.548184 | Preparing playbooks 2026-06-04 01:26:09.186157 | Running Ansible setup 2026-06-04 01:26:13.221907 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-04 01:26:13.828371 | 2026-06-04 01:26:13.828522 | PLAY [localhost] 2026-06-04 01:26:13.836497 | 2026-06-04 01:26:13.836569 | TASK [Gathering Facts] 2026-06-04 01:26:14.722707 | localhost | ok 2026-06-04 01:26:14.731864 | 2026-06-04 01:26:14.731947 | TASK [Setup log path fact] 2026-06-04 01:26:14.749394 | localhost | ok 2026-06-04 01:26:14.759224 | 2026-06-04 01:26:14.759293 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-04 01:26:14.794692 | localhost | ok 2026-06-04 01:26:14.979565 | 2026-06-04 01:26:14.979696 | TASK [emit-job-header : Print job information] 2026-06-04 01:26:15.022236 | # Job Information 2026-06-04 01:26:15.022661 | Ansible Version: 2.16.18 2026-06-04 01:26:15.022694 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-06-04 01:26:15.022717 | Pipeline: check 2026-06-04 01:26:15.022738 | Executor: 2d72f0692154 2026-06-04 01:26:15.022758 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/128 2026-06-04 01:26:15.022781 | Event ID: 413217f0-5fb4-11f1-9626-f3f7c026e293 2026-06-04 01:26:15.025631 | 2026-06-04 01:26:15.025696 | LOOP [emit-job-header : Print node information] 2026-06-04 01:26:15.278510 | localhost | ok: 2026-06-04 01:26:15.278781 | localhost | # Node Information 2026-06-04 01:26:15.278842 | localhost | Inventory Hostname: rockylinux-9 2026-06-04 01:26:15.278890 | localhost | Hostname: np0000178468 2026-06-04 01:26:15.278933 | localhost | Username: zuul 2026-06-04 01:26:15.278982 | localhost | Distro: Rocky 9.7 2026-06-04 01:26:15.279025 | localhost | Provider: yul1 2026-06-04 01:26:15.279067 | localhost | Region: ca-ymq-1 2026-06-04 01:26:15.279108 | localhost | Label: rockylinux-9 2026-06-04 01:26:15.279150 | localhost | Product Name: OpenStack Nova 2026-06-04 01:26:15.279190 | localhost | Interface IP: 199.204.45.53 2026-06-04 01:26:15.287352 | 2026-06-04 01:26:15.287424 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-04 01:26:15.687911 | localhost -> localhost | changed 2026-06-04 01:26:15.696555 | 2026-06-04 01:26:15.696674 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-04 01:26:16.846958 | localhost -> localhost | changed 2026-06-04 01:26:16.855414 | 2026-06-04 01:26:16.855469 | PLAY [all] 2026-06-04 01:26:16.864102 | 2026-06-04 01:26:16.864167 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-04 01:26:17.213471 | rockylinux-9 -> localhost | ok 2026-06-04 01:26:17.222238 | 2026-06-04 01:26:17.222332 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-04 01:26:17.254636 | rockylinux-9 | ok 2026-06-04 01:26:17.269856 | rockylinux-9 | included: /var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-04 01:26:17.278234 | 2026-06-04 01:26:17.278304 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-04 01:26:18.216636 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-06-04 01:26:18.216811 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/783e6219d94a42ac9dacd3aa59005604_id_rsa 2026-06-04 01:26:18.216840 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/783e6219d94a42ac9dacd3aa59005604_id_rsa.pub 2026-06-04 01:26:18.216863 | rockylinux-9 -> localhost | The key fingerprint is: 2026-06-04 01:26:18.216884 | rockylinux-9 -> localhost | SHA256:7ydSmBlR8Ng5g2hhOjo82pok7lfPcqiPRi1KexD0MYw zuul-build-sshkey 2026-06-04 01:26:18.216917 | rockylinux-9 -> localhost | The key's randomart image is: 2026-06-04 01:26:18.216937 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-06-04 01:26:18.216985 | rockylinux-9 -> localhost | | o o .o. | 2026-06-04 01:26:18.217008 | rockylinux-9 -> localhost | | E + o o.= . | 2026-06-04 01:26:18.217029 | rockylinux-9 -> localhost | |. . = o o.* | 2026-06-04 01:26:18.217048 | rockylinux-9 -> localhost | | o o o . o | 2026-06-04 01:26:18.217067 | rockylinux-9 -> localhost | | * . S= | 2026-06-04 01:26:18.217086 | rockylinux-9 -> localhost | | = = o +.. | 2026-06-04 01:26:18.217105 | rockylinux-9 -> localhost | |+.* o + .. | 2026-06-04 01:26:18.217124 | rockylinux-9 -> localhost | |+= +.o +... . | 2026-06-04 01:26:18.217146 | rockylinux-9 -> localhost | |+o+oo.o ..o | 2026-06-04 01:26:18.217165 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-06-04 01:26:18.217215 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.487836 2026-06-04 01:26:18.228114 | 2026-06-04 01:26:18.228332 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-04 01:26:18.263598 | rockylinux-9 | ok 2026-06-04 01:26:18.275441 | rockylinux-9 | included: /var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-04 01:26:18.284263 | 2026-06-04 01:26:18.284531 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-04 01:26:18.300577 | rockylinux-9 | skipping: Conditional result was False 2026-06-04 01:26:18.740609 | 2026-06-04 01:26:18.740785 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-04 01:26:19.207964 | rockylinux-9 | changed 2026-06-04 01:26:19.221262 | 2026-06-04 01:26:19.221589 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-04 01:26:19.488766 | rockylinux-9 | ok 2026-06-04 01:26:19.494742 | 2026-06-04 01:26:19.494811 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-04 01:26:20.414153 | rockylinux-9 | changed 2026-06-04 01:26:20.477065 | 2026-06-04 01:26:20.477208 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-04 01:26:21.384156 | rockylinux-9 | changed 2026-06-04 01:26:21.515430 | 2026-06-04 01:26:21.515559 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-04 01:26:21.541282 | rockylinux-9 | skipping: Conditional result was False 2026-06-04 01:26:21.547647 | 2026-06-04 01:26:21.547723 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-04 01:26:22.040997 | rockylinux-9 -> localhost | changed 2026-06-04 01:26:22.055536 | 2026-06-04 01:26:22.056046 | TASK [add-build-sshkey : Add back temp key] 2026-06-04 01:26:22.323522 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/783e6219d94a42ac9dacd3aa59005604_id_rsa (zuul-build-sshkey) 2026-06-04 01:26:22.323770 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014211 2026-06-04 01:26:22.331676 | 2026-06-04 01:26:22.331769 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-04 01:26:22.729642 | rockylinux-9 | ok 2026-06-04 01:26:22.735319 | 2026-06-04 01:26:22.735390 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-04 01:26:22.760252 | rockylinux-9 | skipping: Conditional result was False 2026-06-04 01:26:22.770139 | 2026-06-04 01:26:22.770217 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-04 01:26:23.168697 | rockylinux-9 | ok 2026-06-04 01:26:23.197595 | 2026-06-04 01:26:23.197744 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-04 01:26:24.259548 | rockylinux-9 | Output suppressed because no_log was given 2026-06-04 01:26:24.286873 | 2026-06-04 01:26:24.287008 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-04 01:26:24.541486 | rockylinux-9 | ok: "logs" 2026-06-04 01:26:24.580100 | rockylinux-9 | ok: All items complete 2026-06-04 01:26:24.580210 | 2026-06-04 01:26:24.779092 | rockylinux-9 | ok: "artifacts" 2026-06-04 01:26:25.022780 | rockylinux-9 | ok: "docs" 2026-06-04 01:26:25.185394 | 2026-06-04 01:26:25.185550 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-04 01:26:25.449075 | rockylinux-9 | changed: "logs" 2026-06-04 01:26:25.768475 | rockylinux-9 | changed: "artifacts" 2026-06-04 01:26:26.175628 | rockylinux-9 | changed: "docs" 2026-06-04 01:26:26.188612 | 2026-06-04 01:26:26.188742 | PLAY RECAP 2026-06-04 01:26:26.188789 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 01:26:26.188820 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-04 01:26:26.188842 | 2026-06-04 01:26:26.310206 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-04 01:26:26.311880 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-04 01:26:26.959811 | 2026-06-04 01:26:26.959942 | PLAY [all] 2026-06-04 01:26:26.970601 | 2026-06-04 01:26:26.970677 | TASK [setup-uv : Extract archive] 2026-06-04 01:26:29.819520 | rockylinux-9 | changed 2026-06-04 01:26:29.826810 | 2026-06-04 01:26:29.826894 | TASK [setup-uv : Print version] 2026-06-04 01:26:29.848820 | [rockylinux-9] Waiting on logger 2026-06-04 01:26:30.364364 | rockylinux-9 | ok: Runtime: 0:00:00.017659 2026-06-04 01:26:30.547044 | 2026-06-04 01:26:30.547181 | TASK [Install Ansible collection siblings] 2026-06-04 01:26:31.007482 | rockylinux-9 | ok: 2026-06-04 01:26:31.007662 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-06-04 01:26:31.007691 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-06-04 01:26:31.009418 | 2026-06-04 01:26:31.009471 | PLAY RECAP 2026-06-04 01:26:31.009692 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 01:26:31.009727 | 2026-06-04 01:26:31.166998 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-04 01:26:31.168382 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-04 01:26:31.761602 | 2026-06-04 01:26:31.761759 | PLAY [all] 2026-06-04 01:26:31.773177 | 2026-06-04 01:26:31.773286 | TASK [Copy inventory file for Zuul] 2026-06-04 01:26:33.107720 | rockylinux-9 | changed 2026-06-04 01:26:33.112422 | 2026-06-04 01:26:33.112498 | TASK [Switch "ansible_host" to private IP] 2026-06-04 01:26:33.509978 | rockylinux-9 | changed: 1 replacements made 2026-06-04 01:26:33.515680 | 2026-06-04 01:26:33.515769 | TASK [Run Molecule scenario] 2026-06-04 01:26:33.538207 | [rockylinux-9] Waiting on logger 2026-06-04 01:26:41.674091 | [rockylinux-9] Waiting on logger 2026-06-04 01:26:51.850151 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:00.998241 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:11.174266 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:21.350061 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:31.526350 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:41.702097 | [rockylinux-9] Waiting on logger 2026-06-04 01:27:50.859525 | [rockylinux-9] Waiting on logger 2026-06-04 01:28:01.030152 | [rockylinux-9] Waiting on logger 2026-06-04 01:28:11.206209 | [rockylinux-9] Waiting on logger 2026-06-04 01:28:21.382354 | [rockylinux-9] Waiting on logger 2026-06-04 01:28:31.566212 | rockylinux-9 | ok: Runtime: 0:01:56.541904 2026-06-04 01:28:31.572280 | 2026-06-04 01:28:31.572332 | PLAY RECAP 2026-06-04 01:28:31.572378 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-04 01:28:31.572400 | 2026-06-04 01:28:31.695602 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-04 01:28:31.698105 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-04 01:28:32.289894 | 2026-06-04 01:28:32.290020 | PLAY [all] 2026-06-04 01:28:32.301049 | 2026-06-04 01:28:32.301160 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-04 01:28:32.347041 | rockylinux-9 | skipping: Conditional result was False 2026-06-04 01:28:32.355088 | 2026-06-04 01:28:32.355188 | TASK [fetch-output : Set log path for single node] 2026-06-04 01:28:32.398132 | rockylinux-9 | ok 2026-06-04 01:28:32.403493 | 2026-06-04 01:28:32.403563 | LOOP [fetch-output : Ensure local output dirs] 2026-06-04 01:28:32.822127 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/logs" 2026-06-04 01:28:33.019644 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/artifacts" 2026-06-04 01:28:33.228105 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/783e6219d94a42ac9dacd3aa59005604/work/docs" 2026-06-04 01:28:33.246818 | 2026-06-04 01:28:33.247003 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-04 01:28:33.945206 | rockylinux-9 | changed: .d..t...... ./ 2026-06-04 01:28:33.945435 | rockylinux-9 | changed: All items complete 2026-06-04 01:28:33.945462 | 2026-06-04 01:28:34.465283 | rockylinux-9 | changed: .d..t...... ./ 2026-06-04 01:28:34.985378 | rockylinux-9 | changed: .d..t...... ./ 2026-06-04 01:28:35.003633 | 2026-06-04 01:28:35.003821 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-04 01:28:35.412763 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008026 2026-06-04 01:28:35.629851 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.005845 2026-06-04 01:28:35.649493 | 2026-06-04 01:28:35.649663 | PLAY [all] 2026-06-04 01:28:35.656154 | 2026-06-04 01:28:35.656228 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-04 01:28:36.127000 | rockylinux-9 | changed 2026-06-04 01:28:36.132525 | 2026-06-04 01:28:36.132577 | PLAY RECAP 2026-06-04 01:28:36.132630 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-04 01:28:36.132657 | 2026-06-04 01:28:36.286874 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-04 01:28:36.289221 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-04 01:28:36.856740 | 2026-06-04 01:28:36.857358 | PLAY [localhost] 2026-06-04 01:28:36.867806 | 2026-06-04 01:28:36.867875 | TASK [Generate Zuul manifest] 2026-06-04 01:28:36.891293 | localhost | ok 2026-06-04 01:28:36.909423 | 2026-06-04 01:28:36.909499 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-04 01:28:37.277915 | localhost | changed 2026-06-04 01:28:37.289038 | 2026-06-04 01:28:37.289157 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-04 01:28:37.324711 | localhost | ok 2026-06-04 01:28:37.331931 | 2026-06-04 01:28:37.332002 | TASK [Upload logs] 2026-06-04 01:28:37.354182 | localhost | ok 2026-06-04 01:28:37.412808 | 2026-06-04 01:28:37.422161 | TASK [Set zuul-log-path fact] 2026-06-04 01:28:37.443321 | localhost | ok 2026-06-04 01:28:37.454790 | 2026-06-04 01:28:37.454900 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-04 01:28:37.488073 | localhost | ok 2026-06-04 01:28:37.498270 | 2026-06-04 01:28:37.498469 | TASK [upload-logs : Create log directories] 2026-06-04 01:28:37.968379 | localhost | changed 2026-06-04 01:28:37.976310 | 2026-06-04 01:28:37.976408 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-04 01:28:38.384378 | localhost -> localhost | ok: Runtime: 0:00:00.005313 2026-06-04 01:28:38.390369 | 2026-06-04 01:28:38.390438 | TASK [upload-logs : Upload logs to log server] 2026-06-04 01:28:38.847676 | localhost | Output suppressed because no_log was given 2026-06-04 01:28:38.852764 | 2026-06-04 01:28:38.852860 | LOOP [upload-logs : Compress console log and json output] 2026-06-04 01:28:38.897986 | localhost | skipping: Conditional result was False 2026-06-04 01:28:38.904934 | localhost | skipping: Conditional result was False 2026-06-04 01:28:38.917465 | 2026-06-04 01:28:38.917652 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-04 01:28:38.957484 | localhost | skipping: Conditional result was False 2026-06-04 01:28:38.957847 | 2026-06-04 01:28:38.961574 | localhost | skipping: Conditional result was False 2026-06-04 01:28:38.970822 | 2026-06-04 01:28:38.970946 | LOOP [upload-logs : Upload console log and json output]