2026-04-14 02:26:06.565768 | Job console starting 2026-04-14 02:26:06.586571 | Updating git repos 2026-04-14 02:26:06.617583 | Cloning repos into workspace 2026-04-14 02:26:07.273390 | Restoring repo states 2026-04-14 02:26:07.282462 | Merging changes 2026-04-14 02:26:07.702919 | Checking out repos 2026-04-14 02:26:07.753588 | Preparing playbooks 2026-04-14 02:26:11.800458 | Running Ansible setup 2026-04-14 02:26:15.922046 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:26:16.580788 | 2026-04-14 02:26:16.580994 | PLAY [localhost] 2026-04-14 02:26:16.590634 | 2026-04-14 02:26:16.590719 | TASK [Gathering Facts] 2026-04-14 02:26:17.600126 | localhost | ok 2026-04-14 02:26:17.610181 | 2026-04-14 02:26:17.610365 | TASK [Setup log path fact] 2026-04-14 02:26:17.629669 | localhost | ok 2026-04-14 02:26:17.640854 | 2026-04-14 02:26:17.640992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:26:17.670263 | localhost | ok 2026-04-14 02:26:17.678089 | 2026-04-14 02:26:17.678183 | TASK [emit-job-header : Print job information] 2026-04-14 02:26:17.718661 | # Job Information 2026-04-14 02:26:17.718880 | Ansible Version: 2.16.16 2026-04-14 02:26:17.718929 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-04-14 02:26:17.718965 | Pipeline: check 2026-04-14 02:26:17.718995 | Executor: 0a8996d2b663 2026-04-14 02:26:17.719025 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/104 2026-04-14 02:26:17.719419 | Event ID: d1276790-37a8-11f1-89b6-dc8b072af067 2026-04-14 02:26:17.724007 | 2026-04-14 02:26:17.724107 | LOOP [emit-job-header : Print node information] 2026-04-14 02:26:17.821236 | localhost | ok: 2026-04-14 02:26:17.821420 | localhost | # Node Information 2026-04-14 02:26:17.821450 | localhost | Inventory Hostname: rockylinux-9 2026-04-14 02:26:17.821478 | localhost | Hostname: np0000165971 2026-04-14 02:26:17.821499 | localhost | Username: zuul 2026-04-14 02:26:17.821524 | localhost | Distro: Rocky 9.7 2026-04-14 02:26:17.821545 | localhost | Provider: yul1 2026-04-14 02:26:17.821565 | localhost | Region: ca-ymq-1 2026-04-14 02:26:17.821584 | localhost | Label: rockylinux-9 2026-04-14 02:26:17.821603 | localhost | Product Name: OpenStack Nova 2026-04-14 02:26:17.821622 | localhost | Interface IP: 199.19.213.85 2026-04-14 02:26:17.838715 | 2026-04-14 02:26:17.839233 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-14 02:26:18.264524 | localhost -> localhost | changed 2026-04-14 02:26:18.271103 | 2026-04-14 02:26:18.271237 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-14 02:26:19.655243 | localhost -> localhost | changed 2026-04-14 02:26:19.663528 | 2026-04-14 02:26:19.663610 | PLAY [all] 2026-04-14 02:26:19.673385 | 2026-04-14 02:26:19.673605 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-14 02:26:19.933733 | rockylinux-9 -> localhost | ok 2026-04-14 02:26:19.939242 | 2026-04-14 02:26:19.939532 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-14 02:26:19.967853 | rockylinux-9 | ok 2026-04-14 02:26:19.987529 | rockylinux-9 | included: /var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-14 02:26:19.996024 | 2026-04-14 02:26:19.996127 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-14 02:26:20.932902 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-14 02:26:20.933128 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/ace9b127dbb04ee3ad44ff788b59928c_id_rsa 2026-04-14 02:26:20.933162 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/ace9b127dbb04ee3ad44ff788b59928c_id_rsa.pub 2026-04-14 02:26:20.933186 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-14 02:26:20.933208 | rockylinux-9 -> localhost | SHA256:wNgwyKnBjZ8QDW1+NYVAKI/UFFmNsbqDlmG4n0i80PM zuul-build-sshkey 2026-04-14 02:26:20.933243 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-14 02:26:20.933266 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-14 02:26:20.933292 | rockylinux-9 -> localhost | |.+X=O== o. | 2026-04-14 02:26:20.933314 | rockylinux-9 -> localhost | |.*+O B.= | 2026-04-14 02:26:20.933334 | rockylinux-9 -> localhost | |.oO o.= . | 2026-04-14 02:26:20.933355 | rockylinux-9 -> localhost | |o. =.. . | 2026-04-14 02:26:20.933375 | rockylinux-9 -> localhost | |.o .. S | 2026-04-14 02:26:20.933396 | rockylinux-9 -> localhost | |oo+ . | 2026-04-14 02:26:20.933416 | rockylinux-9 -> localhost | |o*oo | 2026-04-14 02:26:20.933437 | rockylinux-9 -> localhost | |+o.+. | 2026-04-14 02:26:20.933460 | rockylinux-9 -> localhost | |..o E | 2026-04-14 02:26:20.933482 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-14 02:26:20.933528 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.482278 2026-04-14 02:26:20.938342 | 2026-04-14 02:26:20.938464 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-14 02:26:20.966947 | rockylinux-9 | ok 2026-04-14 02:26:20.975131 | rockylinux-9 | included: /var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-14 02:26:20.982999 | 2026-04-14 02:26:20.983064 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-14 02:26:21.009265 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:26:21.017479 | 2026-04-14 02:26:21.017633 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-14 02:26:21.536243 | rockylinux-9 | changed 2026-04-14 02:26:22.082059 | 2026-04-14 02:26:22.082190 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-14 02:26:22.336562 | rockylinux-9 | ok 2026-04-14 02:26:22.342430 | 2026-04-14 02:26:22.342516 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-14 02:26:23.322324 | rockylinux-9 | changed 2026-04-14 02:26:23.328381 | 2026-04-14 02:26:23.328464 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-14 02:26:24.287676 | rockylinux-9 | changed 2026-04-14 02:26:24.350676 | 2026-04-14 02:26:24.350805 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-14 02:26:24.387086 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:26:24.397817 | 2026-04-14 02:26:24.398049 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-14 02:26:24.871541 | rockylinux-9 -> localhost | changed 2026-04-14 02:26:24.881891 | 2026-04-14 02:26:24.881990 | TASK [add-build-sshkey : Add back temp key] 2026-04-14 02:26:25.191894 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/ace9b127dbb04ee3ad44ff788b59928c_id_rsa (zuul-build-sshkey) 2026-04-14 02:26:25.192133 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014854 2026-04-14 02:26:25.199846 | 2026-04-14 02:26:25.199919 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-14 02:26:25.591300 | rockylinux-9 | ok 2026-04-14 02:26:25.596691 | 2026-04-14 02:26:25.596842 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-14 02:26:25.633105 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:26:25.653852 | 2026-04-14 02:26:25.654134 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-14 02:26:26.141894 | rockylinux-9 | ok 2026-04-14 02:26:26.149572 | 2026-04-14 02:26:26.149677 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-14 02:26:27.162564 | rockylinux-9 | Output suppressed because no_log was given 2026-04-14 02:26:27.170997 | 2026-04-14 02:26:27.171083 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-14 02:26:27.425320 | rockylinux-9 | ok: "logs" 2026-04-14 02:26:27.425591 | rockylinux-9 | ok: All items complete 2026-04-14 02:26:27.425620 | 2026-04-14 02:26:27.650092 | rockylinux-9 | ok: "artifacts" 2026-04-14 02:26:27.866700 | rockylinux-9 | ok: "docs" 2026-04-14 02:26:27.881725 | 2026-04-14 02:26:27.881897 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-14 02:26:28.171279 | rockylinux-9 | changed: "logs" 2026-04-14 02:26:28.408977 | rockylinux-9 | changed: "artifacts" 2026-04-14 02:26:28.631858 | rockylinux-9 | changed: "docs" 2026-04-14 02:26:28.659507 | 2026-04-14 02:26:28.659753 | PLAY RECAP 2026-04-14 02:26:28.659881 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:26:28.659929 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-14 02:26:28.659960 | 2026-04-14 02:26:28.822717 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 02:26:28.825092 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:26:29.445571 | 2026-04-14 02:26:29.445704 | PLAY [all] 2026-04-14 02:26:29.456556 | 2026-04-14 02:26:29.456646 | TASK [setup-uv : Extract archive] 2026-04-14 02:26:32.210355 | rockylinux-9 | changed 2026-04-14 02:26:32.218124 | 2026-04-14 02:26:32.218231 | TASK [setup-uv : Print version] 2026-04-14 02:26:32.250865 | [rockylinux-9] Waiting on logger 2026-04-14 02:26:32.770918 | rockylinux-9 | ok: Runtime: 0:00:00.014390 2026-04-14 02:26:32.778888 | 2026-04-14 02:26:32.778958 | PLAY RECAP 2026-04-14 02:26:32.779018 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:26:32.779055 | 2026-04-14 02:26:32.926144 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-14 02:26:32.927377 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:26:33.543640 | 2026-04-14 02:26:34.197841 | PLAY [all] 2026-04-14 02:26:34.219125 | 2026-04-14 02:26:34.219593 | TASK [Copy inventory file for Zuul] 2026-04-14 02:26:35.562344 | rockylinux-9 | changed 2026-04-14 02:26:35.567678 | 2026-04-14 02:26:35.567754 | TASK [Switch "ansible_host" to private IP] 2026-04-14 02:26:35.931637 | rockylinux-9 | changed: 1 replacements made 2026-04-14 02:26:36.092395 | 2026-04-14 02:26:36.092525 | TASK [Run Molecule scenario] 2026-04-14 02:26:36.114146 | [rockylinux-9] Waiting on logger 2026-04-14 02:26:44.261901 | [rockylinux-9] Waiting on logger 2026-04-14 02:26:53.414395 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:03.593802 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:13.765881 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:23.942123 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:34.118019 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:43.279518 | [rockylinux-9] Waiting on logger 2026-04-14 02:27:53.446811 | [rockylinux-9] Waiting on logger 2026-04-14 02:28:03.621996 | [rockylinux-9] Waiting on logger 2026-04-14 02:28:13.806457 | rockylinux-9 | ok: Runtime: 0:01:36.615718 2026-04-14 02:28:13.813245 | 2026-04-14 02:28:13.813314 | PLAY RECAP 2026-04-14 02:28:13.813374 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-14 02:28:13.813405 | 2026-04-14 02:28:13.941148 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-14 02:28:13.943922 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:28:14.540684 | 2026-04-14 02:28:14.540826 | PLAY [all] 2026-04-14 02:28:14.551807 | 2026-04-14 02:28:14.551885 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-14 02:28:14.597133 | rockylinux-9 | skipping: Conditional result was False 2026-04-14 02:28:14.606187 | 2026-04-14 02:28:14.606296 | TASK [fetch-output : Set log path for single node] 2026-04-14 02:28:14.649800 | rockylinux-9 | ok 2026-04-14 02:28:14.656387 | 2026-04-14 02:28:14.656453 | LOOP [fetch-output : Ensure local output dirs] 2026-04-14 02:28:15.039766 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/logs" 2026-04-14 02:28:15.265175 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/artifacts" 2026-04-14 02:28:15.539057 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/ace9b127dbb04ee3ad44ff788b59928c/work/docs" 2026-04-14 02:28:15.553010 | 2026-04-14 02:28:15.553170 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-14 02:28:16.269447 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:28:16.269689 | rockylinux-9 | changed: All items complete 2026-04-14 02:28:16.269717 | 2026-04-14 02:28:16.790864 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:28:17.313204 | rockylinux-9 | changed: .d..t...... ./ 2026-04-14 02:28:17.331159 | 2026-04-14 02:28:17.331338 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-14 02:28:17.765084 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007836 2026-04-14 02:28:18.004668 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006423 2026-04-14 02:28:18.012884 | 2026-04-14 02:28:18.013028 | PLAY [all] 2026-04-14 02:28:18.018930 | 2026-04-14 02:28:18.019001 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-14 02:28:18.509223 | rockylinux-9 | changed 2026-04-14 02:28:18.517359 | 2026-04-14 02:28:18.517410 | PLAY RECAP 2026-04-14 02:28:18.517458 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-14 02:28:18.517482 | 2026-04-14 02:28:18.674575 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-14 02:28:18.676079 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-14 02:28:19.310049 | 2026-04-14 02:28:19.310625 | PLAY [localhost] 2026-04-14 02:28:19.327733 | 2026-04-14 02:28:19.327813 | TASK [Generate Zuul manifest] 2026-04-14 02:28:19.354791 | localhost | ok 2026-04-14 02:28:19.383730 | 2026-04-14 02:28:19.383888 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-14 02:28:19.731174 | localhost | changed 2026-04-14 02:28:19.749255 | 2026-04-14 02:28:19.749396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-14 02:28:19.780482 | localhost | ok 2026-04-14 02:28:19.789637 | 2026-04-14 02:28:19.789730 | TASK [Upload logs] 2026-04-14 02:28:19.811197 | localhost | ok 2026-04-14 02:28:19.972007 | 2026-04-14 02:28:19.973935 | TASK [Set zuul-log-path fact] 2026-04-14 02:28:20.003294 | localhost | ok 2026-04-14 02:28:20.018318 | 2026-04-14 02:28:20.018400 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 02:28:20.049955 | localhost | ok 2026-04-14 02:28:20.061131 | 2026-04-14 02:28:20.061429 | TASK [upload-logs : Create log directories] 2026-04-14 02:28:20.531110 | localhost | changed 2026-04-14 02:28:20.537492 | 2026-04-14 02:28:20.537572 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-14 02:28:20.965647 | localhost -> localhost | ok: Runtime: 0:00:00.006550 2026-04-14 02:28:20.973230 | 2026-04-14 02:28:20.973392 | TASK [upload-logs : Upload logs to log server] 2026-04-14 02:28:21.555842 | localhost | Output suppressed because no_log was given 2026-04-14 02:28:21.561038 | 2026-04-14 02:28:21.561126 | LOOP [upload-logs : Compress console log and json output] 2026-04-14 02:28:21.607774 | localhost | skipping: Conditional result was False 2026-04-14 02:28:21.614672 | localhost | skipping: Conditional result was False 2026-04-14 02:28:21.643143 | 2026-04-14 02:28:21.643353 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-14 02:28:21.702476 | localhost | skipping: Conditional result was False 2026-04-14 02:28:21.702897 | 2026-04-14 02:28:21.706613 | localhost | skipping: Conditional result was False 2026-04-14 02:28:21.722568 | 2026-04-14 02:28:21.722769 | LOOP [upload-logs : Upload console log and json output]