2026-09-12 00:52:17.049087 | Job console starting
2026-09-12 00:52:17.063755 | Updating git repos
2026-09-12 00:52:17.092224 | Cloning repos into workspace
2026-09-12 00:52:17.136960 | Restoring repo states
2026-09-12 00:52:17.145871 | Merging changes
2026-09-12 00:52:17.811447 | Checking out repos
2026-09-12 00:52:17.855264 | Preparing playbooks
2026-09-12 00:52:19.364955 | Running Ansible setup
2026-09-12 00:52:22.955129 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-12 00:52:23.546294 | 
2026-09-12 00:52:23.546804 | PLAY [localhost]
2026-09-12 00:52:23.554076 | 
2026-09-12 00:52:23.554140 | TASK [Gathering Facts]
2026-09-12 00:52:24.543982 | localhost | ok
2026-09-12 00:52:24.558239 | 
2026-09-12 00:52:24.558534 | TASK [Setup log path fact]
2026-09-12 00:52:24.582257 | localhost | ok
2026-09-12 00:52:24.605664 | 
2026-09-12 00:52:24.605780 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-12 00:52:24.646415 | localhost | ok
2026-09-12 00:52:24.662549 | 
2026-09-12 00:52:24.662703 | TASK [emit-job-header : Print job information]
2026-09-12 00:52:24.716301 | # Job Information
2026-09-12 00:52:24.716570 | Ansible Version: 2.16.18
2026-09-12 00:52:24.716637 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9
2026-09-12 00:52:24.716697 | Pipeline: check
2026-09-12 00:52:24.716737 | Executor: 2d72f0692154
2026-09-12 00:52:24.716775 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/150
2026-09-12 00:52:24.716817 | Event ID: c02f8e60-ae43-11f1-9f8b-a3c8ebe95043
2026-09-12 00:52:24.725494 | 
2026-09-12 00:52:24.725631 | LOOP [emit-job-header : Print node information]
2026-09-12 00:52:24.837897 | localhost | ok:
2026-09-12 00:52:24.838228 | localhost | # Node Information
2026-09-12 00:52:24.838313 | localhost | Inventory Hostname: rockylinux-9
2026-09-12 00:52:24.838419 | localhost | Hostname: np0000192633
2026-09-12 00:52:24.838606 | localhost | Username: zuul
2026-09-12 00:52:24.838979 | localhost | Distro: Rocky 9.7
2026-09-12 00:52:24.839066 | localhost | Provider: yul1
2026-09-12 00:52:24.839173 | localhost | Region: ca-ymq-1
2026-09-12 00:52:24.839221 | localhost | Label: rockylinux-9
2026-09-12 00:52:24.839265 | localhost | Product Name: OpenStack Nova
2026-09-12 00:52:24.839308 | localhost | Interface IP: 162.253.55.127
2026-09-12 00:52:24.852924 | 
2026-09-12 00:52:24.853113 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-12 00:52:25.252258 | localhost -> localhost | changed
2026-09-12 00:52:25.258595 | 
2026-09-12 00:52:25.258692 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-12 00:52:26.125993 | localhost -> localhost | changed
2026-09-12 00:52:26.133799 | 
2026-09-12 00:52:26.133871 | PLAY [all]
2026-09-12 00:52:26.143005 | 
2026-09-12 00:52:26.143088 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-12 00:52:26.373693 | rockylinux-9 -> localhost | ok
2026-09-12 00:52:26.383967 | 
2026-09-12 00:52:26.384099 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-12 00:52:26.417659 | rockylinux-9 | ok
2026-09-12 00:52:26.441893 | rockylinux-9 | included: /var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-12 00:52:26.449599 | 
2026-09-12 00:52:26.449695 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-12 00:52:27.307352 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-09-12 00:52:27.307536 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/9d8fc045667f4218a64ca4eca025a75e_id_rsa
2026-09-12 00:52:27.307562 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/9d8fc045667f4218a64ca4eca025a75e_id_rsa.pub
2026-09-12 00:52:27.307582 | rockylinux-9 -> localhost | The key fingerprint is:
2026-09-12 00:52:27.307601 | rockylinux-9 -> localhost | SHA256:WLUW2opPfJ+iY9RQ0tZ6i/QGPZVCWFcQAt6Pfer7CDo zuul-build-sshkey
2026-09-12 00:52:27.307634 | rockylinux-9 -> localhost | The key's randomart image is:
2026-09-12 00:52:27.307652 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-09-12 00:52:27.307691 | rockylinux-9 -> localhost | |         .+*+ +=.|
2026-09-12 00:52:27.307711 | rockylinux-9 -> localhost | |        .==+ooo  |
2026-09-12 00:52:27.307728 | rockylinux-9 -> localhost | |        o+=o.o   |
2026-09-12 00:52:27.307745 | rockylinux-9 -> localhost | |       =.o+ ++   |
2026-09-12 00:52:27.307762 | rockylinux-9 -> localhost | |      o S+.=.oo .|
2026-09-12 00:52:27.307778 | rockylinux-9 -> localhost | |       o..o.+. o |
2026-09-12 00:52:27.307795 | rockylinux-9 -> localhost | |       .. ..+ .  |
2026-09-12 00:52:27.307811 | rockylinux-9 -> localhost | |        o.Eo o . |
2026-09-12 00:52:27.307830 | rockylinux-9 -> localhost | |       .....  +o.|
2026-09-12 00:52:27.307848 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-09-12 00:52:27.307891 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.426934
2026-09-12 00:52:27.312127 | 
2026-09-12 00:52:27.312187 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-12 00:52:27.339520 | rockylinux-9 | ok
2026-09-12 00:52:27.346880 | rockylinux-9 | included: /var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-12 00:52:27.353120 | 
2026-09-12 00:52:27.353183 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-12 00:52:27.376684 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:27.382651 | 
2026-09-12 00:52:27.382741 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-12 00:52:27.903632 | rockylinux-9 | changed
2026-09-12 00:52:27.913684 | 
2026-09-12 00:52:27.913836 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-12 00:52:28.190012 | rockylinux-9 | ok
2026-09-12 00:52:28.196291 | 
2026-09-12 00:52:28.196374 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-12 00:52:29.206833 | rockylinux-9 | changed
2026-09-12 00:52:29.215811 | 
2026-09-12 00:52:29.215995 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-12 00:52:30.174512 | rockylinux-9 | changed
2026-09-12 00:52:30.183259 | 
2026-09-12 00:52:30.183421 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-12 00:52:30.208118 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:30.219329 | 
2026-09-12 00:52:30.219497 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-12 00:52:30.655400 | rockylinux-9 -> localhost | changed
2026-09-12 00:52:30.678942 | 
2026-09-12 00:52:30.679078 | TASK [add-build-sshkey : Add back temp key]
2026-09-12 00:52:30.957618 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/9d8fc045667f4218a64ca4eca025a75e_id_rsa (zuul-build-sshkey)
2026-09-12 00:52:30.957972 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.015369
2026-09-12 00:52:30.970653 | 
2026-09-12 00:52:30.971414 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-12 00:52:31.386732 | rockylinux-9 | ok
2026-09-12 00:52:31.394771 | 
2026-09-12 00:52:31.394901 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-12 00:52:31.430616 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:31.484999 | 
2026-09-12 00:52:31.485125 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-12 00:52:31.919794 | rockylinux-9 | ok
2026-09-12 00:52:31.926202 | 
2026-09-12 00:52:31.926283 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-12 00:52:32.883472 | rockylinux-9 | Output suppressed because no_log was given
2026-09-12 00:52:32.906806 | 
2026-09-12 00:52:32.907029 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-12 00:52:33.194269 | rockylinux-9 | ok: "logs"
2026-09-12 00:52:33.194582 | rockylinux-9 | ok: All items complete
2026-09-12 00:52:33.194609 | 
2026-09-12 00:52:33.427252 | rockylinux-9 | ok: "artifacts"
2026-09-12 00:52:33.680016 | rockylinux-9 | ok: "docs"
2026-09-12 00:52:33.688732 | 
2026-09-12 00:52:33.688896 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-12 00:52:33.981827 | rockylinux-9 | changed: "logs"
2026-09-12 00:52:34.204275 | rockylinux-9 | changed: "artifacts"
2026-09-12 00:52:34.476203 | rockylinux-9 | changed: "docs"
2026-09-12 00:52:34.497353 | 
2026-09-12 00:52:34.497529 | PLAY RECAP
2026-09-12 00:52:34.497609 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-12 00:52:34.497692 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-12 00:52:34.497734 | 
2026-09-12 00:52:34.679983 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-12 00:52:34.682067 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-12 00:52:35.239629 | 
2026-09-12 00:52:35.239776 | PLAY [all]
2026-09-12 00:52:35.250164 | 
2026-09-12 00:52:35.250238 | TASK [setup-uv : Extract archive]
2026-09-12 00:52:38.235222 | rockylinux-9 | changed
2026-09-12 00:52:38.240265 | 
2026-09-12 00:52:38.240340 | TASK [setup-uv : Print version]
2026-09-12 00:52:38.259961 | [rockylinux-9] Waiting on logger
2026-09-12 00:52:38.776892 | rockylinux-9 | ok: Runtime: 0:00:00.019069
2026-09-12 00:52:38.786980 | 
2026-09-12 00:52:38.787070 | TASK [Install Ansible collection siblings]
2026-09-12 00:52:39.239740 | rockylinux-9 | ok:
2026-09-12 00:52:39.240005 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling
2026-09-12 00:52:39.240065 | rockylinux-9 | Skipping community.general: no checked-out sibling
2026-09-12 00:52:39.244263 | 
2026-09-12 00:52:39.244362 | PLAY RECAP
2026-09-12 00:52:39.244453 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-12 00:52:39.244609 | 
2026-09-12 00:52:39.375450 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-12 00:52:39.377547 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-12 00:52:39.924478 | 
2026-09-12 00:52:39.924766 | PLAY [all]
2026-09-12 00:52:39.935121 | 
2026-09-12 00:52:39.935200 | LOOP [Check inventory directories]
2026-09-12 00:52:40.334443 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers"
2026-09-12 00:52:40.552813 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/containerd/inventory"
2026-09-12 00:52:40.791431 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/containerd/inventory"
2026-09-12 00:52:40.809843 | 
2026-09-12 00:52:40.810098 | LOOP [Copy inventory file for Zuul]
2026-09-12 00:52:42.163581 | rockylinux-9 | changed:
2026-09-12 00:52:42.163917 | rockylinux-9 | {
2026-09-12 00:52:42.163976 | rockylinux-9 |   "ansible_loop_var": "item",
2026-09-12 00:52:42.164032 | rockylinux-9 |   "changed": false,
2026-09-12 00:52:42.164091 | rockylinux-9 |   "failed": false,
2026-09-12 00:52:42.164141 | rockylinux-9 |   "invocation": {
2026-09-12 00:52:42.164179 | rockylinux-9 |     "module_args": {
2026-09-12 00:52:42.164215 | rockylinux-9 |       "checksum_algorithm": "sha1",
2026-09-12 00:52:42.164250 | rockylinux-9 |       "follow": true,
2026-09-12 00:52:42.164284 | rockylinux-9 |       "get_attributes": true,
2026-09-12 00:52:42.164321 | rockylinux-9 |       "get_checksum": true,
2026-09-12 00:52:42.164354 | rockylinux-9 |       "get_mime": true,
2026-09-12 00:52:42.164388 | rockylinux-9 |       "path": "src/github.com/vexxhost/ansible-collection-containers"
2026-09-12 00:52:42.164422 | rockylinux-9 |     }
2026-09-12 00:52:42.164457 | rockylinux-9 |   },
2026-09-12 00:52:42.164521 | rockylinux-9 |   "item": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-12 00:52:42.164583 | rockylinux-9 |   "stat": {
2026-09-12 00:52:42.164619 | rockylinux-9 |     "atime": 1789174352.992,
2026-09-12 00:52:42.164679 | rockylinux-9 |     "attr_flags": "e",
2026-09-12 00:52:42.164714 | rockylinux-9 |     "attributes": [
2026-09-12 00:52:42.164749 | rockylinux-9 |       "extents"
2026-09-12 00:52:42.164782 | rockylinux-9 |     ],
2026-09-12 00:52:42.164815 | rockylinux-9 |     "block_size": 4096,
2026-09-12 00:52:42.164848 | rockylinux-9 |     "blocks": 8,
2026-09-12 00:52:42.164882 | rockylinux-9 |     "charset": "binary",
2026-09-12 00:52:42.164919 | rockylinux-9 |     "ctime": 1789174353.017,
2026-09-12 00:52:42.164953 | rockylinux-9 |     "dev": 64513,
2026-09-12 00:52:42.164987 | rockylinux-9 |     "device_type": 0,
2026-09-12 00:52:42.165021 | rockylinux-9 |     "executable": true,
2026-09-12 00:52:42.165054 | rockylinux-9 |     "exists": true,
2026-09-12 00:52:42.165088 | rockylinux-9 |     "gid": 1000,
2026-09-12 00:52:42.165121 | rockylinux-9 |     "gr_name": "zuul",
2026-09-12 00:52:42.165154 | rockylinux-9 |     "inode": 525401,
2026-09-12 00:52:42.165187 | rockylinux-9 |     "isblk": false,
2026-09-12 00:52:42.165221 | rockylinux-9 |     "ischr": false,
2026-09-12 00:52:42.165254 | rockylinux-9 |     "isdir": true,
2026-09-12 00:52:42.165286 | rockylinux-9 |     "isfifo": false,
2026-09-12 00:52:42.165319 | rockylinux-9 |     "isgid": false,
2026-09-12 00:52:42.165350 | rockylinux-9 |     "islnk": false,
2026-09-12 00:52:42.165382 | rockylinux-9 |     "isreg": false,
2026-09-12 00:52:42.165414 | rockylinux-9 |     "issock": false,
2026-09-12 00:52:42.165445 | rockylinux-9 |     "isuid": false,
2026-09-12 00:52:42.165477 | rockylinux-9 |     "mimetype": "inode/directory",
2026-09-12 00:52:42.165509 | rockylinux-9 |     "mode": "0755",
2026-09-12 00:52:42.165541 | rockylinux-9 |     "mtime": 1789174337.1645153,
2026-09-12 00:52:42.165573 | rockylinux-9 |     "nlink": 11,
2026-09-12 00:52:42.165606 | rockylinux-9 |     "path": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-12 00:52:42.165659 | rockylinux-9 |     "pw_name": "zuul",
2026-09-12 00:52:42.165700 | rockylinux-9 |     "readable": true,
2026-09-12 00:52:42.165734 | rockylinux-9 |     "rgrp": true,
2026-09-12 00:52:42.165766 | rockylinux-9 |     "roth": true,
2026-09-12 00:52:42.165799 | rockylinux-9 |     "rusr": true,
2026-09-12 00:52:42.165831 | rockylinux-9 |     "size": 4096,
2026-09-12 00:52:42.165863 | rockylinux-9 |     "uid": 1000,
2026-09-12 00:52:42.165896 | rockylinux-9 |     "version": "968274523",
2026-09-12 00:52:42.165930 | rockylinux-9 |     "wgrp": false,
2026-09-12 00:52:42.165966 | rockylinux-9 |     "woth": false,
2026-09-12 00:52:42.166000 | rockylinux-9 |     "writeable": true,
2026-09-12 00:52:42.166034 | rockylinux-9 |     "wusr": true,
2026-09-12 00:52:42.166067 | rockylinux-9 |     "xgrp": true,
2026-09-12 00:52:42.166099 | rockylinux-9 |     "xoth": true,
2026-09-12 00:52:42.166131 | rockylinux-9 |     "xusr": true
2026-09-12 00:52:42.166164 | rockylinux-9 |   }
2026-09-12 00:52:42.166198 | rockylinux-9 | }
2026-09-12 00:52:42.166266 | rockylinux-9 | ok: All items complete
2026-09-12 00:52:42.166306 | 
2026-09-12 00:52:42.168931 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:42.170104 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:42.192624 | 
2026-09-12 00:52:42.192826 | LOOP [Switch "ansible_host" to private IP]
2026-09-12 00:52:42.644135 | rockylinux-9 | changed: 1 replacements made
2026-09-12 00:52:42.646490 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:42.651100 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 00:52:42.670254 | 
2026-09-12 00:52:42.670439 | TASK [Run Molecule scenario]
2026-09-12 00:52:42.710214 | [rockylinux-9] Waiting on logger
2026-09-12 00:52:49.829549 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:00.005928 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:10.181648 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:19.339131 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:29.509861 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:39.689338 | [rockylinux-9] Waiting on logger
2026-09-12 00:53:49.861715 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:00.037744 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:10.213740 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:19.372673 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:29.545621 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:39.717655 | [rockylinux-9] Waiting on logger
2026-09-12 00:54:49.893702 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:00.069666 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:10.245679 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:19.401398 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:29.574675 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:39.749388 | [rockylinux-9] Waiting on logger
2026-09-12 00:55:49.925383 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:00.101566 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:10.277688 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:19.433570 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:29.605467 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:39.781686 | [rockylinux-9] Waiting on logger
2026-09-12 00:56:49.957674 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:00.133520 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:09.294960 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:19.465501 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:29.637496 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:39.818446 | [rockylinux-9] Waiting on logger
2026-09-12 00:57:49.989873 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:00.165562 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:09.322935 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:19.493521 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:29.669649 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:39.845626 | [rockylinux-9] Waiting on logger
2026-09-12 00:58:50.021717 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:00.201512 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:09.355026 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:19.525625 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:29.701667 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:39.877476 | [rockylinux-9] Waiting on logger
2026-09-12 00:59:50.053651 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:00.229589 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:09.381641 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:19.557656 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:29.733504 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:39.909634 | [rockylinux-9] Waiting on logger
2026-09-12 01:00:50.085940 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:00.261585 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:09.413736 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:19.589630 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:29.765676 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:39.941927 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:50.117595 | [rockylinux-9] Waiting on logger
2026-09-12 01:01:59.275111 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:09.445783 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:19.621529 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:29.797591 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:39.973568 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:50.150271 | [rockylinux-9] Waiting on logger
2026-09-12 01:02:59.306859 | [rockylinux-9] Waiting on logger
2026-09-12 01:03:09.477746 | [rockylinux-9] Waiting on logger
2026-09-12 01:03:19.653684 | [rockylinux-9] Waiting on logger
2026-09-12 01:03:29.829625 | [rockylinux-9] Waiting on logger
2026-09-12 01:03:40.005623 | [rockylinux-9] Waiting on logger
2026-09-12 01:03:43.470735 | rockylinux-9 | ERROR
2026-09-12 01:03:43.471116 | rockylinux-9 | {
2026-09-12 01:03:43.471220 | rockylinux-9 |   "delta": "0:10:59.350232",
2026-09-12 01:03:43.471273 | rockylinux-9 |   "end": "2026-09-12 01:03:42.698546",
2026-09-12 01:03:43.471339 | rockylinux-9 |   "msg": "non-zero return code",
2026-09-12 01:03:43.471394 | rockylinux-9 |   "rc": 2,
2026-09-12 01:03:43.471440 | rockylinux-9 |   "start": "2026-09-12 00:52:43.348314"
2026-09-12 01:03:43.471496 | rockylinux-9 | }
failure
2026-09-12 01:03:43.486705 | 
2026-09-12 01:03:43.486813 | PLAY RECAP
2026-09-12 01:03:43.486898 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-12 01:03:43.486965 | 
2026-09-12 01:03:43.640873 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-12 01:03:43.643181 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-12 01:03:44.293867 | 
2026-09-12 01:03:44.294015 | PLAY [all]
2026-09-12 01:03:44.303793 | 
2026-09-12 01:03:44.303865 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-12 01:03:44.368085 | rockylinux-9 | skipping: Conditional result was False
2026-09-12 01:03:44.373596 | 
2026-09-12 01:03:44.373682 | TASK [fetch-output : Set log path for single node]
2026-09-12 01:03:44.406224 | rockylinux-9 | ok
2026-09-12 01:03:44.413625 | 
2026-09-12 01:03:44.413714 | LOOP [fetch-output : Ensure local output dirs]
2026-09-12 01:03:44.788902 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/logs"
2026-09-12 01:03:45.028136 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/artifacts"
2026-09-12 01:03:45.238619 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/9d8fc045667f4218a64ca4eca025a75e/work/docs"
2026-09-12 01:03:45.262216 | 
2026-09-12 01:03:45.262403 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-12 01:03:46.064634 | rockylinux-9 | ok
2026-09-12 01:03:46.064950 | rockylinux-9 | changed: All items complete
2026-09-12 01:03:46.065007 | 
2026-09-12 01:03:46.606712 | rockylinux-9 | changed: .d..t...... ./
2026-09-12 01:03:47.181278 | rockylinux-9 | changed: .d..t...... ./
2026-09-12 01:03:47.209360 | 
2026-09-12 01:03:47.209581 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-12 01:03:47.584608 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.005861
2026-09-12 01:03:47.831843 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007376
2026-09-12 01:03:47.852526 | 
2026-09-12 01:03:47.852686 | PLAY [all]
2026-09-12 01:03:47.863139 | 
2026-09-12 01:03:47.863262 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-12 01:03:48.332951 | rockylinux-9 | changed
2026-09-12 01:03:48.342550 | 
2026-09-12 01:03:48.342641 | PLAY RECAP
2026-09-12 01:03:48.342723 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-12 01:03:48.342764 | 
2026-09-12 01:03:48.465982 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-12 01:03:48.467224 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-12 01:03:48.961323 | 
2026-09-12 01:03:48.961565 | PLAY [localhost]
2026-09-12 01:03:48.971117 | 
2026-09-12 01:03:48.971183 | TASK [Generate Zuul manifest]
2026-09-12 01:03:48.986980 | localhost | ok
2026-09-12 01:03:49.001411 | 
2026-09-12 01:03:49.001481 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-12 01:03:49.420477 | localhost | changed
2026-09-12 01:03:49.430291 | 
2026-09-12 01:03:49.430357 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-12 01:03:49.459609 | localhost | ok
2026-09-12 01:03:49.468142 | 
2026-09-12 01:03:49.468222 | TASK [Upload logs]
2026-09-12 01:03:49.485873 | localhost | ok
2026-09-12 01:03:49.540774 | 
2026-09-12 01:03:49.540876 | TASK [Set zuul-log-path fact]
2026-09-12 01:03:49.557715 | localhost | ok
2026-09-12 01:03:49.567560 | 
2026-09-12 01:03:49.567622 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-12 01:03:49.605286 | localhost | ok
2026-09-12 01:03:49.613432 | 
2026-09-12 01:03:49.613511 | TASK [upload-logs : Create log directories]
2026-09-12 01:03:50.018399 | localhost | changed
2026-09-12 01:03:50.029254 | 
2026-09-12 01:03:50.029384 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-12 01:03:50.443399 | localhost -> localhost | ok: Runtime: 0:00:00.004477
2026-09-12 01:03:50.449601 | 
2026-09-12 01:03:50.449682 | TASK [upload-logs : Upload logs to log server]
2026-09-12 01:03:50.917577 | localhost | Output suppressed because no_log was given
2026-09-12 01:03:50.926668 | 
2026-09-12 01:03:50.926844 | LOOP [upload-logs : Compress console log and json output]
2026-09-12 01:03:50.992620 | localhost | skipping: Conditional result was False
2026-09-12 01:03:51.002351 | localhost | skipping: Conditional result was False
2026-09-12 01:03:51.009441 | 
2026-09-12 01:03:51.009590 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-12 01:03:51.067054 | localhost | skipping: Conditional result was False
2026-09-12 01:03:51.067484 | 
2026-09-12 01:03:51.073471 | localhost | skipping: Conditional result was False
2026-09-12 01:03:51.088085 | 
2026-09-12 01:03:51.088179 | LOOP [upload-logs : Upload console log and json output]