2026-08-26 20:50:50.098514 | Job console starting
2026-08-26 20:50:50.116362 | Updating git repos
2026-08-26 20:50:50.144094 | Cloning repos into workspace
2026-08-26 20:50:50.192306 | Restoring repo states
2026-08-26 20:50:50.199193 | Merging changes
2026-08-26 20:50:50.627847 | Checking out repos
2026-08-26 20:50:50.672100 | Preparing playbooks
2026-08-26 20:50:51.763519 | Running Ansible setup
2026-08-26 20:50:56.574451 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:50:57.268128 | 
2026-08-26 20:50:57.268277 | PLAY [localhost]
2026-08-26 20:50:57.276453 | 
2026-08-26 20:50:57.276526 | TASK [Gathering Facts]
2026-08-26 20:50:58.148086 | localhost | ok
2026-08-26 20:50:58.159643 | 
2026-08-26 20:50:58.159752 | TASK [Setup log path fact]
2026-08-26 20:50:58.181509 | localhost | ok
2026-08-26 20:50:58.192696 | 
2026-08-26 20:50:58.192763 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 20:50:58.224232 | localhost | ok
2026-08-26 20:50:58.232045 | 
2026-08-26 20:50:58.232113 | TASK [emit-job-header : Print job information]
2026-08-26 20:50:58.273368 | # Job Information
2026-08-26 20:50:58.273522 | Ansible Version: 2.16.18
2026-08-26 20:50:58.273567 | Job: ansible-collection-ceph-molecule-ha-ubuntu-jammy
2026-08-26 20:50:58.273597 | Pipeline: check
2026-08-26 20:50:58.273625 | Executor: 2d72f0692154
2026-08-26 20:50:58.273652 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/118
2026-08-26 20:50:58.273683 | Event ID: 6b24ae30-a18e-11f1-9c41-ecc345c57c50
2026-08-26 20:50:58.277392 | 
2026-08-26 20:50:58.277479 | LOOP [emit-job-header : Print node information]
2026-08-26 20:50:58.371343 | localhost | ok:
2026-08-26 20:50:58.372167 | localhost | # Node Information
2026-08-26 20:50:58.372212 | localhost | Inventory Hostname: mon1
2026-08-26 20:50:58.372244 | localhost | Hostname: np0000191299
2026-08-26 20:50:58.372274 | localhost | Username: zuul
2026-08-26 20:50:58.372306 | localhost | Distro: Ubuntu 22.04
2026-08-26 20:50:58.372334 | localhost | Provider: yul1
2026-08-26 20:50:58.372362 | localhost | Region: ca-ymq-1
2026-08-26 20:50:58.372389 | localhost | Label: ubuntu-jammy
2026-08-26 20:50:58.372417 | localhost | Product Name: OpenStack Nova
2026-08-26 20:50:58.372444 | localhost | Interface IP: 162.253.55.34
2026-08-26 20:50:58.414451 | localhost | ok:
2026-08-26 20:50:58.414606 | localhost | # Node Information
2026-08-26 20:50:58.414677 | localhost | Inventory Hostname: osd1
2026-08-26 20:50:58.414735 | localhost | Hostname: np0000191300
2026-08-26 20:50:58.414787 | localhost | Username: zuul
2026-08-26 20:50:58.414841 | localhost | Distro: Ubuntu 22.04
2026-08-26 20:50:58.414891 | localhost | Provider: yul1
2026-08-26 20:50:58.414941 | localhost | Region: ca-ymq-1
2026-08-26 20:50:58.414991 | localhost | Label: ubuntu-jammy
2026-08-26 20:50:58.415040 | localhost | Product Name: OpenStack Nova
2026-08-26 20:50:58.415091 | localhost | Interface IP: 162.253.55.186
2026-08-26 20:50:58.439188 | 
2026-08-26 20:50:58.439336 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-26 20:50:58.829974 | localhost -> localhost | changed
2026-08-26 20:50:58.839754 | 
2026-08-26 20:50:58.840048 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-26 20:50:59.878602 | localhost -> localhost | changed
2026-08-26 20:50:59.886738 | 
2026-08-26 20:50:59.886822 | PLAY [all]
2026-08-26 20:50:59.895935 | 
2026-08-26 20:50:59.896003 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-26 20:51:00.144108 | mon1 -> localhost | ok
2026-08-26 20:51:00.152417 | 
2026-08-26 20:51:00.152484 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-26 20:51:00.181674 | mon1 | ok
2026-08-26 20:51:00.200900 | osd1 | ok
2026-08-26 20:51:00.218274 | mon1 | included: /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:51:00.218329 | osd1 | included: /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:51:00.224030 | 
2026-08-26 20:51:00.224137 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-26 20:51:01.018959 | mon1 -> localhost | Generating public/private rsa key pair.
2026-08-26 20:51:01.019205 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/47c36f9f89c142508907a06a802ed01f_id_rsa
2026-08-26 20:51:01.019248 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/47c36f9f89c142508907a06a802ed01f_id_rsa.pub
2026-08-26 20:51:01.019569 | mon1 -> localhost | The key fingerprint is:
2026-08-26 20:51:01.019613 | mon1 -> localhost | SHA256:D/cxwXgPtew9KZ1XqYTx2kjtUsWoiI+objhlmbkywHI zuul-build-sshkey
2026-08-26 20:51:01.019644 | mon1 -> localhost | The key's randomart image is:
2026-08-26 20:51:01.019674 | mon1 -> localhost | +---[RSA 3072]----+
2026-08-26 20:51:01.019703 | mon1 -> localhost | |           .  +. |
2026-08-26 20:51:01.019732 | mon1 -> localhost | |           o=+.o.|
2026-08-26 20:51:01.019799 | mon1 -> localhost | |        . oo*=o..|
2026-08-26 20:51:01.019829 | mon1 -> localhost | |       . ..oB=o.+|
2026-08-26 20:51:01.019857 | mon1 -> localhost | |.   + . S .+o=o=o|
2026-08-26 20:51:01.019884 | mon1 -> localhost | |o.E* . . = ..o. o|
2026-08-26 20:51:01.019911 | mon1 -> localhost | |o.+ o     . .    |
2026-08-26 20:51:01.019938 | mon1 -> localhost | | = +             |
2026-08-26 20:51:01.019964 | mon1 -> localhost | |  *.             |
2026-08-26 20:51:01.019990 | mon1 -> localhost | +----[SHA256]-----+
2026-08-26 20:51:01.020059 | mon1 -> localhost | ok: Runtime: 0:00:00.379453
2026-08-26 20:51:01.025996 | 
2026-08-26 20:51:01.026067 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-26 20:51:01.064404 | mon1 | ok
2026-08-26 20:51:01.071259 | osd1 | ok
2026-08-26 20:51:01.083908 | mon1 | included: /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:51:01.083955 | osd1 | included: /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:51:01.106215 | 
2026-08-26 20:51:01.106381 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-26 20:51:01.133805 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:01.156948 | osd1 | skipping: Conditional result was False
2026-08-26 20:51:01.164802 | 
2026-08-26 20:51:01.164877 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-26 20:51:01.641356 | mon1 | changed
2026-08-26 20:51:01.662608 | osd1 | changed
2026-08-26 20:51:01.669880 | 
2026-08-26 20:51:01.670027 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-26 20:51:01.881244 | osd1 | ok
2026-08-26 20:51:01.888428 | mon1 | ok
2026-08-26 20:51:01.893434 | 
2026-08-26 20:51:01.893503 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-26 20:51:02.406938 | mon1 | changed
2026-08-26 20:51:02.413311 | osd1 | changed
2026-08-26 20:51:02.418792 | 
2026-08-26 20:51:02.418859 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-26 20:51:02.975193 | mon1 | changed
2026-08-26 20:51:02.979966 | osd1 | changed
2026-08-26 20:51:02.984570 | 
2026-08-26 20:51:02.984631 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-26 20:51:03.009575 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:03.020814 | osd1 | skipping: Conditional result was False
2026-08-26 20:51:03.030853 | 
2026-08-26 20:51:03.030946 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-26 20:51:03.390625 | mon1 -> localhost | changed
2026-08-26 20:51:03.407898 | 
2026-08-26 20:51:03.407973 | TASK [add-build-sshkey : Add back temp key]
2026-08-26 20:51:03.680316 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/47c36f9f89c142508907a06a802ed01f_id_rsa (zuul-build-sshkey)
2026-08-26 20:51:03.680511 | mon1 -> localhost | ok: Runtime: 0:00:00.014275
2026-08-26 20:51:03.685481 | 
2026-08-26 20:51:03.685543 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-26 20:51:04.685999 | osd1 | ok
2026-08-26 20:51:04.829203 | mon1 | ok
2026-08-26 20:51:04.833625 | 
2026-08-26 20:51:04.833696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-26 20:51:04.860106 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:04.871566 | osd1 | skipping: Conditional result was False
2026-08-26 20:51:04.891966 | 
2026-08-26 20:51:04.892037 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-26 20:51:05.194384 | mon1 | ok
2026-08-26 20:51:05.198605 | osd1 | ok
2026-08-26 20:51:05.203992 | 
2026-08-26 20:51:05.204054 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-26 20:51:05.944013 | osd1 | Output suppressed because no_log was given
2026-08-26 20:51:05.962170 | mon1 | Output suppressed because no_log was given
2026-08-26 20:51:05.981650 | 
2026-08-26 20:51:05.981763 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-26 20:51:06.188797 | osd1 | ok: "logs"
2026-08-26 20:51:06.189083 | osd1 | ok: All items complete
2026-08-26 20:51:06.189113 | 
2026-08-26 20:51:06.196398 | mon1 | ok: "logs"
2026-08-26 20:51:06.367174 | osd1 | ok: "artifacts"
2026-08-26 20:51:06.375225 | mon1 | ok: "artifacts"
2026-08-26 20:51:06.507480 | osd1 | ok: "docs"
2026-08-26 20:51:06.520640 | mon1 | ok: "docs"
2026-08-26 20:51:06.532457 | 
2026-08-26 20:51:06.532690 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-26 20:51:06.737987 | mon1 | changed: "logs"
2026-08-26 20:51:06.738331 | mon1 | ok: All items complete
2026-08-26 20:51:06.738367 | 
2026-08-26 20:51:06.756137 | osd1 | changed: "logs"
2026-08-26 20:51:06.899026 | mon1 | changed: "artifacts"
2026-08-26 20:51:06.938901 | osd1 | changed: "artifacts"
2026-08-26 20:51:07.068351 | mon1 | changed: "docs"
2026-08-26 20:51:07.093269 | osd1 | changed: "docs"
2026-08-26 20:51:07.122568 | 
2026-08-26 20:51:07.122701 | PLAY RECAP
2026-08-26 20:51:07.122755 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:51:07.122788 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:51:07.122818 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:51:07.122837 | 
2026-08-26 20:51:07.288553 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:51:07.291102 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:51:07.890603 | 
2026-08-26 20:51:07.890734 | PLAY [all]
2026-08-26 20:51:07.901505 | 
2026-08-26 20:51:07.901583 | TASK [setup-uv : Extract archive]
2026-08-26 20:51:13.411809 | osd1 | changed
2026-08-26 20:51:13.574602 | mon1 | changed
2026-08-26 20:51:13.582296 | 
2026-08-26 20:51:13.582377 | TASK [setup-uv : Print version]
2026-08-26 20:51:13.997367 | mon1 | uv 0.8.13
2026-08-26 20:51:14.012277 | osd1 | uv 0.8.13
2026-08-26 20:51:14.148156 | osd1 | ok: Runtime: 0:00:00.011894
2026-08-26 20:51:14.156512 | mon1 | ok: Runtime: 0:00:00.013423
2026-08-26 20:51:14.169167 | 
2026-08-26 20:51:14.169236 | TASK [Install Ansible collection siblings]
2026-08-26 20:51:14.550110 | mon1 | ok:
2026-08-26 20:51:14.550268 | mon1 | Skipping community.general: no checked-out sibling
2026-08-26 20:51:14.550295 | mon1 | Skipping ansible.utils: no checked-out sibling
2026-08-26 20:51:14.550316 | mon1 | Skipping vexxhost.containers: no checked-out sibling
2026-08-26 20:51:14.552102 | 
2026-08-26 20:51:14.552150 | PLAY RECAP
2026-08-26 20:51:14.552197 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:51:14.552240 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:51:14.552261 | 
2026-08-26 20:51:14.681110 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:51:14.688025 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 20:51:15.342212 | 
2026-08-26 20:51:15.342376 | PLAY [all]
2026-08-26 20:51:15.354368 | 
2026-08-26 20:51:15.354506 | LOOP [Check inventory directories]
2026-08-26 20:51:15.709034 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:51:15.875615 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-26 20:51:16.008795 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-26 20:51:16.030680 | 
2026-08-26 20:51:16.030969 | LOOP [Copy inventory file for Zuul]
2026-08-26 20:51:16.817963 | mon1 | changed:
2026-08-26 20:51:16.818229 | mon1 | {
2026-08-26 20:51:16.818269 | mon1 |   "ansible_loop_var": "item",
2026-08-26 20:51:16.818301 | mon1 |   "changed": false,
2026-08-26 20:51:16.818328 | mon1 |   "failed": false,
2026-08-26 20:51:16.818364 | mon1 |   "invocation": {
2026-08-26 20:51:16.818391 | mon1 |     "module_args": {
2026-08-26 20:51:16.818416 | mon1 |       "checksum_algorithm": "sha1",
2026-08-26 20:51:16.818440 | mon1 |       "follow": true,
2026-08-26 20:51:16.818464 | mon1 |       "get_attributes": true,
2026-08-26 20:51:16.818490 | mon1 |       "get_checksum": true,
2026-08-26 20:51:16.818515 | mon1 |       "get_mime": true,
2026-08-26 20:51:16.818539 | mon1 |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:51:16.818563 | mon1 |     }
2026-08-26 20:51:16.818587 | mon1 |   },
2026-08-26 20:51:16.818611 | mon1 |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:51:16.818634 | mon1 |   "stat": {
2026-08-26 20:51:16.818658 | mon1 |     "atime": 1787777465.8270516,
2026-08-26 20:51:16.818686 | mon1 |     "attr_flags": "e",
2026-08-26 20:51:16.818723 | mon1 |     "attributes": [
2026-08-26 20:51:16.818761 | mon1 |       "extents"
2026-08-26 20:51:16.818798 | mon1 |     ],
2026-08-26 20:51:16.818824 | mon1 |     "block_size": 4096,
2026-08-26 20:51:16.818848 | mon1 |     "blocks": 8,
2026-08-26 20:51:16.818872 | mon1 |     "charset": "unknown",
2026-08-26 20:51:16.818900 | mon1 |     "ctime": 1787777465.8470526,
2026-08-26 20:51:16.818925 | mon1 |     "dev": 64513,
2026-08-26 20:51:16.818949 | mon1 |     "device_type": 0,
2026-08-26 20:51:16.818972 | mon1 |     "executable": true,
2026-08-26 20:51:16.818995 | mon1 |     "exists": true,
2026-08-26 20:51:16.819019 | mon1 |     "gid": 1000,
2026-08-26 20:51:16.819041 | mon1 |     "gr_name": "zuul",
2026-08-26 20:51:16.819065 | mon1 |     "inode": 1042461,
2026-08-26 20:51:16.819088 | mon1 |     "isblk": false,
2026-08-26 20:51:16.819111 | mon1 |     "ischr": false,
2026-08-26 20:51:16.819135 | mon1 |     "isdir": true,
2026-08-26 20:51:16.819158 | mon1 |     "isfifo": false,
2026-08-26 20:51:16.819181 | mon1 |     "isgid": false,
2026-08-26 20:51:16.819204 | mon1 |     "islnk": false,
2026-08-26 20:51:16.819229 | mon1 |     "isreg": false,
2026-08-26 20:51:16.819252 | mon1 |     "issock": false,
2026-08-26 20:51:16.819274 | mon1 |     "isuid": false,
2026-08-26 20:51:16.819297 | mon1 |     "mimetype": "unknown",
2026-08-26 20:51:16.819321 | mon1 |     "mode": "0755",
2026-08-26 20:51:16.819344 | mon1 |     "mtime": 1787777450.2097027,
2026-08-26 20:51:16.819368 | mon1 |     "nlink": 10,
2026-08-26 20:51:16.819392 | mon1 |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:51:16.819416 | mon1 |     "pw_name": "zuul",
2026-08-26 20:51:16.819446 | mon1 |     "readable": true,
2026-08-26 20:51:16.819560 | mon1 |     "rgrp": true,
2026-08-26 20:51:16.819607 | mon1 |     "roth": true,
2026-08-26 20:51:16.819635 | mon1 |     "rusr": true,
2026-08-26 20:51:16.819660 | mon1 |     "size": 4096,
2026-08-26 20:51:16.819701 | mon1 |     "uid": 1000,
2026-08-26 20:51:16.819726 | mon1 |     "version": "4059657349",
2026-08-26 20:51:16.819751 | mon1 |     "wgrp": false,
2026-08-26 20:51:16.819778 | mon1 |     "woth": false,
2026-08-26 20:51:16.819803 | mon1 |     "writeable": true,
2026-08-26 20:51:16.819826 | mon1 |     "wusr": true,
2026-08-26 20:51:16.819849 | mon1 |     "xgrp": true,
2026-08-26 20:51:16.819871 | mon1 |     "xoth": true,
2026-08-26 20:51:16.819894 | mon1 |     "xusr": true
2026-08-26 20:51:16.819917 | mon1 |   }
2026-08-26 20:51:16.819941 | mon1 | }
2026-08-26 20:51:16.819990 | mon1 | ok: All items complete
2026-08-26 20:51:16.820020 | 
2026-08-26 20:51:16.821425 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:16.822024 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:16.851805 | 
2026-08-26 20:51:16.851966 | LOOP [Switch "ansible_host" to private IP]
2026-08-26 20:51:17.185235 | mon1 | changed: 2 replacements made
2026-08-26 20:51:17.186513 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:17.190765 | mon1 | skipping: Conditional result was False
2026-08-26 20:51:17.201930 | 
2026-08-26 20:51:17.204018 | TASK [Run Molecule scenario]
2026-08-26 20:51:17.876847 | mon1 | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB)
2026-08-26 20:51:18.693604 | mon1 |  Downloading cpython-3.13.7-linux-x86_64-gnu (download)
2026-08-26 20:51:18.890708 | mon1 | Using CPython 3.13.7
2026-08-26 20:51:18.890805 | mon1 | Creating virtual environment at: .venv
2026-08-26 20:51:35.195868 | mon1 | Downloading pygments (1.2MiB)
2026-08-26 20:51:35.198433 | mon1 | Downloading netaddr (2.2MiB)
2026-08-26 20:51:35.201154 | mon1 | Downloading ansible-core (2.1MiB)
2026-08-26 20:51:35.201499 | mon1 | Downloading cryptography (4.3MiB)
2026-08-26 20:51:35.379361 | mon1 |  Downloading netaddr
2026-08-26 20:51:35.388653 | mon1 |  Downloading cryptography
2026-08-26 20:51:35.434788 | mon1 |  Downloading pygments
2026-08-26 20:51:35.555479 | mon1 |  Downloading ansible-core
2026-08-26 20:51:35.596397 | mon1 | Installed 36 packages in 40ms
2026-08-26 20:51:36.653601 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-08-26 20:51:36.653685 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-26 20:51:37.237024 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-26 20:51:37.237127 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-26 20:54:28.527681 | mon1 | WARNING  Retrying execution failure 250 of: ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1
2026-08-26 20:54:28.527798 | mon1 | ERROR    Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1, returned 250 code:
2026-08-26 20:54:28.527839 | mon1 | Starting galaxy collection install process
2026-08-26 20:54:28.527851 | mon1 | Process install dependency map
2026-08-26 20:54:28.527890 | mon1 | the full traceback was:
2026-08-26 20:54:28.527901 | mon1 |
2026-08-26 20:54:28.527911 | mon1 | Traceback (most recent call last):
2026-08-26 20:54:28.527922 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 646, in cli_executor
2026-08-26 20:54:28.527933 | mon1 |     exit_code = cli.run()
2026-08-26 20:54:28.527943 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 727, in run
2026-08-26 20:54:28.527953 | mon1 |     return context.CLIARGS()
2026-08-26 20:54:28.527963 | mon1 |            ~~~~~~~~~~~~~~~~~~~~~~~^^
2026-08-26 20:54:28.527973 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 98, in method_wrapper
2026-08-26 20:54:28.527983 | mon1 |     return wrapped_method(*args, **kwargs)
2026-08-26 20:54:28.527993 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1392, in execute_install
2026-08-26 20:54:28.528002 | mon1 |     self._execute_install_collection(
2026-08-26 20:54:28.528012 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.528021 | mon1 |         collection_requirements, collection_path,
2026-08-26 20:54:28.528031 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528041 | mon1 |         artifacts_manager=artifacts_manager,
2026-08-26 20:54:28.528050 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528059 | mon1 |     )
2026-08-26 20:54:28.528069 | mon1 |     ^
2026-08-26 20:54:28.528079 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1441, in _execute_install_collection
2026-08-26 20:54:28.528089 | mon1 |     install_collections(
2026-08-26 20:54:28.528099 | mon1 |     ~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.528109 | mon1 |         requirements, output_path, self.api_servers, ignore_errors,
2026-08-26 20:54:28.528120 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528130 | mon1 |     ...<5 lines>...
2026-08-26 20:54:28.528139 | mon1 |         read_requirement_paths=read_req_paths,
2026-08-26 20:54:28.528149 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528158 | mon1 |     )
2026-08-26 20:54:28.528168 | mon1 |     ^
2026-08-26 20:54:28.528177 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 736, in install_collections
2026-08-26 20:54:28.528209 | mon1 |     dependency_map = _resolve_depenency_map(
2026-08-26 20:54:28.528219 | mon1 |         collections,
2026-08-26 20:54:28.528229 | mon1 |     ...<7 lines>...
2026-08-26 20:54:28.528238 | mon1 |         offline=offline,
2026-08-26 20:54:28.528248 | mon1 |     )
2026-08-26 20:54:28.528257 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1863, in _resolve_depenency_map
2026-08-26 20:54:28.528268 | mon1 |     return collection_dep_resolver.resolve(
2026-08-26 20:54:28.528277 | mon1 |            ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.528287 | mon1 |         requested_requirements,
2026-08-26 20:54:28.528296 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528407 | mon1 |         max_rounds=2000000,  # NOTE: same constant pip uses
2026-08-26 20:54:28.528418 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528427 | mon1 |     ).mapping
2026-08-26 20:54:28.528437 | mon1 |     ^
2026-08-26 20:54:28.528447 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 546, in resolve
2026-08-26 20:54:28.528457 | mon1 |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-08-26 20:54:28.528466 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 427, in resolve
2026-08-26 20:54:28.528476 | mon1 |     failure_causes = self._attempt_to_pin_criterion(name)
2026-08-26 20:54:28.528486 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 239, in _attempt_to_pin_criterion
2026-08-26 20:54:28.528495 | mon1 |     criteria = self._get_updated_criteria(candidate)
2026-08-26 20:54:28.528505 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 230, in _get_updated_criteria
2026-08-26 20:54:28.528515 | mon1 |     self._add_to_criteria(criteria, requirement, parent=candidate)
2026-08-26 20:54:28.528525 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528535 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 148, in _add_to_criteria
2026-08-26 20:54:28.528544 | mon1 |     matches = self._p.find_matches(
2026-08-26 20:54:28.528554 | mon1 |         identifier=identifier,
2026-08-26 20:54:28.528563 | mon1 |     ...<9 lines>...
2026-08-26 20:54:28.528573 | mon1 |         ),
2026-08-26 20:54:28.528582 | mon1 |     )
2026-08-26 20:54:28.528592 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 477, in find_matches
2026-08-26 20:54:28.528601 | mon1 |     match for match in self._find_matches(list(requirements))
2026-08-26 20:54:28.528611 | mon1 |                        ~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.528630 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 253, in _find_matches
2026-08-26 20:54:28.528646 | mon1 |     coll_versions =  if preinstalled_candidates else self._api_proxy.get_collection_versions(first_req)  # type: t.Iterable]
2026-08-26 20:54:28.528656 | mon1 |                                                        ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^
2026-08-26 20:54:28.528665 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 103, in get_collection_versions
2026-08-26 20:54:28.528675 | mon1 |     return set(
2026-08-26 20:54:28.528684 | mon1 |         (version, api)
2026-08-26 20:54:28.528693 | mon1 |     ...<2 lines>...
2026-08-26 20:54:28.528703 | mon1 |         )
2026-08-26 20:54:28.528720 | mon1 |     )
2026-08-26 20:54:28.528730 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 105, in <genexpr>
2026-08-26 20:54:28.528740 | mon1 |     for api, version in self._get_collection_versions(
2026-08-26 20:54:28.528749 | mon1 |                         ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.528759 | mon1 |         requirement,
2026-08-26 20:54:28.528768 | mon1 |         ^^^^^^^^^^^^
2026-08-26 20:54:28.528777 | mon1 |     )
2026-08-26 20:54:28.528787 | mon1 |     ^
2026-08-26 20:54:28.528796 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 85, in _get_collection_versions
2026-08-26 20:54:28.528805 | mon1 |     raise last_error
2026-08-26 20:54:28.528815 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 64, in _get_collection_versions
2026-08-26 20:54:28.528824 | mon1 |     versions = api.get_collection_versions(requirement.namespace, requirement.name)
2026-08-26 20:54:28.528834 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 144, in wrapped
2026-08-26 20:54:28.528844 | mon1 |     return method(self, *args, **kwargs)
2026-08-26 20:54:28.528853 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 873, in get_collection_versions
2026-08-26 20:54:28.528885 | mon1 |     data = self._call_galaxy(versions_url, error_context_msg=error_context_msg, cache=True, cache_key=cache_key)
2026-08-26 20:54:28.528895 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 169, in run_function
2026-08-26 20:54:28.528904 | mon1 |     return call_retryable_function()
2026-08-26 20:54:28.528914 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 389, in _call_galaxy
2026-08-26 20:54:28.528923 | mon1 |     res = path_cache
2026-08-26 20:54:28.528933 | mon1 |           ~~~~~~~~~~^^^^^^^^^^^
2026-08-26 20:54:28.528942 | mon1 | KeyError: 'results'
2026-08-26 20:54:28.528951 | mon1 |
2026-08-26 20:54:28.528961 | mon1 | ansible-galaxy
2026-08-26 20:54:28.528970 | mon1 |   config file = None
2026-08-26 20:54:28.528979 | mon1 |   configured module search path =
2026-08-26 20:54:28.528989 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible
2026-08-26 20:54:28.528999 | mon1 |   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-26 20:54:28.529008 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 20:54:28.529018 | mon1 |   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-26 20:54:28.529027 | mon1 |   jinja version = 3.1.6
2026-08-26 20:54:28.529036 | mon1 |   libyaml = True
2026-08-26 20:54:28.529046 | mon1 | No config file found; using defaults
2026-08-26 20:54:28.529055 | mon1 | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-26 20:54:28.529065 | mon1 | 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-26 20:54:28.529074 | mon1 | Found installed collection ansible.utils:6.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-26 20:54:28.529084 | mon1 | Opened /home/zuul/.ansible/galaxy_token
2026-08-26 20:54:28.529093 | mon1 | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-26 20:54:28.529103 | mon1 | unexpected error when getting available versions of collection ansible.posix:
2026-08-26 20:54:28.529119 | mon1 | 'results'
2026-08-26 20:54:28.529132 | mon1 | ERROR! Unexpected Exception, this is probably a bug: 'results'
2026-08-26 20:54:28.529142 | mon1 |
2026-08-26 20:54:28.531238 | mon1 | Traceback (most recent call last):
2026-08-26 20:54:28.534662 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in <module>
2026-08-26 20:54:28.534697 | mon1 |     sys.exit(main())
2026-08-26 20:54:28.534708 | mon1 |              ~~~~^^
2026-08-26 20:54:28.534981 | mon1 |   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-26 20:54:28.534997 | mon1 |     return self.main(*args, **kwargs)
2026-08-26 20:54:28.535008 | mon1 |            ~~~~~~~~~^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.535262 | mon1 |   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-26 20:54:28.535278 | mon1 |     rv = self.invoke(ctx)
2026-08-26 20:54:28.535544 | mon1 |   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-26 20:54:28.535556 | mon1 |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-26 20:54:28.535566 | mon1 |                            ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
2026-08-26 20:54:28.535972 | mon1 |   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-26 20:54:28.536002 | mon1 |     return ctx.invoke(self.callback, **ctx.params)
2026-08-26 20:54:28.536013 | mon1 |            ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.536241 | mon1 |   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-26 20:54:28.536254 | mon1 |     return callback(*args, **kwargs)
2026-08-26 20:54:28.536533 | mon1 |   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-26 20:54:28.536549 | mon1 |     return func(*args, **kwargs)
2026-08-26 20:54:28.536769 | mon1 |   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-26 20:54:28.536781 | mon1 |     return f(get_current_context(), *args, **kwargs)
2026-08-26 20:54:28.537026 | mon1 |   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-26 20:54:28.537038 | mon1 |     return func(ctx)
2026-08-26 20:54:28.537306 | mon1 |   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-26 20:54:28.537318 | mon1 |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-26 20:54:28.537328 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.537577 | mon1 |   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-26 20:54:28.537589 | mon1 |     _run_scenarios(scenarios, command_args, default_config)
2026-08-26 20:54:28.537598 | mon1 |     ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.538015 | mon1 |   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-26 20:54:28.538027 | mon1 |     scenario.config.runtime.prepare_environment(
2026-08-26 20:54:28.538037 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.538047 | mon1 |         install_local=True,
2026-08-26 20:54:28.538056 | mon1 |         ^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.538066 | mon1 |         role_name_check=role_name_check,
2026-08-26 20:54:28.538075 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.538085 | mon1 |     )
2026-08-26 20:54:28.538108 | mon1 |     ^
2026-08-26 20:54:28.538428 | mon1 |   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-26 20:54:28.538441 | mon1 |     self.install_collection(
2026-08-26 20:54:28.538450 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.538460 | mon1 |         f"{name}{',' if is_url(name) else ':'}{required_version}",
2026-08-26 20:54:28.538470 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.538479 | mon1 |         destination=destination,
2026-08-26 20:54:28.538489 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.538498 | mon1 |     )
2026-08-26 20:54:28.538508 | mon1 |     ^
2026-08-26 20:54:28.538672 | mon1 |   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-26 20:54:28.538683 | mon1 |     raise InvalidPrerequisiteError(msg)
2026-08-26 20:54:28.543700 | mon1 | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.1.1, returned 250 code:
2026-08-26 20:54:28.543730 | mon1 | Starting galaxy collection install process
2026-08-26 20:54:28.543740 | mon1 | Process install dependency map
2026-08-26 20:54:28.543750 | mon1 | the full traceback was:
2026-08-26 20:54:28.543760 | mon1 |
2026-08-26 20:54:28.543769 | mon1 | Traceback (most recent call last):
2026-08-26 20:54:28.543779 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 646, in cli_executor
2026-08-26 20:54:28.543789 | mon1 |     exit_code = cli.run()
2026-08-26 20:54:28.543806 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 727, in run
2026-08-26 20:54:28.543816 | mon1 |     return context.CLIARGS['func']()
2026-08-26 20:54:28.543826 | mon1 |            ~~~~~~~~~~~~~~~~~~~~~~~^^
2026-08-26 20:54:28.543835 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 98, in method_wrapper
2026-08-26 20:54:28.543845 | mon1 |     return wrapped_method(*args, **kwargs)
2026-08-26 20:54:28.543854 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1392, in execute_install
2026-08-26 20:54:28.543893 | mon1 |     self._execute_install_collection(
2026-08-26 20:54:28.543903 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.543912 | mon1 |         collection_requirements, collection_path,
2026-08-26 20:54:28.543922 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.543931 | mon1 |         artifacts_manager=artifacts_manager,
2026-08-26 20:54:28.543940 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.543950 | mon1 |     )
2026-08-26 20:54:28.543959 | mon1 |     ^
2026-08-26 20:54:28.543968 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1441, in _execute_install_collection
2026-08-26 20:54:28.543978 | mon1 |     install_collections(
2026-08-26 20:54:28.543988 | mon1 |     ~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.543998 | mon1 |         requirements, output_path, self.api_servers, ignore_errors,
2026-08-26 20:54:28.544008 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544017 | mon1 |     ...<5 lines>...
2026-08-26 20:54:28.544026 | mon1 |         read_requirement_paths=read_req_paths,
2026-08-26 20:54:28.544036 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544045 | mon1 |     )
2026-08-26 20:54:28.544055 | mon1 |     ^
2026-08-26 20:54:28.544065 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 736, in install_collections
2026-08-26 20:54:28.544075 | mon1 |     dependency_map = _resolve_depenency_map(
2026-08-26 20:54:28.544085 | mon1 |         collections,
2026-08-26 20:54:28.544095 | mon1 |     ...<7 lines>...
2026-08-26 20:54:28.544115 | mon1 |         offline=offline,
2026-08-26 20:54:28.544124 | mon1 |     )
2026-08-26 20:54:28.544134 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1863, in _resolve_depenency_map
2026-08-26 20:54:28.544144 | mon1 |     return collection_dep_resolver.resolve(
2026-08-26 20:54:28.544153 | mon1 |            ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.544163 | mon1 |         requested_requirements,
2026-08-26 20:54:28.544172 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544181 | mon1 |         max_rounds=2000000,  # NOTE: same constant pip uses
2026-08-26 20:54:28.544190 | mon1 |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544200 | mon1 |     ).mapping
2026-08-26 20:54:28.544209 | mon1 |     ^
2026-08-26 20:54:28.544219 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 546, in resolve
2026-08-26 20:54:28.544229 | mon1 |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-08-26 20:54:28.544238 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 427, in resolve
2026-08-26 20:54:28.544248 | mon1 |     failure_causes = self._attempt_to_pin_criterion(name)
2026-08-26 20:54:28.544257 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 239, in _attempt_to_pin_criterion
2026-08-26 20:54:28.544266 | mon1 |     criteria = self._get_updated_criteria(candidate)
2026-08-26 20:54:28.544276 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 230, in _get_updated_criteria
2026-08-26 20:54:28.544285 | mon1 |     self._add_to_criteria(criteria, requirement, parent=candidate)
2026-08-26 20:54:28.544294 | mon1 |     ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544325 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/resolvelib/resolvers.py", line 148, in _add_to_criteria
2026-08-26 20:54:28.544337 | mon1 |     matches = self._p.find_matches(
2026-08-26 20:54:28.544346 | mon1 |         identifier=identifier,
2026-08-26 20:54:28.544356 | mon1 |     ...<9 lines>...
2026-08-26 20:54:28.544365 | mon1 |         ),
2026-08-26 20:54:28.544375 | mon1 |     )
2026-08-26 20:54:28.544384 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 477, in find_matches
2026-08-26 20:54:28.544394 | mon1 |     match for match in self._find_matches(list(requirements[identifier]))
2026-08-26 20:54:28.544407 | mon1 |                        ~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:54:28.544426 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 253, in _find_matches
2026-08-26 20:54:28.544436 | mon1 |     coll_versions = [] if preinstalled_candidates else self._api_proxy.get_collection_versions(first_req)  # type: t.Iterable[t.Tuple[str, GalaxyAPI]]
2026-08-26 20:54:28.544446 | mon1 |                                                        ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^
2026-08-26 20:54:28.544455 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 103, in get_collection_versions
2026-08-26 20:54:28.544465 | mon1 |     return set(
2026-08-26 20:54:28.544474 | mon1 |         (version, api)
2026-08-26 20:54:28.544483 | mon1 |     ...<2 lines>...
2026-08-26 20:54:28.544493 | mon1 |         )
2026-08-26 20:54:28.544502 | mon1 |     )
2026-08-26 20:54:28.544512 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 105, in <genexpr>
2026-08-26 20:54:28.544521 | mon1 |     for api, version in self._get_collection_versions(
2026-08-26 20:54:28.544537 | mon1 |                         ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-08-26 20:54:28.544547 | mon1 |         requirement,
2026-08-26 20:54:28.544556 | mon1 |         ^^^^^^^^^^^^
2026-08-26 20:54:28.544565 | mon1 |     )
2026-08-26 20:54:28.544575 | mon1 |     ^
2026-08-26 20:54:28.544584 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 85, in _get_collection_versions
2026-08-26 20:54:28.544593 | mon1 |     raise last_error
2026-08-26 20:54:28.544603 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 64, in _get_collection_versions
2026-08-26 20:54:28.544612 | mon1 |     versions = api.get_collection_versions(requirement.namespace, requirement.name)
2026-08-26 20:54:28.544622 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 144, in wrapped
2026-08-26 20:54:28.544631 | mon1 |     return method(self, *args, **kwargs)
2026-08-26 20:54:28.544641 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 873, in get_collection_versions
2026-08-26 20:54:28.544650 | mon1 |     data = self._call_galaxy(versions_url, error_context_msg=error_context_msg, cache=True, cache_key=cache_key)
2026-08-26 20:54:28.544660 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 169, in run_function
2026-08-26 20:54:28.544670 | mon1 |     return call_retryable_function()
2026-08-26 20:54:28.544679 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 389, in _call_galaxy
2026-08-26 20:54:28.544691 | mon1 |     res = path_cache['results']
2026-08-26 20:54:28.544701 | mon1 |           ~~~~~~~~~~^^^^^^^^^^^
2026-08-26 20:54:28.544709 | mon1 | KeyError: 'results'
2026-08-26 20:54:28.544718 | mon1 |
2026-08-26 20:54:28.544727 | mon1 | ansible-galaxy [core 2.18.6]
2026-08-26 20:54:28.544735 | mon1 |   config file = None
2026-08-26 20:54:28.544744 | mon1 |   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-26 20:54:28.544753 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.13/site-packages/ansible
2026-08-26 20:54:28.544761 | mon1 |   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-26 20:54:28.544770 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 20:54:28.544779 | mon1 |   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-26 20:54:28.544788 | mon1 |   jinja version = 3.1.6
2026-08-26 20:54:28.544796 | mon1 |   libyaml = True
2026-08-26 20:54:28.544805 | mon1 | No config file found; using defaults
2026-08-26 20:54:28.544814 | mon1 | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-26 20:54:28.544822 | mon1 | 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-26 20:54:28.544831 | mon1 | Found installed collection ansible.utils:6.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-26 20:54:28.544840 | mon1 | Opened /home/zuul/.ansible/galaxy_token
2026-08-26 20:54:28.544848 | mon1 | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-26 20:54:28.544857 | mon1 | unexpected error when getting available versions of collection ansible.posix:
2026-08-26 20:54:28.544882 | mon1 | 'results'
2026-08-26 20:54:28.544897 | mon1 | ERROR! Unexpected Exception, this is probably a bug: 'results'
2026-08-26 20:54:28.544905 | mon1 |
2026-08-26 20:54:39.112114 | mon1 | ERROR
2026-08-26 20:54:39.112332 | mon1 | {
2026-08-26 20:54:39.112363 | mon1 |   "delta": "0:03:11.046488",
2026-08-26 20:54:39.112385 | mon1 |   "end": "2026-08-26 20:54:28.627451",
2026-08-26 20:54:39.112405 | mon1 |   "msg": "non-zero return code",
2026-08-26 20:54:39.112425 | mon1 |   "rc": 1,
2026-08-26 20:54:39.112443 | mon1 |   "start": "2026-08-26 20:51:17.580963"
2026-08-26 20:54:39.112461 | mon1 | }
failure
2026-08-26 20:54:39.116348 | 
2026-08-26 20:54:39.116401 | PLAY RECAP
2026-08-26 20:54:39.116446 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:54:39.116469 | 
2026-08-26 20:54:39.230746 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 20:54:39.234979 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 20:54:39.907657 | 
2026-08-26 20:54:39.907872 | PLAY [all]
2026-08-26 20:54:39.922482 | 
2026-08-26 20:54:39.922563 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-26 20:54:39.975540 | mon1 | ok
2026-08-26 20:54:39.982520 | osd1 | ok
2026-08-26 20:54:39.987281 | 
2026-08-26 20:54:39.987358 | TASK [fetch-output : Set log path for single node]
2026-08-26 20:54:40.010866 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:40.021887 | osd1 | skipping: Conditional result was False
2026-08-26 20:54:40.031624 | 
2026-08-26 20:54:40.031699 | LOOP [fetch-output : Ensure local output dirs]
2026-08-26 20:54:40.430333 | osd1 -> localhost | changed: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/logs/osd1"
2026-08-26 20:54:40.444268 | mon1 -> localhost | changed: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/logs/mon1"
2026-08-26 20:54:40.675331 | mon1 -> localhost | ok: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/artifacts"
2026-08-26 20:54:40.687429 | osd1 -> localhost | changed: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/artifacts"
2026-08-26 20:54:40.911348 | mon1 -> localhost | changed: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/docs"
2026-08-26 20:54:40.915747 | osd1 -> localhost | ok: "/var/lib/zuul/builds/47c36f9f89c142508907a06a802ed01f/work/docs"
2026-08-26 20:54:40.932432 | 
2026-08-26 20:54:40.932569 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-26 20:54:42.604075 | osd1 | changed: .d..t...... ./
2026-08-26 20:54:42.604344 | osd1 | changed: All items complete
2026-08-26 20:54:42.604375 | 
2026-08-26 20:54:42.630712 | mon1 | changed: .d..t...... ./
2026-08-26 20:54:43.080130 | osd1 | changed: .d..t...... ./
2026-08-26 20:54:43.110387 | mon1 | ok
2026-08-26 20:54:43.553392 | osd1 | changed: .d..t...... ./
2026-08-26 20:54:43.592295 | mon1 | ok
2026-08-26 20:54:43.614284 | 
2026-08-26 20:54:43.614444 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-26 20:54:44.032128 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007275
2026-08-26 20:54:44.032486 | mon1 -> localhost | changed: All items complete
2026-08-26 20:54:44.032527 | 
2026-08-26 20:54:44.243938 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.008331
2026-08-26 20:54:44.271198 | 
2026-08-26 20:54:44.271397 | PLAY [all]
2026-08-26 20:54:44.279845 | 
2026-08-26 20:54:44.279908 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-26 20:54:44.713536 | mon1 | changed
2026-08-26 20:54:44.955342 | osd1 | changed
2026-08-26 20:54:44.971199 | 
2026-08-26 20:54:44.971250 | PLAY RECAP
2026-08-26 20:54:44.971297 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 20:54:44.971326 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 20:54:44.971346 | 
2026-08-26 20:54:45.099577 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 20:54:45.107223 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-26 20:54:45.761422 | 
2026-08-26 20:54:45.761643 | PLAY [localhost]
2026-08-26 20:54:45.773836 | 
2026-08-26 20:54:45.773917 | TASK [Generate Zuul manifest]
2026-08-26 20:54:45.805791 | localhost | ok
2026-08-26 20:54:45.824391 | 
2026-08-26 20:54:45.824493 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-26 20:54:46.243891 | localhost | changed
2026-08-26 20:54:46.259717 | 
2026-08-26 20:54:46.259831 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-26 20:54:46.290920 | localhost | ok
2026-08-26 20:54:46.301631 | 
2026-08-26 20:54:46.301705 | TASK [Upload logs]
2026-08-26 20:54:46.327968 | localhost | ok
2026-08-26 20:54:46.389207 | 
2026-08-26 20:54:46.389347 | TASK [Set zuul-log-path fact]
2026-08-26 20:54:46.413654 | localhost | ok
2026-08-26 20:54:46.425725 | 
2026-08-26 20:54:46.425789 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 20:54:46.459140 | localhost | ok
2026-08-26 20:54:46.469456 | 
2026-08-26 20:54:46.469523 | TASK [upload-logs : Create log directories]
2026-08-26 20:54:46.908118 | localhost | changed
2026-08-26 20:54:46.915837 | 
2026-08-26 20:54:46.915932 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-26 20:54:47.325509 | localhost -> localhost | ok: Runtime: 0:00:00.004260
2026-08-26 20:54:47.333137 | 
2026-08-26 20:54:47.333231 | TASK [upload-logs : Upload logs to log server]
2026-08-26 20:54:47.808969 | localhost | Output suppressed because no_log was given
2026-08-26 20:54:47.816780 | 
2026-08-26 20:54:47.816874 | LOOP [upload-logs : Compress console log and json output]
2026-08-26 20:54:47.909744 | localhost | skipping: Conditional result was False
2026-08-26 20:54:47.916835 | localhost | skipping: Conditional result was False
2026-08-26 20:54:47.934536 | 
2026-08-26 20:54:47.934724 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-26 20:54:48.050243 | localhost | skipping: Conditional result was False
2026-08-26 20:54:48.050506 | 
2026-08-26 20:54:48.061846 | localhost | skipping: Conditional result was False
2026-08-26 20:54:48.113050 | 
2026-08-26 20:54:48.113219 | LOOP [upload-logs : Upload console log and json output]