2026-08-12 00:17:21.348869 | Job console starting
2026-08-12 00:17:21.358971 | Updating git repos
2026-08-12 00:17:21.388270 | Cloning repos into workspace
2026-08-12 00:17:22.448181 | Restoring repo states
2026-08-12 00:17:22.457957 | Merging changes
2026-08-12 00:17:23.141749 | Checking out repos
2026-08-12 00:17:23.236913 | Preparing playbooks
2026-08-12 00:17:25.201190 | Running Ansible setup
2026-08-12 00:17:29.178602 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 00:17:29.882860 | 
2026-08-12 00:17:29.883244 | PLAY [localhost]
2026-08-12 00:17:29.896193 | 
2026-08-12 00:17:29.896364 | TASK [Gathering Facts]
2026-08-12 00:17:30.808133 | localhost | ok
2026-08-12 00:17:30.819598 | 
2026-08-12 00:17:30.819687 | TASK [Setup log path fact]
2026-08-12 00:17:30.852405 | localhost | ok
2026-08-12 00:17:30.871121 | 
2026-08-12 00:17:30.871235 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 00:17:30.903275 | localhost | ok
2026-08-12 00:17:30.911153 | 
2026-08-12 00:17:30.911269 | TASK [emit-job-header : Print job information]
2026-08-12 00:17:30.955250 | # Job Information
2026-08-12 00:17:30.955443 | Ansible Version: 2.16.18
2026-08-12 00:17:30.955519 | Job: ansible-collection-ceph-molecule-aio-ubuntu-jammy
2026-08-12 00:17:30.955558 | Pipeline: check
2026-08-12 00:17:30.955596 | Executor: 2d72f0692154
2026-08-12 00:17:30.955633 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/117
2026-08-12 00:17:30.955671 | Event ID: 25c0f960-95e1-11f1-9f68-6f39b35a0a6e
2026-08-12 00:17:30.960522 | 
2026-08-12 00:17:30.960615 | LOOP [emit-job-header : Print node information]
2026-08-12 00:17:31.072224 | localhost | ok:
2026-08-12 00:17:31.072501 | localhost | # Node Information
2026-08-12 00:17:31.072544 | localhost | Inventory Hostname: aio
2026-08-12 00:17:31.072578 | localhost | Hostname: np0000188731
2026-08-12 00:17:31.072609 | localhost | Username: zuul
2026-08-12 00:17:31.072647 | localhost | Distro: Ubuntu 22.04
2026-08-12 00:17:31.072677 | localhost | Provider: yul1
2026-08-12 00:17:31.072707 | localhost | Region: ca-ymq-1
2026-08-12 00:17:31.072737 | localhost | Label: ubuntu-jammy
2026-08-12 00:17:31.072767 | localhost | Product Name: OpenStack Nova
2026-08-12 00:17:31.072796 | localhost | Interface IP: 199.204.45.238
2026-08-12 00:17:31.090422 | 
2026-08-12 00:17:31.090650 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-12 00:17:31.529413 | localhost -> localhost | changed
2026-08-12 00:17:31.534810 | 
2026-08-12 00:17:31.534885 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-12 00:17:32.491362 | localhost -> localhost | changed
2026-08-12 00:17:32.500902 | 
2026-08-12 00:17:32.500986 | PLAY [all]
2026-08-12 00:17:32.508746 | 
2026-08-12 00:17:32.508815 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-12 00:17:32.812904 | aio -> localhost | ok
2026-08-12 00:17:32.824024 | 
2026-08-12 00:17:32.824109 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-12 00:17:32.854231 | aio | ok
2026-08-12 00:17:32.872774 | aio | included: /var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-12 00:17:32.878790 | 
2026-08-12 00:17:32.878856 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-12 00:17:33.620772 | aio -> localhost | Generating public/private rsa key pair.
2026-08-12 00:17:33.621079 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/2d75448b04624b0083c0ae1a49b1dc5a_id_rsa
2026-08-12 00:17:33.621125 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/2d75448b04624b0083c0ae1a49b1dc5a_id_rsa.pub
2026-08-12 00:17:33.621159 | aio -> localhost | The key fingerprint is:
2026-08-12 00:17:33.621192 | aio -> localhost | SHA256:eBORNaIyXu9ZohP5/JGV8WZPE9JsyF0TEVm06nbi4LA zuul-build-sshkey
2026-08-12 00:17:33.621267 | aio -> localhost | The key's randomart image is:
2026-08-12 00:17:33.621311 | aio -> localhost | +---[RSA 3072]----+
2026-08-12 00:17:33.621352 | aio -> localhost | |        ooo    *X|
2026-08-12 00:17:33.621385 | aio -> localhost | |       ..o .. =.+|
2026-08-12 00:17:33.621415 | aio -> localhost | |    o o .   .+ B |
2026-08-12 00:17:33.621444 | aio -> localhost | |   . + + .   ++ .|
2026-08-12 00:17:33.621472 | aio -> localhost | |    . + S . o.+..|
2026-08-12 00:17:33.621500 | aio -> localhost | |       B = o.o o.|
2026-08-12 00:17:33.621527 | aio -> localhost | |      o =.o. + ..|
2026-08-12 00:17:33.621556 | aio -> localhost | |       . .+.+ o  |
2026-08-12 00:17:33.621588 | aio -> localhost | |         E.. .   |
2026-08-12 00:17:33.621616 | aio -> localhost | +----[SHA256]-----+
2026-08-12 00:17:33.621711 | aio -> localhost | ok: Runtime: 0:00:00.273628
2026-08-12 00:17:33.636311 | 
2026-08-12 00:17:33.636476 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-12 00:17:33.673851 | aio | ok
2026-08-12 00:17:33.684213 | aio | included: /var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-12 00:17:33.692268 | 
2026-08-12 00:17:33.692334 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-12 00:17:33.717476 | aio | skipping: Conditional result was False
2026-08-12 00:17:33.726569 | 
2026-08-12 00:17:33.726659 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-12 00:17:34.157707 | aio | changed
2026-08-12 00:17:34.162734 | 
2026-08-12 00:17:34.162799 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-12 00:17:34.342958 | aio | ok
2026-08-12 00:17:34.349652 | 
2026-08-12 00:17:34.349721 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-12 00:17:34.823460 | aio | changed
2026-08-12 00:17:35.516318 | 
2026-08-12 00:17:35.516540 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-12 00:17:35.990082 | aio | changed
2026-08-12 00:17:35.995308 | 
2026-08-12 00:17:35.995376 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-12 00:17:36.023599 | aio | skipping: Conditional result was False
2026-08-12 00:17:36.030376 | 
2026-08-12 00:17:36.030498 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-12 00:17:36.441764 | aio -> localhost | changed
2026-08-12 00:17:36.455806 | 
2026-08-12 00:17:36.455881 | TASK [add-build-sshkey : Add back temp key]
2026-08-12 00:17:36.772642 | aio -> localhost | Identity added: /var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/2d75448b04624b0083c0ae1a49b1dc5a_id_rsa (zuul-build-sshkey)
2026-08-12 00:17:36.772851 | aio -> localhost | ok: Runtime: 0:00:00.016292
2026-08-12 00:17:36.777972 | 
2026-08-12 00:17:36.778032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-12 00:17:37.102275 | aio | ok
2026-08-12 00:17:37.284330 | 
2026-08-12 00:17:37.284434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-12 00:17:37.322339 | aio | skipping: Conditional result was False
2026-08-12 00:17:37.339349 | 
2026-08-12 00:17:37.339429 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-12 00:17:37.725764 | aio | ok
2026-08-12 00:17:37.738860 | 
2026-08-12 00:17:37.738945 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-12 00:17:38.465638 | aio | Output suppressed because no_log was given
2026-08-12 00:17:38.480768 | 
2026-08-12 00:17:38.480854 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-12 00:17:38.704381 | aio | ok: "logs"
2026-08-12 00:17:38.704569 | aio | ok: All items complete
2026-08-12 00:17:38.704596 | 
2026-08-12 00:17:38.811543 | aio | ok: "artifacts"
2026-08-12 00:17:39.007607 | aio | ok: "docs"
2026-08-12 00:17:39.019291 | 
2026-08-12 00:17:39.019361 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-12 00:17:39.211954 | aio | changed: "logs"
2026-08-12 00:17:39.363914 | aio | changed: "artifacts"
2026-08-12 00:17:39.518027 | aio | changed: "docs"
2026-08-12 00:17:39.527892 | 
2026-08-12 00:17:39.527988 | PLAY RECAP
2026-08-12 00:17:39.528038 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-12 00:17:39.528067 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 00:17:39.528090 | 
2026-08-12 00:17:39.686332 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-12 00:17:39.690049 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-12 00:17:40.327524 | 
2026-08-12 00:17:40.327662 | PLAY [all]
2026-08-12 00:17:40.338363 | 
2026-08-12 00:17:40.338453 | TASK [setup-uv : Extract archive]
2026-08-12 00:17:42.609201 | aio | changed
2026-08-12 00:17:42.618727 | 
2026-08-12 00:17:42.618884 | TASK [setup-uv : Print version]
2026-08-12 00:17:42.977191 | aio | uv 0.8.13
2026-08-12 00:17:43.160378 | aio | ok: Runtime: 0:00:00.013663
2026-08-12 00:17:43.169978 | 
2026-08-12 00:17:43.170052 | TASK [Install Ansible collection siblings]
2026-08-12 00:17:43.549681 | aio | ok:
2026-08-12 00:17:43.549904 | aio | Skipping community.general: no checked-out sibling
2026-08-12 00:17:43.549946 | aio | Skipping ansible.utils: no checked-out sibling
2026-08-12 00:17:43.549979 | aio | Skipping vexxhost.containers: no checked-out sibling
2026-08-12 00:17:43.552214 | 
2026-08-12 00:17:43.552274 | PLAY RECAP
2026-08-12 00:17:43.552336 | aio | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-12 00:17:43.552368 | 
2026-08-12 00:17:43.687407 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-12 00:17:43.689855 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-12 00:17:44.306830 | 
2026-08-12 00:17:44.307045 | PLAY [all]
2026-08-12 00:17:44.320078 | 
2026-08-12 00:17:44.320234 | LOOP [Check inventory directories]
2026-08-12 00:17:44.677336 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-12 00:17:44.824995 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-12 00:17:44.985714 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-12 00:17:44.999324 | 
2026-08-12 00:17:44.999563 | LOOP [Copy inventory file for Zuul]
2026-08-12 00:17:45.792668 | aio | changed:
2026-08-12 00:17:45.792893 | aio | {
2026-08-12 00:17:45.792936 | aio |   "ansible_loop_var": "item",
2026-08-12 00:17:45.793027 | aio |   "changed": false,
2026-08-12 00:17:45.793086 | aio |   "failed": false,
2026-08-12 00:17:45.793130 | aio |   "invocation": {
2026-08-12 00:17:45.793160 | aio |     "module_args": {
2026-08-12 00:17:45.793187 | aio |       "checksum_algorithm": "sha1",
2026-08-12 00:17:45.793213 | aio |       "follow": true,
2026-08-12 00:17:45.793239 | aio |       "get_attributes": true,
2026-08-12 00:17:45.793267 | aio |       "get_checksum": true,
2026-08-12 00:17:45.793293 | aio |       "get_mime": true,
2026-08-12 00:17:45.793318 | aio |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-12 00:17:45.793343 | aio |     }
2026-08-12 00:17:45.793369 | aio |   },
2026-08-12 00:17:45.793394 | aio |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-12 00:17:45.793418 | aio |   "stat": {
2026-08-12 00:17:45.793442 | aio |     "atime": 1786493858.3428895,
2026-08-12 00:17:45.793468 | aio |     "attr_flags": "e",
2026-08-12 00:17:45.793492 | aio |     "attributes": [
2026-08-12 00:17:45.793517 | aio |       "extents"
2026-08-12 00:17:45.793552 | aio |     ],
2026-08-12 00:17:45.793586 | aio |     "block_size": 4096,
2026-08-12 00:17:45.793617 | aio |     "blocks": 8,
2026-08-12 00:17:45.793642 | aio |     "charset": "unknown",
2026-08-12 00:17:45.793669 | aio |     "ctime": 1786493858.3468895,
2026-08-12 00:17:45.793701 | aio |     "dev": 64513,
2026-08-12 00:17:45.793823 | aio |     "device_type": 0,
2026-08-12 00:17:45.793867 | aio |     "executable": true,
2026-08-12 00:17:45.793895 | aio |     "exists": true,
2026-08-12 00:17:45.793921 | aio |     "gid": 1000,
2026-08-12 00:17:45.793946 | aio |     "gr_name": "zuul",
2026-08-12 00:17:45.793970 | aio |     "inode": 1042461,
2026-08-12 00:17:45.793993 | aio |     "isblk": false,
2026-08-12 00:17:45.794018 | aio |     "ischr": false,
2026-08-12 00:17:45.794042 | aio |     "isdir": true,
2026-08-12 00:17:45.794065 | aio |     "isfifo": false,
2026-08-12 00:17:45.794088 | aio |     "isgid": false,
2026-08-12 00:17:45.794112 | aio |     "islnk": false,
2026-08-12 00:17:45.794137 | aio |     "isreg": false,
2026-08-12 00:17:45.794160 | aio |     "issock": false,
2026-08-12 00:17:45.794184 | aio |     "isuid": false,
2026-08-12 00:17:45.794208 | aio |     "mimetype": "unknown",
2026-08-12 00:17:45.794232 | aio |     "mode": "0755",
2026-08-12 00:17:45.794257 | aio |     "mtime": 1786493842.8270888,
2026-08-12 00:17:45.794293 | aio |     "nlink": 10,
2026-08-12 00:17:45.794346 | aio |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-12 00:17:45.794377 | aio |     "pw_name": "zuul",
2026-08-12 00:17:45.794405 | aio |     "readable": true,
2026-08-12 00:17:45.794431 | aio |     "rgrp": true,
2026-08-12 00:17:45.794456 | aio |     "roth": true,
2026-08-12 00:17:45.794481 | aio |     "rusr": true,
2026-08-12 00:17:45.794505 | aio |     "size": 4096,
2026-08-12 00:17:45.794531 | aio |     "uid": 1000,
2026-08-12 00:17:45.794563 | aio |     "version": "1325689800",
2026-08-12 00:17:45.794593 | aio |     "wgrp": false,
2026-08-12 00:17:45.794621 | aio |     "woth": false,
2026-08-12 00:17:45.794645 | aio |     "writeable": true,
2026-08-12 00:17:45.794669 | aio |     "wusr": true,
2026-08-12 00:17:45.794693 | aio |     "xgrp": true,
2026-08-12 00:17:45.794717 | aio |     "xoth": true,
2026-08-12 00:17:45.794741 | aio |     "xusr": true
2026-08-12 00:17:45.794768 | aio |   }
2026-08-12 00:17:45.794795 | aio | }
2026-08-12 00:17:45.794849 | aio | ok: All items complete
2026-08-12 00:17:45.794880 | 
2026-08-12 00:17:45.796562 | aio | skipping: Conditional result was False
2026-08-12 00:17:45.797489 | aio | skipping: Conditional result was False
2026-08-12 00:17:45.816358 | 
2026-08-12 00:17:45.816537 | LOOP [Switch "ansible_host" to private IP]
2026-08-12 00:17:46.158501 | aio | changed: 1 replacements made
2026-08-12 00:17:46.160720 | aio | skipping: Conditional result was False
2026-08-12 00:17:46.162262 | aio | skipping: Conditional result was False
2026-08-12 00:17:46.176426 | 
2026-08-12 00:17:46.176564 | TASK [Run Molecule scenario]
2026-08-12 00:17:46.729461 | aio | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB)
2026-08-12 00:17:47.366519 | aio |  Downloading cpython-3.13.7-linux-x86_64-gnu (download)
2026-08-12 00:17:47.539191 | aio | Using CPython 3.13.7
2026-08-12 00:17:47.539253 | aio | Creating virtual environment at: .venv
2026-08-12 00:17:47.599352 | aio | Downloading ansible-core (2.3MiB)
2026-08-12 00:17:47.599518 | aio | Downloading netaddr (2.2MiB)
2026-08-12 00:17:47.605143 | aio | Downloading pygments (1.2MiB)
2026-08-12 00:17:47.605358 | aio | Downloading cryptography (4.3MiB)
2026-08-12 00:17:47.783364 | aio |  Downloading netaddr
2026-08-12 00:17:47.792383 | aio |  Downloading cryptography
2026-08-12 00:17:47.831354 | aio |  Downloading pygments
2026-08-12 00:17:47.953299 | aio |  Downloading ansible-core
2026-08-12 00:17:47.982816 | aio | Installed 36 packages in 29ms
2026-08-12 00:17:49.080129 | aio | INFO     Collection 'vexxhost.ceph' detected.
2026-08-12 00:17:49.080228 | aio | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-12 00:17:50.052673 | aio | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-12 00:17:50.052755 | aio | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-12 00:19:37.774557 | aio | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1
2026-08-12 00:19:37.774697 | aio | ERROR    Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1, returned 1 code:
2026-08-12 00:19:37.774731 | aio | Starting galaxy collection install process
2026-08-12 00:19:37.774746 | aio | Process install dependency map
2026-08-12 00:19:37.774760 | aio |
2026-08-12 00:19:37.774773 | aio | ansible-galaxy
2026-08-12 00:19:37.774786 | aio |   config file = None
2026-08-12 00:19:37.774799 | aio |   configured module search path =
2026-08-12 00:19:37.774812 | aio |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible
2026-08-12 00:19:37.774827 | aio |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages
2026-08-12 00:19:37.774840 | aio |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-12 00:19:37.774854 | aio |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03)  (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python)
2026-08-12 00:19:37.774867 | aio |   jinja version = 3.1.6
2026-08-12 00:19:37.774880 | aio |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-12 00:19:37.774892 | aio | No config file found; using defaults
2026-08-12 00:19:37.774906 | aio | Found installed collection community.library_inventory_filtering_v1:1.1.5 at '/home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1'
2026-08-12 00:19:37.774919 | aio | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-12 00:19:37.774933 | aio | Found installed collection ansible.utils:6.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-12 00:19:37.774945 | aio | Opened /home/zuul/.ansible/galaxy_token
2026-08-12 00:19:37.774959 | aio | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection ansible.posix: Missing expected 'results' in ansible-galaxy cache: {'expires': '2026-08-13T00:18:36Z', 'paginated': False}. This may indicate cache corruption (for example, from concurrent ansible-galaxy runs) or a bug in how the cache was generated. Try running with --clear-response-cache or --no-cache to work around the issue: 'results'
2026-08-12 00:19:37.774980 | aio | : Missing expected 'results' in ansible-galaxy cache: {'expires': '2026-08-13T00:18:36Z', 'paginated': False}. This may indicate cache corruption (for example, from concurrent ansible-galaxy runs) or a bug in how the cache was generated. Try running with --clear-response-cache or --no-cache to work around the issue: 'results'
2026-08-12 00:19:37.775016 | aio |
2026-08-12 00:19:37.777921 | aio | Traceback (most recent call last):
2026-08-12 00:19:37.781428 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in <module>
2026-08-12 00:19:37.781469 | aio |     sys.exit(main())
2026-08-12 00:19:37.781486 | aio |              ~~~~^^
2026-08-12 00:19:37.781815 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/core.py", line 1442, in __call__
2026-08-12 00:19:37.781846 | aio |     return self.main(*args, **kwargs)
2026-08-12 00:19:37.781860 | aio |            ~~~~~~~~~^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.782214 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/core.py", line 1363, in main
2026-08-12 00:19:37.782249 | aio |     rv = self.invoke(ctx)
2026-08-12 00:19:37.782648 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/core.py", line 1830, in invoke
2026-08-12 00:19:37.782680 | aio |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-12 00:19:37.782695 | aio |                            ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
2026-08-12 00:19:37.783018 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/core.py", line 1226, in invoke
2026-08-12 00:19:37.783055 | aio |     return ctx.invoke(self.callback, **ctx.params)
2026-08-12 00:19:37.783071 | aio |            ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.783223 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/core.py", line 794, in invoke
2026-08-12 00:19:37.783236 | aio |     return callback(*args, **kwargs)
2026-08-12 00:19:37.783369 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 613, in wrapper
2026-08-12 00:19:37.783383 | aio |     return func(*args, **kwargs)
2026-08-12 00:19:37.783518 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/click/decorators.py", line 34, in new_func
2026-08-12 00:19:37.783532 | aio |     return f(get_current_context(), *args, **kwargs)
2026-08-12 00:19:37.783667 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 468, in wrapper
2026-08-12 00:19:37.783680 | aio |     return func(ctx)
2026-08-12 00:19:37.783851 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/molecule/command/test.py", line 95, in test
2026-08-12 00:19:37.783865 | aio |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-12 00:19:37.783871 | aio |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784037 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 235, in execute_cmdline_scenarios
2026-08-12 00:19:37.784050 | aio |     _run_scenarios(scenarios, command_args, default_config)
2026-08-12 00:19:37.784057 | aio |     ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784312 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 314, in _run_scenarios
2026-08-12 00:19:37.784326 | aio |     scenario.config.runtime.prepare_environment(
2026-08-12 00:19:37.784332 | aio |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-12 00:19:37.784338 | aio |         install_local=True,
2026-08-12 00:19:37.784344 | aio |         ^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784351 | aio |         role_name_check=role_name_check,
2026-08-12 00:19:37.784357 | aio |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784363 | aio |     )
2026-08-12 00:19:37.784369 | aio |     ^
2026-08-12 00:19:37.784564 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 694, in prepare_environment
2026-08-12 00:19:37.784584 | aio |     self.install_collection(
2026-08-12 00:19:37.784591 | aio |     ~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-12 00:19:37.784597 | aio |         f"{name}{',' if is_url(name) else ':'}{required_version}",
2026-08-12 00:19:37.784604 | aio |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784610 | aio |         destination=destination,
2026-08-12 00:19:37.784616 | aio |         ^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-12 00:19:37.784623 | aio |     )
2026-08-12 00:19:37.784629 | aio |     ^
2026-08-12 00:19:37.784729 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 552, in install_collection
2026-08-12 00:19:37.784741 | aio |     raise InvalidPrerequisiteError(msg)
2026-08-12 00:19:37.785265 | aio | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1, returned 1 code:
2026-08-12 00:19:37.785279 | aio | Starting galaxy collection install process
2026-08-12 00:19:37.785285 | aio | Process install dependency map
2026-08-12 00:19:37.785291 | aio |
2026-08-12 00:19:37.785296 | aio | ansible-galaxy [core 2.21.3]
2026-08-12 00:19:37.785302 | aio |   config file = None
2026-08-12 00:19:37.785308 | aio |   configured module search path = ['/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/plugins/modules', '/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
2026-08-12 00:19:37.785314 | aio |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible
2026-08-12 00:19:37.785320 | aio |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages
2026-08-12 00:19:37.785326 | aio |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-12 00:19:37.785331 | aio |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03) [Clang 20.1.4 ] (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python)
2026-08-12 00:19:37.785337 | aio |   jinja version = 3.1.6
2026-08-12 00:19:37.785342 | aio |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-12 00:19:37.785348 | aio | No config file found; using defaults
2026-08-12 00:19:37.785353 | aio | Found installed collection community.library_inventory_filtering_v1:1.1.5 at '/home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1'
2026-08-12 00:19:37.785359 | aio | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-12 00:19:37.785364 | aio | Found installed collection ansible.utils:6.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-12 00:19:37.785370 | aio | Opened /home/zuul/.ansible/galaxy_token
2026-08-12 00:19:37.785376 | aio | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection ansible.posix: Missing expected 'results' in ansible-galaxy cache: {'expires': '2026-08-13T00:18:36Z', 'paginated': False}. This may indicate cache corruption (for example, from concurrent ansible-galaxy runs) or a bug in how the cache was generated. Try running with --clear-response-cache or --no-cache to work around the issue: 'results'
2026-08-12 00:19:37.785382 | aio | [ERROR]: Missing expected 'results' in ansible-galaxy cache: {'expires': '2026-08-13T00:18:36Z', 'paginated': False}. This may indicate cache corruption (for example, from concurrent ansible-galaxy runs) or a bug in how the cache was generated. Try running with --clear-response-cache or --no-cache to work around the issue: 'results'
2026-08-12 00:19:37.785388 | aio |
2026-08-12 00:19:37.898718 | aio | ERROR
2026-08-12 00:19:37.898960 | aio | {
2026-08-12 00:19:37.899003 | aio |   "delta": "0:01:51.330200",
2026-08-12 00:19:37.899033 | aio |   "end": "2026-08-12 00:19:37.857181",
2026-08-12 00:19:37.899061 | aio |   "msg": "non-zero return code",
2026-08-12 00:19:37.899087 | aio |   "rc": 1,
2026-08-12 00:19:37.899113 | aio |   "start": "2026-08-12 00:17:46.526981"
2026-08-12 00:19:37.899139 | aio | }
failure
2026-08-12 00:19:37.902100 | 
2026-08-12 00:19:37.902148 | PLAY RECAP
2026-08-12 00:19:37.902194 | aio | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-12 00:19:37.902215 | 
2026-08-12 00:19:38.034127 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-12 00:19:38.038853 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 00:19:38.660983 | 
2026-08-12 00:19:38.661116 | PLAY [all]
2026-08-12 00:19:38.672474 | 
2026-08-12 00:19:38.672554 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-12 00:19:38.717383 | aio | skipping: Conditional result was False
2026-08-12 00:19:38.725257 | 
2026-08-12 00:19:38.725360 | TASK [fetch-output : Set log path for single node]
2026-08-12 00:19:38.771514 | aio | ok
2026-08-12 00:19:38.776477 | 
2026-08-12 00:19:38.776589 | LOOP [fetch-output : Ensure local output dirs]
2026-08-12 00:19:39.186804 | aio -> localhost | ok: "/var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/logs"
2026-08-12 00:19:39.412300 | aio -> localhost | changed: "/var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/artifacts"
2026-08-12 00:19:39.656546 | aio -> localhost | changed: "/var/lib/zuul/builds/2d75448b04624b0083c0ae1a49b1dc5a/work/docs"
2026-08-12 00:19:39.675640 | 
2026-08-12 00:19:39.675802 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-12 00:19:40.344435 | aio | ok
2026-08-12 00:19:40.344684 | aio | changed: All items complete
2026-08-12 00:19:40.344720 | 
2026-08-12 00:19:40.784730 | aio | changed: .d..t...... ./
2026-08-12 00:19:41.243809 | aio | changed: .d..t...... ./
2026-08-12 00:19:41.267725 | 
2026-08-12 00:19:41.267927 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-12 00:19:41.780812 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.007656
2026-08-12 00:19:42.025301 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.007144
2026-08-12 00:19:42.036259 | 
2026-08-12 00:19:42.036389 | PLAY [all]
2026-08-12 00:19:42.045061 | 
2026-08-12 00:19:42.045159 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-12 00:19:42.483723 | aio | changed
2026-08-12 00:19:42.489106 | 
2026-08-12 00:19:42.489155 | PLAY RECAP
2026-08-12 00:19:42.489201 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-12 00:19:42.489223 | 
2026-08-12 00:19:42.606385 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-12 00:19:42.610026 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-12 00:19:43.236576 | 
2026-08-12 00:19:43.236724 | PLAY [localhost]
2026-08-12 00:19:43.247283 | 
2026-08-12 00:19:43.247365 | TASK [Generate Zuul manifest]
2026-08-12 00:19:43.279753 | localhost | ok
2026-08-12 00:19:43.297945 | 
2026-08-12 00:19:43.298210 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-12 00:19:43.675943 | localhost | changed
2026-08-12 00:19:43.690782 | 
2026-08-12 00:19:43.690855 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-12 00:19:43.732537 | localhost | ok
2026-08-12 00:19:43.742718 | 
2026-08-12 00:19:43.742802 | TASK [Upload logs]
2026-08-12 00:19:43.765255 | localhost | ok
2026-08-12 00:19:43.825959 | 
2026-08-12 00:19:43.826077 | TASK [Set zuul-log-path fact]
2026-08-12 00:19:43.848714 | localhost | ok
2026-08-12 00:19:43.865567 | 
2026-08-12 00:19:43.865640 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-12 00:19:43.894495 | localhost | ok
2026-08-12 00:19:43.904484 | 
2026-08-12 00:19:43.904570 | TASK [upload-logs : Create log directories]
2026-08-12 00:19:44.368104 | localhost | changed
2026-08-12 00:19:44.382545 | 
2026-08-12 00:19:44.382930 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-12 00:19:44.982998 | localhost -> localhost | ok: Runtime: 0:00:00.007043
2026-08-12 00:19:44.991051 | 
2026-08-12 00:19:44.991168 | TASK [upload-logs : Upload logs to log server]
2026-08-12 00:19:45.725899 | localhost | Output suppressed because no_log was given
2026-08-12 00:19:45.730746 | 
2026-08-12 00:19:45.730890 | LOOP [upload-logs : Compress console log and json output]
2026-08-12 00:19:45.781372 | localhost | skipping: Conditional result was False
2026-08-12 00:19:45.844040 | localhost | skipping: Conditional result was False
2026-08-12 00:19:45.864478 | 
2026-08-12 00:19:45.864688 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-12 00:19:45.917705 | localhost | skipping: Conditional result was False
2026-08-12 00:19:45.917941 | 
2026-08-12 00:19:45.918510 | localhost | skipping: Conditional result was False
2026-08-12 00:19:45.933791 | 
2026-08-12 00:19:45.933953 | LOOP [upload-logs : Upload console log and json output]