2026-09-05 00:54:23.637969 | Job console starting 2026-09-05 00:54:23.665294 | Updating git repos 2026-09-05 00:54:23.695130 | Cloning repos into workspace 2026-09-05 00:54:24.067072 | Restoring repo states 2026-09-05 00:54:24.077275 | Merging changes 2026-09-05 00:54:24.607602 | Checking out repos 2026-09-05 00:54:24.734397 | Preparing playbooks 2026-09-05 00:54:26.463579 | Running Ansible setup 2026-09-05 00:54:30.325431 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-05 00:54:30.996816 | 2026-09-05 00:54:30.996978 | PLAY [localhost] 2026-09-05 00:54:31.004547 | 2026-09-05 00:54:31.004617 | TASK [Gathering Facts] 2026-09-05 00:54:31.958590 | localhost | ok 2026-09-05 00:54:31.972854 | 2026-09-05 00:54:31.973263 | TASK [Setup log path fact] 2026-09-05 00:54:31.992746 | localhost | ok 2026-09-05 00:54:32.006546 | 2026-09-05 00:54:32.006742 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 00:54:32.035623 | localhost | ok 2026-09-05 00:54:32.043693 | 2026-09-05 00:54:32.043834 | TASK [emit-job-header : Print job information] 2026-09-05 00:54:32.095439 | # Job Information 2026-09-05 00:54:32.095705 | Ansible Version: 2.16.18 2026-09-05 00:54:32.095791 | Job: ansible-collection-containers-molecule-docker-rockylinux-9 2026-09-05 00:54:32.095841 | Pipeline: check 2026-09-05 00:54:32.095882 | Executor: 2d72f0692154 2026-09-05 00:54:32.095921 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149 2026-09-05 00:54:32.095965 | Event ID: b7f4aa30-a8c3-11f1-9178-a13e202f19f2 2026-09-05 00:54:32.101418 | 2026-09-05 00:54:32.101572 | LOOP [emit-job-header : Print node information] 2026-09-05 00:54:32.180358 | localhost | ok: 2026-09-05 00:54:32.180622 | localhost | # Node Information 2026-09-05 00:54:32.180665 | localhost | Inventory Hostname: rockylinux-9 2026-09-05 00:54:32.180697 | localhost | Hostname: np0000191933 2026-09-05 00:54:32.180725 | localhost | Username: zuul 2026-09-05 00:54:32.180757 | localhost | Distro: Rocky 9.7 2026-09-05 00:54:32.180789 | localhost | Provider: yul1 2026-09-05 00:54:32.180816 | localhost | Region: ca-ymq-1 2026-09-05 00:54:32.180843 | localhost | Label: rockylinux-9 2026-09-05 00:54:32.180870 | localhost | Product Name: OpenStack Nova 2026-09-05 00:54:32.180897 | localhost | Interface IP: 162.253.55.15 2026-09-05 00:54:32.189314 | 2026-09-05 00:54:32.189535 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-05 00:54:32.598936 | localhost -> localhost | changed 2026-09-05 00:54:32.604000 | 2026-09-05 00:54:32.604067 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-05 00:54:33.419694 | localhost -> localhost | changed 2026-09-05 00:54:33.433117 | 2026-09-05 00:54:33.433249 | PLAY [all] 2026-09-05 00:54:33.457122 | 2026-09-05 00:54:33.457260 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-05 00:54:33.745373 | rockylinux-9 -> localhost | ok 2026-09-05 00:54:33.752676 | 2026-09-05 00:54:33.752787 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-05 00:54:33.782064 | rockylinux-9 | ok 2026-09-05 00:54:33.798260 | rockylinux-9 | included: /var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-05 00:54:33.804662 | 2026-09-05 00:54:33.804719 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-05 00:54:35.614911 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-09-05 00:54:35.615229 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/0a60b6ab1a0749ee9a6f9e4e086d2227_id_rsa 2026-09-05 00:54:35.615289 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/0a60b6ab1a0749ee9a6f9e4e086d2227_id_rsa.pub 2026-09-05 00:54:35.615334 | rockylinux-9 -> localhost | The key fingerprint is: 2026-09-05 00:54:35.615374 | rockylinux-9 -> localhost | SHA256:FzysxemtUODNi+2sAvXj1ufQa8mxKRBOxO4Jwdz4fV0 zuul-build-sshkey 2026-09-05 00:54:35.615428 | rockylinux-9 -> localhost | The key's randomart image is: 2026-09-05 00:54:35.615468 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-09-05 00:54:35.615563 | rockylinux-9 -> localhost | | o +. | 2026-09-05 00:54:35.615620 | rockylinux-9 -> localhost | | =.+B . E| 2026-09-05 00:54:35.615661 | rockylinux-9 -> localhost | | =..% . . | 2026-09-05 00:54:35.615701 | rockylinux-9 -> localhost | | o =B.=. . | 2026-09-05 00:54:35.615739 | rockylinux-9 -> localhost | | . *So=.. | 2026-09-05 00:54:35.615788 | rockylinux-9 -> localhost | | . B= o. | 2026-09-05 00:54:35.615826 | rockylinux-9 -> localhost | | . . +=..= | 2026-09-05 00:54:35.615864 | rockylinux-9 -> localhost | | . o.o.B. | 2026-09-05 00:54:35.615908 | rockylinux-9 -> localhost | | o. =o | 2026-09-05 00:54:35.616015 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-09-05 00:54:35.616159 | rockylinux-9 -> localhost | ok: Runtime: 0:00:01.284913 2026-09-05 00:54:35.625281 | 2026-09-05 00:54:35.625403 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-05 00:54:35.658272 | rockylinux-9 | ok 2026-09-05 00:54:35.673277 | rockylinux-9 | included: /var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-05 00:54:35.684635 | 2026-09-05 00:54:35.684729 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-05 00:54:35.709043 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:35.720276 | 2026-09-05 00:54:35.720414 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-05 00:54:36.215414 | rockylinux-9 | changed 2026-09-05 00:54:36.219592 | 2026-09-05 00:54:36.219655 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-05 00:54:36.504829 | rockylinux-9 | ok 2026-09-05 00:54:36.513685 | 2026-09-05 00:54:36.513811 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-05 00:54:37.517452 | rockylinux-9 | changed 2026-09-05 00:54:37.521881 | 2026-09-05 00:54:37.521953 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-05 00:54:38.494326 | rockylinux-9 | changed 2026-09-05 00:54:38.504869 | 2026-09-05 00:54:38.504991 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-05 00:54:38.529481 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:38.539443 | 2026-09-05 00:54:38.539588 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-05 00:54:38.951493 | rockylinux-9 -> localhost | changed 2026-09-05 00:54:38.963890 | 2026-09-05 00:54:38.963986 | TASK [add-build-sshkey : Add back temp key] 2026-09-05 00:54:39.268377 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/0a60b6ab1a0749ee9a6f9e4e086d2227_id_rsa (zuul-build-sshkey) 2026-09-05 00:54:39.268683 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.017227 2026-09-05 00:54:39.274647 | 2026-09-05 00:54:39.274733 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-05 00:54:39.678576 | rockylinux-9 | ok 2026-09-05 00:54:39.686361 | 2026-09-05 00:54:39.686485 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-05 00:54:39.722175 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:39.751704 | 2026-09-05 00:54:39.751948 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-05 00:54:40.192868 | rockylinux-9 | ok 2026-09-05 00:54:40.205900 | 2026-09-05 00:54:40.205986 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-05 00:54:41.396284 | rockylinux-9 | Output suppressed because no_log was given 2026-09-05 00:54:41.411623 | 2026-09-05 00:54:41.411892 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-05 00:54:41.701415 | rockylinux-9 | ok: "logs" 2026-09-05 00:54:41.702055 | rockylinux-9 | ok: All items complete 2026-09-05 00:54:41.702127 | 2026-09-05 00:54:41.922638 | rockylinux-9 | ok: "artifacts" 2026-09-05 00:54:42.162991 | rockylinux-9 | ok: "docs" 2026-09-05 00:54:42.179390 | 2026-09-05 00:54:42.179574 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-05 00:54:42.451678 | rockylinux-9 | changed: "logs" 2026-09-05 00:54:42.689928 | rockylinux-9 | changed: "artifacts" 2026-09-05 00:54:42.963126 | rockylinux-9 | changed: "docs" 2026-09-05 00:54:42.987152 | 2026-09-05 00:54:42.987337 | PLAY RECAP 2026-09-05 00:54:42.987423 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-05 00:54:42.987480 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-05 00:54:42.987579 | 2026-09-05 00:54:43.183123 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-05 00:54:43.185469 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-05 00:54:43.800928 | 2026-09-05 00:54:43.801088 | PLAY [all] 2026-09-05 00:54:43.812405 | 2026-09-05 00:54:43.812477 | TASK [setup-uv : Extract archive] 2026-09-05 00:54:46.656887 | rockylinux-9 | changed 2026-09-05 00:54:46.668830 | 2026-09-05 00:54:46.668983 | TASK [setup-uv : Print version] 2026-09-05 00:54:46.706952 | [rockylinux-9] Waiting on logger 2026-09-05 00:54:47.222350 | rockylinux-9 | ok: Runtime: 0:00:00.017268 2026-09-05 00:54:47.242867 | 2026-09-05 00:54:47.243041 | TASK [Install Ansible collection siblings] 2026-09-05 00:54:47.800462 | rockylinux-9 | ok: 2026-09-05 00:54:47.800874 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-09-05 00:54:47.800935 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-09-05 00:54:47.803816 | 2026-09-05 00:54:47.803908 | PLAY RECAP 2026-09-05 00:54:47.803990 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-05 00:54:47.804031 | 2026-09-05 00:54:48.008656 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-05 00:54:48.011025 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-05 00:54:48.634680 | 2026-09-05 00:54:48.634792 | PLAY [all] 2026-09-05 00:54:48.644454 | 2026-09-05 00:54:48.644562 | LOOP [Check inventory directories] 2026-09-05 00:54:49.038983 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-09-05 00:54:49.300568 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/docker/inventory" 2026-09-05 00:54:49.538216 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/inventory" 2026-09-05 00:54:49.556557 | 2026-09-05 00:54:49.556791 | LOOP [Copy inventory file for Zuul] 2026-09-05 00:54:50.930606 | rockylinux-9 | changed: 2026-09-05 00:54:50.930937 | rockylinux-9 | { 2026-09-05 00:54:50.930992 | rockylinux-9 | "ansible_loop_var": "item", 2026-09-05 00:54:50.931036 | rockylinux-9 | "changed": false, 2026-09-05 00:54:50.931074 | rockylinux-9 | "failed": false, 2026-09-05 00:54:50.931116 | rockylinux-9 | "invocation": { 2026-09-05 00:54:50.931151 | rockylinux-9 | "module_args": { 2026-09-05 00:54:50.931186 | rockylinux-9 | "checksum_algorithm": "sha1", 2026-09-05 00:54:50.931237 | rockylinux-9 | "follow": true, 2026-09-05 00:54:50.931274 | rockylinux-9 | "get_attributes": true, 2026-09-05 00:54:50.931311 | rockylinux-9 | "get_checksum": true, 2026-09-05 00:54:50.931345 | rockylinux-9 | "get_mime": true, 2026-09-05 00:54:50.931378 | rockylinux-9 | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-09-05 00:54:50.931412 | rockylinux-9 | } 2026-09-05 00:54:50.931445 | rockylinux-9 | }, 2026-09-05 00:54:50.931478 | rockylinux-9 | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-05 00:54:50.931552 | rockylinux-9 | "stat": { 2026-09-05 00:54:50.931590 | rockylinux-9 | "atime": 1788569681.459, 2026-09-05 00:54:50.931624 | rockylinux-9 | "attr_flags": "e", 2026-09-05 00:54:50.931657 | rockylinux-9 | "attributes": [ 2026-09-05 00:54:50.931690 | rockylinux-9 | "extents" 2026-09-05 00:54:50.931723 | rockylinux-9 | ], 2026-09-05 00:54:50.931755 | rockylinux-9 | "block_size": 4096, 2026-09-05 00:54:50.931788 | rockylinux-9 | "blocks": 8, 2026-09-05 00:54:50.931822 | rockylinux-9 | "charset": "binary", 2026-09-05 00:54:50.931874 | rockylinux-9 | "ctime": 1788569681.482, 2026-09-05 00:54:50.931909 | rockylinux-9 | "dev": 64513, 2026-09-05 00:54:50.931943 | rockylinux-9 | "device_type": 0, 2026-09-05 00:54:50.931975 | rockylinux-9 | "executable": true, 2026-09-05 00:54:50.932008 | rockylinux-9 | "exists": true, 2026-09-05 00:54:50.932040 | rockylinux-9 | "gid": 1000, 2026-09-05 00:54:50.932072 | rockylinux-9 | "gr_name": "zuul", 2026-09-05 00:54:50.932104 | rockylinux-9 | "inode": 525401, 2026-09-05 00:54:50.932136 | rockylinux-9 | "isblk": false, 2026-09-05 00:54:50.932170 | rockylinux-9 | "ischr": false, 2026-09-05 00:54:50.932203 | rockylinux-9 | "isdir": true, 2026-09-05 00:54:50.932235 | rockylinux-9 | "isfifo": false, 2026-09-05 00:54:50.932267 | rockylinux-9 | "isgid": false, 2026-09-05 00:54:50.932299 | rockylinux-9 | "islnk": false, 2026-09-05 00:54:50.932331 | rockylinux-9 | "isreg": false, 2026-09-05 00:54:50.932362 | rockylinux-9 | "issock": false, 2026-09-05 00:54:50.932394 | rockylinux-9 | "isuid": false, 2026-09-05 00:54:50.932426 | rockylinux-9 | "mimetype": "inode/directory", 2026-09-05 00:54:50.932457 | rockylinux-9 | "mode": "0755", 2026-09-05 00:54:50.932489 | rockylinux-9 | "mtime": 1788569664.1184573, 2026-09-05 00:54:50.932572 | rockylinux-9 | "nlink": 11, 2026-09-05 00:54:50.932606 | rockylinux-9 | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-05 00:54:50.932639 | rockylinux-9 | "pw_name": "zuul", 2026-09-05 00:54:50.932677 | rockylinux-9 | "readable": true, 2026-09-05 00:54:50.932711 | rockylinux-9 | "rgrp": true, 2026-09-05 00:54:50.932744 | rockylinux-9 | "roth": true, 2026-09-05 00:54:50.932777 | rockylinux-9 | "rusr": true, 2026-09-05 00:54:50.932809 | rockylinux-9 | "size": 4096, 2026-09-05 00:54:50.932841 | rockylinux-9 | "uid": 1000, 2026-09-05 00:54:50.932873 | rockylinux-9 | "version": "3030563450", 2026-09-05 00:54:50.932906 | rockylinux-9 | "wgrp": false, 2026-09-05 00:54:50.932942 | rockylinux-9 | "woth": false, 2026-09-05 00:54:50.932974 | rockylinux-9 | "writeable": true, 2026-09-05 00:54:50.933006 | rockylinux-9 | "wusr": true, 2026-09-05 00:54:50.933038 | rockylinux-9 | "xgrp": true, 2026-09-05 00:54:50.933069 | rockylinux-9 | "xoth": true, 2026-09-05 00:54:50.933099 | rockylinux-9 | "xusr": true 2026-09-05 00:54:50.933131 | rockylinux-9 | } 2026-09-05 00:54:50.933163 | rockylinux-9 | } 2026-09-05 00:54:50.933226 | rockylinux-9 | ok: All items complete 2026-09-05 00:54:50.933265 | 2026-09-05 00:54:50.935886 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:50.937075 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:50.957925 | 2026-09-05 00:54:50.958160 | LOOP [Switch "ansible_host" to private IP] 2026-09-05 00:54:51.384846 | rockylinux-9 | changed: 1 replacements made 2026-09-05 00:54:51.387090 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:51.391313 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 00:54:51.406640 | 2026-09-05 00:54:51.406863 | TASK [Run Molecule scenario] 2026-09-05 00:54:51.442899 | [rockylinux-9] Waiting on logger 2026-09-05 00:54:58.565713 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:07.722784 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:17.893455 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:28.069465 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:38.245399 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:48.425713 | [rockylinux-9] Waiting on logger 2026-09-05 00:55:58.597447 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:07.754847 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:17.925444 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:28.105374 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:38.277631 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:48.457399 | [rockylinux-9] Waiting on logger 2026-09-05 00:56:58.629357 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:07.786802 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:17.957515 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:28.133478 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:38.309579 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:48.485687 | [rockylinux-9] Waiting on logger 2026-09-05 00:57:58.661829 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:07.819187 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:17.993615 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:28.165626 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:38.341722 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:48.517477 | [rockylinux-9] Waiting on logger 2026-09-05 00:58:58.693606 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:07.845685 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:18.021515 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:28.197623 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:38.373702 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:48.549539 | [rockylinux-9] Waiting on logger 2026-09-05 00:59:57.711103 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:07.877675 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:18.053611 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:28.229842 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:38.405735 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:48.581610 | [rockylinux-9] Waiting on logger 2026-09-05 01:00:57.739391 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:07.909770 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:18.085541 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:28.261561 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:38.437682 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:48.613671 | [rockylinux-9] Waiting on logger 2026-09-05 01:01:57.771065 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:07.941543 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:18.117500 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:28.293705 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:38.469576 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:48.645646 | [rockylinux-9] Waiting on logger 2026-09-05 01:02:57.803054 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:07.973638 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:18.149637 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:28.325699 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:38.502394 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:48.677862 | [rockylinux-9] Waiting on logger 2026-09-05 01:03:57.829933 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:08.005682 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:18.181694 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:28.357773 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:38.533738 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:48.709785 | [rockylinux-9] Waiting on logger 2026-09-05 01:04:57.865526 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:08.037713 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:18.213623 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:28.390313 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:38.565800 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:47.722842 | [rockylinux-9] Waiting on logger 2026-09-05 01:05:57.893760 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:08.069820 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:18.245744 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:28.421596 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:38.598014 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:47.754888 | [rockylinux-9] Waiting on logger 2026-09-05 01:06:51.116051 | rockylinux-9 | ok: Runtime: 0:11:58.285417 2026-09-05 01:06:51.125306 | 2026-09-05 01:06:51.125403 | PLAY RECAP 2026-09-05 01:06:51.125479 | rockylinux-9 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-05 01:06:51.125518 | 2026-09-05 01:06:51.233745 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-05 01:06:51.235950 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 01:06:51.765511 | 2026-09-05 01:06:51.765616 | PLAY [all] 2026-09-05 01:06:51.774776 | 2026-09-05 01:06:51.774845 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-05 01:06:51.838657 | rockylinux-9 | skipping: Conditional result was False 2026-09-05 01:06:51.844073 | 2026-09-05 01:06:51.844171 | TASK [fetch-output : Set log path for single node] 2026-09-05 01:06:51.894909 | rockylinux-9 | ok 2026-09-05 01:06:51.902705 | 2026-09-05 01:06:51.902845 | LOOP [fetch-output : Ensure local output dirs] 2026-09-05 01:06:52.260463 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/logs" 2026-09-05 01:06:52.472135 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/artifacts" 2026-09-05 01:06:52.677689 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/0a60b6ab1a0749ee9a6f9e4e086d2227/work/docs" 2026-09-05 01:06:52.693148 | 2026-09-05 01:06:52.693320 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-05 01:06:53.430846 | rockylinux-9 | ok 2026-09-05 01:06:53.431149 | rockylinux-9 | changed: All items complete 2026-09-05 01:06:53.431204 | 2026-09-05 01:06:53.971796 | rockylinux-9 | changed: .d..t...... ./ 2026-09-05 01:06:54.522979 | rockylinux-9 | changed: .d..t...... ./ 2026-09-05 01:06:54.549370 | 2026-09-05 01:06:54.549563 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-05 01:06:54.971833 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.005537 2026-09-05 01:06:55.213735 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.005919 2026-09-05 01:06:55.238154 | 2026-09-05 01:06:55.238308 | PLAY [all] 2026-09-05 01:06:55.245162 | 2026-09-05 01:06:55.245243 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-05 01:06:55.705414 | rockylinux-9 | changed 2026-09-05 01:06:55.715212 | 2026-09-05 01:06:55.715352 | PLAY RECAP 2026-09-05 01:06:55.715465 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-05 01:06:55.715513 | 2026-09-05 01:06:55.820564 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-05 01:06:55.822864 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-05 01:06:56.372287 | 2026-09-05 01:06:56.372464 | PLAY [localhost] 2026-09-05 01:06:56.383923 | 2026-09-05 01:06:56.384029 | TASK [Generate Zuul manifest] 2026-09-05 01:06:56.402546 | localhost | ok 2026-09-05 01:06:56.418930 | 2026-09-05 01:06:56.419043 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-05 01:06:56.794004 | localhost | changed 2026-09-05 01:06:56.806299 | 2026-09-05 01:06:56.806372 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-05 01:06:56.836833 | localhost | ok 2026-09-05 01:06:56.845244 | 2026-09-05 01:06:56.845349 | TASK [Upload logs] 2026-09-05 01:06:56.863534 | localhost | ok 2026-09-05 01:06:56.921690 | 2026-09-05 01:06:56.921793 | TASK [Set zuul-log-path fact] 2026-09-05 01:06:56.938516 | localhost | ok 2026-09-05 01:06:56.949802 | 2026-09-05 01:06:56.949881 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-05 01:06:56.976385 | localhost | ok 2026-09-05 01:06:56.982176 | 2026-09-05 01:06:56.982235 | TASK [upload-logs : Create log directories] 2026-09-05 01:06:57.375030 | localhost | changed 2026-09-05 01:06:57.388827 | 2026-09-05 01:06:57.389626 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-05 01:06:57.796935 | localhost -> localhost | ok: Runtime: 0:00:00.004395 2026-09-05 01:06:57.805783 | 2026-09-05 01:06:57.805915 | TASK [upload-logs : Upload logs to log server] 2026-09-05 01:06:58.308275 | localhost | Output suppressed because no_log was given 2026-09-05 01:06:58.312965 | 2026-09-05 01:06:58.313063 | LOOP [upload-logs : Compress console log and json output] 2026-09-05 01:06:58.350988 | localhost | skipping: Conditional result was False 2026-09-05 01:06:58.360852 | localhost | skipping: Conditional result was False 2026-09-05 01:06:58.376986 | 2026-09-05 01:06:58.377225 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-05 01:06:58.413767 | localhost | skipping: Conditional result was False 2026-09-05 01:06:58.414041 | 2026-09-05 01:06:58.418017 | localhost | skipping: Conditional result was False 2026-09-05 01:06:58.426599 | 2026-09-05 01:06:58.426730 | LOOP [upload-logs : Upload console log and json output]