2026-04-10 00:54:09.726780 | Job console starting 2026-04-10 00:54:09.822423 | Updating git repos 2026-04-10 00:54:09.997288 | Cloning repos into workspace 2026-04-10 00:54:10.386490 | Restoring repo states 2026-04-10 00:54:10.394307 | Merging changes 2026-04-10 00:54:11.063223 | Checking out repos 2026-04-10 00:54:11.232426 | Preparing playbooks 2026-04-10 00:54:14.454428 | Running Ansible setup 2026-04-10 00:54:18.513139 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-10 00:54:19.179161 | 2026-04-10 00:54:19.179297 | PLAY [localhost] 2026-04-10 00:54:19.192083 | 2026-04-10 00:54:19.192255 | TASK [Gathering Facts] 2026-04-10 00:54:20.140981 | localhost | ok 2026-04-10 00:54:20.163725 | 2026-04-10 00:54:20.163977 | TASK [Setup log path fact] 2026-04-10 00:54:20.203570 | localhost | ok 2026-04-10 00:54:20.235848 | 2026-04-10 00:54:20.236055 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-10 00:54:20.283830 | localhost | ok 2026-04-10 00:54:20.291123 | 2026-04-10 00:54:20.291219 | TASK [emit-job-header : Print job information] 2026-04-10 00:54:20.332290 | # Job Information 2026-04-10 00:54:20.332476 | Ansible Version: 2.16.16 2026-04-10 00:54:20.332510 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-04-10 00:54:20.332534 | Pipeline: check 2026-04-10 00:54:20.332555 | Executor: 0a8996d2b663 2026-04-10 00:54:20.332575 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/102 2026-04-10 00:54:20.332598 | Event ID: a13b32c0-3477-11f1-8c27-8c298754fe0d 2026-04-10 00:54:20.335692 | 2026-04-10 00:54:20.335763 | LOOP [emit-job-header : Print node information] 2026-04-10 00:54:20.430351 | localhost | ok: 2026-04-10 00:54:20.528855 | localhost | # Node Information 2026-04-10 00:54:20.529089 | localhost | Inventory Hostname: rockylinux-9 2026-04-10 00:54:20.529132 | localhost | Hostname: np0000164765 2026-04-10 00:54:20.529174 | localhost | Username: zuul 2026-04-10 00:54:20.529215 | localhost | Distro: Rocky 9.7 2026-04-10 00:54:20.529254 | localhost | Provider: yul1 2026-04-10 00:54:20.529283 | localhost | Region: ca-ymq-1 2026-04-10 00:54:20.529309 | localhost | Label: rockylinux-9 2026-04-10 00:54:20.529342 | localhost | Product Name: OpenStack Nova 2026-04-10 00:54:20.529369 | localhost | Interface IP: 199.204.45.25 2026-04-10 00:54:20.548065 | 2026-04-10 00:54:20.548208 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-10 00:54:21.124370 | localhost -> localhost | changed 2026-04-10 00:54:21.130034 | 2026-04-10 00:54:21.130126 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-10 00:54:22.082534 | localhost -> localhost | changed 2026-04-10 00:54:22.088727 | 2026-04-10 00:54:22.088790 | PLAY [all] 2026-04-10 00:54:22.096142 | 2026-04-10 00:54:22.096210 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-10 00:54:22.381961 | rockylinux-9 -> localhost | ok 2026-04-10 00:54:22.389420 | 2026-04-10 00:54:22.389495 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-10 00:54:22.408478 | rockylinux-9 | ok 2026-04-10 00:54:22.428762 | rockylinux-9 | included: /var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-10 00:54:22.434269 | 2026-04-10 00:54:22.434331 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-10 00:54:23.132349 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-04-10 00:54:23.136621 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/45e0ba77d9ff478ca4657758c079b35b_id_rsa 2026-04-10 00:54:23.136811 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/45e0ba77d9ff478ca4657758c079b35b_id_rsa.pub 2026-04-10 00:54:23.136842 | rockylinux-9 -> localhost | The key fingerprint is: 2026-04-10 00:54:23.136867 | rockylinux-9 -> localhost | SHA256:3iEsEdd11H4qpWr3BnfMF3lwJqxqQZOgEQrzsfinHm8 zuul-build-sshkey 2026-04-10 00:54:23.136904 | rockylinux-9 -> localhost | The key's randomart image is: 2026-04-10 00:54:23.136927 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-04-10 00:54:23.136956 | rockylinux-9 -> localhost | | o . +.oo o.oo. | 2026-04-10 00:54:23.136979 | rockylinux-9 -> localhost | | = + = = .+ +| 2026-04-10 00:54:23.137019 | rockylinux-9 -> localhost | | . + o . . . *.| 2026-04-10 00:54:23.137042 | rockylinux-9 -> localhost | | . o . . .o+| 2026-04-10 00:54:23.137062 | rockylinux-9 -> localhost | | . o S .o o ++| 2026-04-10 00:54:23.137082 | rockylinux-9 -> localhost | | o o oo.+ o =| 2026-04-10 00:54:23.137102 | rockylinux-9 -> localhost | | o .... + ..| 2026-04-10 00:54:23.137122 | rockylinux-9 -> localhost | | . oE o . . | 2026-04-10 00:54:23.137146 | rockylinux-9 -> localhost | | ... . . o. | 2026-04-10 00:54:23.137166 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-04-10 00:54:23.137255 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.292941 2026-04-10 00:54:23.142886 | 2026-04-10 00:54:23.142953 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-10 00:54:23.173543 | rockylinux-9 | ok 2026-04-10 00:54:23.183373 | rockylinux-9 | included: /var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-10 00:54:23.192096 | 2026-04-10 00:54:23.192161 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-10 00:54:23.207500 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:23.215094 | 2026-04-10 00:54:23.215194 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-10 00:54:23.696381 | rockylinux-9 | changed 2026-04-10 00:54:23.702833 | 2026-04-10 00:54:23.702906 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-10 00:54:23.967036 | rockylinux-9 | ok 2026-04-10 00:54:23.978546 | 2026-04-10 00:54:23.978614 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-10 00:54:24.900563 | rockylinux-9 | changed 2026-04-10 00:54:24.909401 | 2026-04-10 00:54:24.909487 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-10 00:54:25.807968 | rockylinux-9 | changed 2026-04-10 00:54:25.817297 | 2026-04-10 00:54:25.817366 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-10 00:54:25.841698 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:25.847219 | 2026-04-10 00:54:25.847291 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-10 00:54:26.288194 | rockylinux-9 -> localhost | changed 2026-04-10 00:54:26.301003 | 2026-04-10 00:54:26.301095 | TASK [add-build-sshkey : Add back temp key] 2026-04-10 00:54:26.763758 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/45e0ba77d9ff478ca4657758c079b35b_id_rsa (zuul-build-sshkey) 2026-04-10 00:54:26.763971 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.012205 2026-04-10 00:54:26.772567 | 2026-04-10 00:54:26.772633 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-10 00:54:27.167346 | rockylinux-9 | ok 2026-04-10 00:54:27.260911 | 2026-04-10 00:54:27.261063 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-10 00:54:27.286847 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:54:27.298982 | 2026-04-10 00:54:27.299559 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-10 00:54:27.751154 | rockylinux-9 | ok 2026-04-10 00:54:27.756579 | 2026-04-10 00:54:27.756650 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-10 00:54:28.721386 | rockylinux-9 | Output suppressed because no_log was given 2026-04-10 00:54:28.781253 | 2026-04-10 00:54:28.781357 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-10 00:54:29.051799 | rockylinux-9 | ok: "logs" 2026-04-10 00:54:29.053396 | rockylinux-9 | ok: All items complete 2026-04-10 00:54:29.053579 | 2026-04-10 00:54:29.276867 | rockylinux-9 | ok: "artifacts" 2026-04-10 00:54:29.500636 | rockylinux-9 | ok: "docs" 2026-04-10 00:54:29.652938 | 2026-04-10 00:54:29.653114 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-10 00:54:29.931864 | rockylinux-9 | changed: "logs" 2026-04-10 00:54:30.157618 | rockylinux-9 | changed: "artifacts" 2026-04-10 00:54:30.376463 | rockylinux-9 | changed: "docs" 2026-04-10 00:54:30.390458 | 2026-04-10 00:54:30.390581 | PLAY RECAP 2026-04-10 00:54:30.390634 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:54:30.390667 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-10 00:54:30.390692 | 2026-04-10 00:54:30.615120 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-10 00:54:30.617098 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-10 00:54:31.282450 | 2026-04-10 00:54:31.282587 | PLAY [all] 2026-04-10 00:54:31.295237 | 2026-04-10 00:54:31.295327 | TASK [setup-uv : Extract archive] 2026-04-10 00:54:34.093989 | rockylinux-9 | changed 2026-04-10 00:54:34.099307 | 2026-04-10 00:54:34.099388 | TASK [setup-uv : Print version] 2026-04-10 00:54:34.144561 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:34.655212 | rockylinux-9 | ok: Runtime: 0:00:00.014138 2026-04-10 00:54:34.664052 | 2026-04-10 00:54:34.664181 | PLAY RECAP 2026-04-10 00:54:34.664238 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:54:34.664285 | 2026-04-10 00:54:34.864106 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-10 00:54:34.868632 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-10 00:54:35.568708 | 2026-04-10 00:54:35.568839 | PLAY [all] 2026-04-10 00:54:35.579782 | 2026-04-10 00:54:35.579856 | TASK [Copy inventory file for Zuul] 2026-04-10 00:54:37.018366 | rockylinux-9 | changed 2026-04-10 00:54:37.023210 | 2026-04-10 00:54:37.023308 | TASK [Switch "ansible_host" to private IP] 2026-04-10 00:54:37.380774 | rockylinux-9 | changed: 1 replacements made 2026-04-10 00:54:37.467495 | 2026-04-10 00:54:37.467594 | TASK [Run Molecule scenario] 2026-04-10 00:54:37.488300 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:45.637995 | [rockylinux-9] Waiting on logger 2026-04-10 00:54:55.814127 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:05.990722 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:15.147521 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:25.515103 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:35.686045 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:45.866063 | [rockylinux-9] Waiting on logger 2026-04-10 00:55:56.042019 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:05.195101 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:15.365905 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:25.545874 | [rockylinux-9] Waiting on logger 2026-04-10 00:56:31.149421 | rockylinux-9 | ok: Runtime: 0:01:52.148516 2026-04-10 00:56:31.155838 | 2026-04-10 00:56:31.155920 | PLAY RECAP 2026-04-10 00:56:31.155990 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-10 00:56:31.156022 | 2026-04-10 00:56:31.351542 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-10 00:56:31.365526 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-10 00:56:32.023467 | 2026-04-10 00:56:32.023625 | PLAY [all] 2026-04-10 00:56:32.034850 | 2026-04-10 00:56:32.034961 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-10 00:56:32.091680 | rockylinux-9 | skipping: Conditional result was False 2026-04-10 00:56:32.100335 | 2026-04-10 00:56:32.100496 | TASK [fetch-output : Set log path for single node] 2026-04-10 00:56:32.144410 | rockylinux-9 | ok 2026-04-10 00:56:32.154045 | 2026-04-10 00:56:32.154227 | LOOP [fetch-output : Ensure local output dirs] 2026-04-10 00:56:32.660273 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/logs" 2026-04-10 00:56:32.868421 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/artifacts" 2026-04-10 00:56:33.087279 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/45e0ba77d9ff478ca4657758c079b35b/work/docs" 2026-04-10 00:56:33.102948 | 2026-04-10 00:56:33.103160 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-10 00:56:33.854689 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:56:33.855048 | rockylinux-9 | changed: All items complete 2026-04-10 00:56:33.855184 | 2026-04-10 00:56:34.357197 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:56:34.872285 | rockylinux-9 | changed: .d..t...... ./ 2026-04-10 00:56:34.891083 | 2026-04-10 00:56:34.891231 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-10 00:56:35.321225 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007253 2026-04-10 00:56:35.560872 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007076 2026-04-10 00:56:35.578494 | 2026-04-10 00:56:35.578640 | PLAY [all] 2026-04-10 00:56:35.584471 | 2026-04-10 00:56:35.584544 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-10 00:56:36.088203 | rockylinux-9 | changed 2026-04-10 00:56:36.093844 | 2026-04-10 00:56:36.093896 | PLAY RECAP 2026-04-10 00:56:36.093941 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-10 00:56:36.093965 | 2026-04-10 00:56:36.254882 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-10 00:56:36.257092 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-10 00:56:36.827111 | 2026-04-10 00:56:36.827272 | PLAY [localhost] 2026-04-10 00:56:36.837618 | 2026-04-10 00:56:36.837699 | TASK [Generate Zuul manifest] 2026-04-10 00:56:36.857919 | localhost | ok 2026-04-10 00:56:36.876377 | 2026-04-10 00:56:36.876460 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-10 00:56:37.230295 | localhost | changed 2026-04-10 00:56:37.252169 | 2026-04-10 00:56:37.252303 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-10 00:56:37.285231 | localhost | ok 2026-04-10 00:56:37.293895 | 2026-04-10 00:56:37.293964 | TASK [Upload logs] 2026-04-10 00:56:37.317894 | localhost | ok 2026-04-10 00:56:37.379538 | 2026-04-10 00:56:37.379695 | TASK [Set zuul-log-path fact] 2026-04-10 00:56:37.399745 | localhost | ok 2026-04-10 00:56:37.412807 | 2026-04-10 00:56:37.412886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-10 00:56:37.445101 | localhost | ok 2026-04-10 00:56:37.454078 | 2026-04-10 00:56:37.454144 | TASK [upload-logs : Create log directories] 2026-04-10 00:56:37.932188 | localhost | changed 2026-04-10 00:56:37.938605 | 2026-04-10 00:56:37.938703 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-10 00:56:38.386265 | localhost -> localhost | ok: Runtime: 0:00:00.005394 2026-04-10 00:56:38.391487 | 2026-04-10 00:56:38.391574 | TASK [upload-logs : Upload logs to log server] 2026-04-10 00:56:38.926150 | localhost | Output suppressed because no_log was given 2026-04-10 00:56:38.929706 | 2026-04-10 00:56:38.929772 | LOOP [upload-logs : Compress console log and json output] 2026-04-10 00:56:38.978543 | localhost | skipping: Conditional result was False 2026-04-10 00:56:38.986053 | localhost | skipping: Conditional result was False 2026-04-10 00:56:39.002866 | 2026-04-10 00:56:39.003056 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-10 00:56:39.053527 | localhost | skipping: Conditional result was False 2026-04-10 00:56:39.053840 | 2026-04-10 00:56:39.058309 | localhost | skipping: Conditional result was False 2026-04-10 00:56:39.067340 | 2026-04-10 00:56:39.067495 | LOOP [upload-logs : Upload console log and json output]