2026-09-15 11:38:05.312542 | Job console starting
2026-09-15 11:38:05.328652 | Updating git repos
2026-09-15 11:38:05.395885 | Cloning repos into workspace
2026-09-15 11:38:05.447582 | Restoring repo states
2026-09-15 11:38:05.453790 | Merging changes
2026-09-15 11:38:05.894089 | Checking out repos
2026-09-15 11:38:05.935666 | Preparing playbooks
2026-09-15 11:38:07.207849 | Running Ansible setup
2026-09-15 11:38:11.013851 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-15 11:38:11.625911 | 
2026-09-15 11:38:11.626052 | PLAY [localhost]
2026-09-15 11:38:11.634381 | 
2026-09-15 11:38:11.634467 | TASK [Gathering Facts]
2026-09-15 11:38:12.525190 | localhost | ok
2026-09-15 11:38:12.533512 | 
2026-09-15 11:38:12.533619 | TASK [Setup log path fact]
2026-09-15 11:38:12.553156 | localhost | ok
2026-09-15 11:38:12.566477 | 
2026-09-15 11:38:12.566651 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-15 11:38:12.606984 | localhost | ok
2026-09-15 11:38:12.615714 | 
2026-09-15 11:38:12.615878 | TASK [emit-job-header : Print job information]
2026-09-15 11:38:12.668108 | # Job Information
2026-09-15 11:38:12.668416 | Ansible Version: 2.16.18
2026-09-15 11:38:12.668483 | Job: ansible-collection-ceph-molecule-aio-ubuntu-noble
2026-09-15 11:38:12.668569 | Pipeline: check
2026-09-15 11:38:12.668612 | Executor: 2d72f0692154
2026-09-15 11:38:12.668651 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/117
2026-09-15 11:38:12.668695 | Event ID: 7c9cc470-b0f9-11f1-9f58-9ec8e2f5aac2
2026-09-15 11:38:12.675436 | 
2026-09-15 11:38:12.675584 | LOOP [emit-job-header : Print node information]
2026-09-15 11:38:12.794864 | localhost | ok:
2026-09-15 11:38:12.795121 | localhost | # Node Information
2026-09-15 11:38:12.795176 | localhost | Inventory Hostname: aio
2026-09-15 11:38:12.795219 | localhost | Hostname: np0000192826
2026-09-15 11:38:12.795257 | localhost | Username: zuul
2026-09-15 11:38:12.795327 | localhost | Distro: Ubuntu 24.04
2026-09-15 11:38:12.795390 | localhost | Provider: yul1
2026-09-15 11:38:12.795464 | localhost | Region: ca-ymq-1
2026-09-15 11:38:12.795533 | localhost | Label: ubuntu-noble
2026-09-15 11:38:12.795601 | localhost | Product Name: OpenStack Nova
2026-09-15 11:38:12.795665 | localhost | Interface IP: 162.253.55.54
2026-09-15 11:38:12.807411 | 
2026-09-15 11:38:12.807583 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-15 11:38:13.249208 | localhost -> localhost | changed
2026-09-15 11:38:13.260141 | 
2026-09-15 11:38:13.260348 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-15 11:38:14.101551 | localhost -> localhost | changed
2026-09-15 11:38:14.114447 | 
2026-09-15 11:38:14.114594 | PLAY [all]
2026-09-15 11:38:14.133816 | 
2026-09-15 11:38:14.134176 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-15 11:38:14.392849 | aio -> localhost | ok
2026-09-15 11:38:14.404975 | 
2026-09-15 11:38:14.405108 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-15 11:38:14.450145 | aio | ok
2026-09-15 11:38:14.478763 | aio | included: /var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-15 11:38:14.486799 | 
2026-09-15 11:38:14.486878 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-15 11:38:15.948348 | aio -> localhost | Generating public/private rsa key pair.
2026-09-15 11:38:15.948691 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/dc6489b94be54614bec6c24f38658a10_id_rsa
2026-09-15 11:38:15.948776 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/dc6489b94be54614bec6c24f38658a10_id_rsa.pub
2026-09-15 11:38:15.948833 | aio -> localhost | The key fingerprint is:
2026-09-15 11:38:15.948879 | aio -> localhost | SHA256:+1e958om6EDm2RPBPbOKia+xWOtWblPy9BklShzpJUU zuul-build-sshkey
2026-09-15 11:38:15.948950 | aio -> localhost | The key's randomart image is:
2026-09-15 11:38:15.948994 | aio -> localhost | +---[RSA 3072]----+
2026-09-15 11:38:15.949046 | aio -> localhost | |           +E    |
2026-09-15 11:38:15.949091 | aio -> localhost | |         .+..    |
2026-09-15 11:38:15.949133 | aio -> localhost | |         oo++    |
2026-09-15 11:38:15.949176 | aio -> localhost | |          +..+.  |
2026-09-15 11:38:15.949216 | aio -> localhost | |        S....o . |
2026-09-15 11:38:15.949257 | aio -> localhost | |       =o*+o. . .|
2026-09-15 11:38:15.949321 | aio -> localhost | |      +oB=+o +  .|
2026-09-15 11:38:15.949368 | aio -> localhost | |     o.=+oo.=....|
2026-09-15 11:38:15.949416 | aio -> localhost | |    .o=o.oo. oooo|
2026-09-15 11:38:15.949458 | aio -> localhost | +----[SHA256]-----+
2026-09-15 11:38:15.949570 | aio -> localhost | ok: Runtime: 0:00:01.018711
2026-09-15 11:38:15.963943 | 
2026-09-15 11:38:15.964108 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-15 11:38:16.001144 | aio | ok
2026-09-15 11:38:16.019197 | aio | included: /var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-15 11:38:16.037974 | 
2026-09-15 11:38:16.038149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-15 11:38:16.062389 | aio | skipping: Conditional result was False
2026-09-15 11:38:16.076202 | 
2026-09-15 11:38:16.076361 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-15 11:38:16.614262 | aio | changed
2026-09-15 11:38:16.622164 | 
2026-09-15 11:38:16.622248 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-15 11:38:16.885396 | aio | ok
2026-09-15 11:38:16.896442 | 
2026-09-15 11:38:16.896594 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-15 11:38:17.520056 | aio | changed
2026-09-15 11:38:17.529225 | 
2026-09-15 11:38:17.529388 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-15 11:38:18.136776 | aio | changed
2026-09-15 11:38:18.147964 | 
2026-09-15 11:38:18.148100 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-15 11:38:18.172945 | aio | skipping: Conditional result was False
2026-09-15 11:38:18.184657 | 
2026-09-15 11:38:18.184799 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-15 11:38:18.631170 | aio -> localhost | changed
2026-09-15 11:38:18.650116 | 
2026-09-15 11:38:18.650314 | TASK [add-build-sshkey : Add back temp key]
2026-09-15 11:38:19.040117 | aio -> localhost | Identity added: /var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/dc6489b94be54614bec6c24f38658a10_id_rsa (zuul-build-sshkey)
2026-09-15 11:38:19.040337 | aio -> localhost | ok: Runtime: 0:00:00.015900
2026-09-15 11:38:19.047784 | 
2026-09-15 11:38:19.047883 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-15 11:38:19.429992 | aio | ok
2026-09-15 11:38:19.440972 | 
2026-09-15 11:38:19.441107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-15 11:38:19.476755 | aio | skipping: Conditional result was False
2026-09-15 11:38:19.500779 | 
2026-09-15 11:38:19.500901 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-15 11:38:19.980843 | aio | ok
2026-09-15 11:38:19.988522 | 
2026-09-15 11:38:19.988613 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-15 11:38:20.809714 | aio | Output suppressed because no_log was given
2026-09-15 11:38:20.829736 | 
2026-09-15 11:38:20.829873 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-15 11:38:21.094994 | aio | ok: "logs"
2026-09-15 11:38:21.095595 | aio | ok: All items complete
2026-09-15 11:38:21.095645 | 
2026-09-15 11:38:21.324658 | aio | ok: "artifacts"
2026-09-15 11:38:21.527488 | aio | ok: "docs"
2026-09-15 11:38:21.539179 | 
2026-09-15 11:38:21.539367 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-15 11:38:21.762008 | aio | changed: "logs"
2026-09-15 11:38:21.954989 | aio | changed: "artifacts"
2026-09-15 11:38:22.187426 | aio | changed: "docs"
2026-09-15 11:38:22.205072 | 
2026-09-15 11:38:22.205223 | PLAY RECAP
2026-09-15 11:38:22.205314 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-15 11:38:22.205355 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-15 11:38:22.205389 | 
2026-09-15 11:38:22.383263 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-15 11:38:22.385442 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-15 11:38:22.981426 | 
2026-09-15 11:38:22.981579 | PLAY [all]
2026-09-15 11:38:22.992394 | 
2026-09-15 11:38:22.992471 | TASK [setup-uv : Extract archive]
2026-09-15 11:38:25.769320 | aio | changed
2026-09-15 11:38:25.779683 | 
2026-09-15 11:38:25.779872 | TASK [setup-uv : Print version]
2026-09-15 11:38:26.212248 | aio | uv 0.8.13
2026-09-15 11:38:26.348187 | aio | ok: Runtime: 0:00:00.016451
2026-09-15 11:38:26.361187 | 
2026-09-15 11:38:26.361285 | TASK [Install Ansible collection siblings]
2026-09-15 11:38:26.810770 | aio | ok:
2026-09-15 11:38:27.728755 | aio | Skipping community.general: no checked-out sibling
2026-09-15 11:38:27.728946 | aio | Skipping ansible.utils: no checked-out sibling
2026-09-15 11:38:27.729001 | aio | Skipping vexxhost.containers: no checked-out sibling
2026-09-15 11:38:27.732601 | 
2026-09-15 11:38:27.732700 | PLAY RECAP
2026-09-15 11:38:27.732791 | aio | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-15 11:38:27.732834 | 
2026-09-15 11:38:27.886098 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-15 11:38:27.891259 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-15 11:38:28.448336 | 
2026-09-15 11:38:28.448585 | PLAY [all]
2026-09-15 11:38:28.461328 | 
2026-09-15 11:38:28.461421 | LOOP [Check inventory directories]
2026-09-15 11:38:28.878926 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-09-15 11:38:29.091456 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-09-15 11:38:29.305841 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-09-15 11:38:29.327338 | 
2026-09-15 11:38:29.327652 | LOOP [Copy inventory file for Zuul]
2026-09-15 11:38:30.377389 | aio | changed:
2026-09-15 11:38:30.377700 | aio | {
2026-09-15 11:38:30.377762 | aio |   "ansible_loop_var": "item",
2026-09-15 11:38:30.377812 | aio |   "changed": false,
2026-09-15 11:38:30.377857 | aio |   "failed": false,
2026-09-15 11:38:30.377907 | aio |   "invocation": {
2026-09-15 11:38:30.377957 | aio |     "module_args": {
2026-09-15 11:38:30.378015 | aio |       "checksum_algorithm": "sha1",
2026-09-15 11:38:30.378075 | aio |       "follow": true,
2026-09-15 11:38:30.378118 | aio |       "get_attributes": true,
2026-09-15 11:38:30.378182 | aio |       "get_checksum": true,
2026-09-15 11:38:30.378223 | aio |       "get_mime": true,
2026-09-15 11:38:30.378258 | aio |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-09-15 11:38:30.378317 | aio |     }
2026-09-15 11:38:30.378355 | aio |   },
2026-09-15 11:38:30.378392 | aio |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-09-15 11:38:30.378445 | aio |   "stat": {
2026-09-15 11:38:30.378482 | aio |     "atime": 1789472300.6725123,
2026-09-15 11:38:30.378520 | aio |     "attr_flags": "e",
2026-09-15 11:38:30.378556 | aio |     "attributes": [
2026-09-15 11:38:30.378594 | aio |       "extents"
2026-09-15 11:38:30.378630 | aio |     ],
2026-09-15 11:38:30.378665 | aio |     "block_size": 4096,
2026-09-15 11:38:30.378701 | aio |     "blocks": 8,
2026-09-15 11:38:30.378737 | aio |     "charset": "unknown",
2026-09-15 11:38:30.378777 | aio |     "ctime": 1789472300.6965125,
2026-09-15 11:38:30.378815 | aio |     "dev": 64769,
2026-09-15 11:38:30.378866 | aio |     "device_type": 0,
2026-09-15 11:38:30.378904 | aio |     "executable": true,
2026-09-15 11:38:30.378939 | aio |     "exists": true,
2026-09-15 11:38:30.378975 | aio |     "gid": 1000,
2026-09-15 11:38:30.379011 | aio |     "gr_name": "zuul",
2026-09-15 11:38:30.379055 | aio |     "inode": 1034784,
2026-09-15 11:38:30.379092 | aio |     "isblk": false,
2026-09-15 11:38:30.379128 | aio |     "ischr": false,
2026-09-15 11:38:30.379166 | aio |     "isdir": true,
2026-09-15 11:38:30.379201 | aio |     "isfifo": false,
2026-09-15 11:38:30.379235 | aio |     "isgid": false,
2026-09-15 11:38:30.379269 | aio |     "islnk": false,
2026-09-15 11:38:30.379322 | aio |     "isreg": false,
2026-09-15 11:38:30.379358 | aio |     "issock": false,
2026-09-15 11:38:30.379393 | aio |     "isuid": false,
2026-09-15 11:38:30.379427 | aio |     "mimetype": "unknown",
2026-09-15 11:38:30.379462 | aio |     "mode": "0755",
2026-09-15 11:38:30.379497 | aio |     "mtime": 1789472285.8522396,
2026-09-15 11:38:30.379531 | aio |     "nlink": 10,
2026-09-15 11:38:30.379566 | aio |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-09-15 11:38:30.379602 | aio |     "pw_name": "zuul",
2026-09-15 11:38:30.379639 | aio |     "readable": true,
2026-09-15 11:38:30.379675 | aio |     "rgrp": true,
2026-09-15 11:38:30.379710 | aio |     "roth": true,
2026-09-15 11:38:30.379746 | aio |     "rusr": true,
2026-09-15 11:38:30.379781 | aio |     "size": 4096,
2026-09-15 11:38:30.379816 | aio |     "uid": 1000,
2026-09-15 11:38:30.379851 | aio |     "version": "1876294913",
2026-09-15 11:38:30.379887 | aio |     "wgrp": false,
2026-09-15 11:38:30.379926 | aio |     "woth": false,
2026-09-15 11:38:30.379964 | aio |     "writeable": true,
2026-09-15 11:38:30.380000 | aio |     "wusr": true,
2026-09-15 11:38:30.380036 | aio |     "xgrp": true,
2026-09-15 11:38:30.380071 | aio |     "xoth": true,
2026-09-15 11:38:30.380106 | aio |     "xusr": true
2026-09-15 11:38:30.380142 | aio |   }
2026-09-15 11:38:30.380178 | aio | }
2026-09-15 11:38:30.380248 | aio | ok: All items complete
2026-09-15 11:38:30.380309 | 
2026-09-15 11:38:30.383031 | aio | skipping: Conditional result was False
2026-09-15 11:38:30.387922 | aio | skipping: Conditional result was False
2026-09-15 11:38:30.402771 | 
2026-09-15 11:38:30.402872 | LOOP [Switch "ansible_host" to private IP]
2026-09-15 11:38:30.809832 | aio | changed: 1 replacements made
2026-09-15 11:38:30.812131 | aio | skipping: Conditional result was False
2026-09-15 11:38:30.813889 | aio | skipping: Conditional result was False
2026-09-15 11:38:30.825124 | 
2026-09-15 11:38:30.825279 | TASK [Run Molecule scenario]
2026-09-15 11:38:31.354767 | aio | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-09-15 11:38:31.354912 | aio | Creating virtual environment at: .venv
2026-09-15 11:38:31.386598 | aio | Downloading pygments (1.2MiB)
2026-09-15 11:38:31.390102 | aio | Downloading netaddr (2.2MiB)
2026-09-15 11:38:31.390514 | aio | Downloading cryptography (4.3MiB)
2026-09-15 11:38:31.390942 | aio | Downloading ansible-core (2.3MiB)
2026-09-15 11:38:31.580757 | aio |  Downloading netaddr
2026-09-15 11:38:31.593522 | aio |  Downloading cryptography
2026-09-15 11:38:31.642271 | aio |  Downloading pygments
2026-09-15 11:38:31.811196 | aio |  Downloading ansible-core
2026-09-15 11:38:31.878859 | aio | Installed 37 packages in 67ms
2026-09-15 11:38:32.651650 | aio | INFO     Collection 'vexxhost.ceph' detected.
2026-09-15 11:38:32.651747 | aio | INFO     Scenarios will be used from 'extensions/molecule'
2026-09-15 11:38:33.636044 | aio | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-15 11:38:33.636122 | aio | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-09-15 11:40:48.893970 | aio | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv community.general:>=4.5.0
2026-09-15 11:40:48.894093 | aio | ERROR    Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-09-15 11:40:48.894108 | aio | Starting galaxy collection install process
2026-09-15 11:40:48.894121 | aio | Process install dependency map
2026-09-15 11:40:48.894132 | aio | Starting collection install process
2026-09-15 11:40:48.894162 | aio | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.4.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141ifb8mk4t/tmpcpsw_8wb/community-general-13.4.0-1ouqs5jm
2026-09-15 11:40:48.894189 | aio |
2026-09-15 11:40:48.894201 | aio | ansible-galaxy
2026-09-15 11:40:48.894213 | aio |   config file = None
2026-09-15 11:40:48.894224 | aio |   configured module search path =
2026-09-15 11:40:48.894236 | aio |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-09-15 11:40:48.894254 | aio |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/local/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages
2026-09-15 11:40:48.894355 | aio |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-09-15 11:40:48.894373 | aio |   python version = 3.12.3 (main, Jul 15 2026, 23:46:41)  (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python)
2026-09-15 11:40:48.894384 | aio |   jinja version = 3.1.6
2026-09-15 11:40:48.894396 | aio |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-09-15 11:40:48.894407 | aio | No config file found; using defaults
2026-09-15 11:40:48.894419 | aio | Created /home/zuul/.ansible/galaxy_token
2026-09-15 11:40:48.894430 | aio | : Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out
2026-09-15 11:40:48.894442 | aio |
2026-09-15 11:40:48.895649 | aio | Traceback (most recent call last):
2026-09-15 11:40:48.895996 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in <module>
2026-09-15 11:40:48.896626 | aio |     sys.exit(main())
2026-09-15 11:40:48.897019 | aio |              ^^^^^^
2026-09-15 11:40:48.897387 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/core.py", line 1442, in __call__
2026-09-15 11:40:48.898430 | aio |     return self.main(*args, **kwargs)
2026-09-15 11:40:48.898830 | aio |            ^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.899138 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/core.py", line 1363, in main
2026-09-15 11:40:48.900148 | aio |     rv = self.invoke(ctx)
2026-09-15 11:40:48.900592 | aio |          ^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.900897 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/core.py", line 1830, in invoke
2026-09-15 11:40:48.902024 | aio |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-09-15 11:40:48.902500 | aio |                            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.902835 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/core.py", line 1226, in invoke
2026-09-15 11:40:48.903807 | aio |     return ctx.invoke(self.callback, **ctx.params)
2026-09-15 11:40:48.904225 | aio |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.904616 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/core.py", line 794, in invoke
2026-09-15 11:40:48.905345 | aio |     return callback(*args, **kwargs)
2026-09-15 11:40:48.905809 | aio |            ^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.906096 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/molecule/click_cfg.py", line 613, in wrapper
2026-09-15 11:40:48.906771 | aio |     return func(*args, **kwargs)
2026-09-15 11:40:48.907139 | aio |            ^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.907576 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/click/decorators.py", line 34, in new_func
2026-09-15 11:40:48.907981 | aio |     return f(get_current_context(), *args, **kwargs)
2026-09-15 11:40:48.908478 | aio |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-15 11:40:48.908821 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/molecule/click_cfg.py", line 468, in wrapper
2026-09-15 11:40:48.909498 | aio |     return func(ctx)
2026-09-15 11:40:48.909866 | aio |            ^^^^^^^^^
2026-09-15 11:40:48.910189 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/molecule/command/test.py", line 95, in test
2026-09-15 11:40:48.910796 | aio |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-09-15 11:40:48.911375 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/molecule/command/base.py", line 235, in execute_cmdline_scenarios
2026-09-15 11:40:48.911917 | aio |     _run_scenarios(scenarios, command_args, default_config)
2026-09-15 11:40:48.912327 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/molecule/command/base.py", line 314, in _run_scenarios
2026-09-15 11:40:48.912924 | aio |     scenario.config.runtime.prepare_environment(
2026-09-15 11:40:48.913221 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible_compat/runtime.py", line 694, in prepare_environment
2026-09-15 11:40:48.913836 | aio |     self.install_collection(
2026-09-15 11:40:48.914059 | aio |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible_compat/runtime.py", line 552, in install_collection
2026-09-15 11:40:48.914576 | aio |     raise InvalidPrerequisiteError(msg)
2026-09-15 11:40:48.915803 | aio | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-09-15 11:40:48.915837 | aio | Starting galaxy collection install process
2026-09-15 11:40:48.915850 | aio | Process install dependency map
2026-09-15 11:40:48.915862 | aio | Starting collection install process
2026-09-15 11:40:48.915873 | aio | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.4.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141ifb8mk4t/tmpcpsw_8wb/community-general-13.4.0-1ouqs5jm
2026-09-15 11:40:48.915919 | aio |
2026-09-15 11:40:48.915932 | aio | ansible-galaxy [core 2.21.4]
2026-09-15 11:40:48.915944 | aio |   config file = None
2026-09-15 11:40:48.915955 | 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-09-15 11:40:48.915967 | aio |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-09-15 11:40:48.916002 | aio |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/local/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages
2026-09-15 11:40:48.916017 | aio |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-09-15 11:40:48.916028 | aio |   python version = 3.12.3 (main, Jul 15 2026, 23:46:41) [GCC 13.3.0] (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python)
2026-09-15 11:40:48.916039 | aio |   jinja version = 3.1.6
2026-09-15 11:40:48.916050 | aio |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-09-15 11:40:48.916061 | aio | No config file found; using defaults
2026-09-15 11:40:48.916072 | aio | Created /home/zuul/.ansible/galaxy_token
2026-09-15 11:40:48.916083 | aio | [ERROR]: Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out
2026-09-15 11:40:48.916102 | aio |
2026-09-15 11:40:49.450346 | aio | ERROR
2026-09-15 11:40:49.450875 | aio | {
2026-09-15 11:40:49.450999 | aio |   "delta": "0:02:17.741539",
2026-09-15 11:40:49.451085 | aio |   "end": "2026-09-15 11:40:49.020911",
2026-09-15 11:40:49.451563 | aio |   "msg": "non-zero return code",
2026-09-15 11:40:49.451661 | aio |   "rc": 1,
2026-09-15 11:40:49.451740 | aio |   "start": "2026-09-15 11:38:31.279372"
2026-09-15 11:40:49.451816 | aio | }
failure
2026-09-15 11:40:49.457966 | 
2026-09-15 11:40:49.458079 | PLAY RECAP
2026-09-15 11:40:49.458165 | aio | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-15 11:40:49.458211 | 
2026-09-15 11:40:49.666440 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-15 11:40:49.669923 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-15 11:40:50.251689 | 
2026-09-15 11:40:50.251880 | PLAY [all]
2026-09-15 11:40:50.264093 | 
2026-09-15 11:40:50.264205 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-15 11:40:50.328149 | aio | skipping: Conditional result was False
2026-09-15 11:40:50.336370 | 
2026-09-15 11:40:50.336484 | TASK [fetch-output : Set log path for single node]
2026-09-15 11:40:50.389556 | aio | ok
2026-09-15 11:40:50.396347 | 
2026-09-15 11:40:50.396465 | LOOP [fetch-output : Ensure local output dirs]
2026-09-15 11:40:50.842064 | aio -> localhost | ok: "/var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/logs"
2026-09-15 11:40:51.134197 | aio -> localhost | changed: "/var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/artifacts"
2026-09-15 11:40:51.364304 | aio -> localhost | changed: "/var/lib/zuul/builds/dc6489b94be54614bec6c24f38658a10/work/docs"
2026-09-15 11:40:51.382812 | 
2026-09-15 11:40:51.383037 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-15 11:40:52.099930 | aio | changed: .d..t...... ./
2026-09-15 11:40:52.100188 | aio | changed: All items complete
2026-09-15 11:40:52.100227 | 
2026-09-15 11:40:52.645934 | aio | changed: .d..t...... ./
2026-09-15 11:40:53.186525 | aio | changed: .d..t...... ./
2026-09-15 11:40:53.214541 | 
2026-09-15 11:40:53.214702 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-15 11:40:53.617697 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.005793
2026-09-15 11:40:53.867103 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.005728
2026-09-15 11:40:53.894997 | 
2026-09-15 11:40:53.895147 | PLAY [all]
2026-09-15 11:40:53.908390 | 
2026-09-15 11:40:53.908556 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-15 11:40:54.397624 | aio | changed
2026-09-15 11:40:54.404383 | 
2026-09-15 11:40:54.404483 | PLAY RECAP
2026-09-15 11:40:54.404556 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-15 11:40:54.404577 | 
2026-09-15 11:40:54.551599 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-15 11:40:54.555161 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-15 11:40:55.270384 | 
2026-09-15 11:40:55.270538 | PLAY [localhost]
2026-09-15 11:40:55.280443 | 
2026-09-15 11:40:55.280540 | TASK [Generate Zuul manifest]
2026-09-15 11:40:55.297924 | localhost | ok
2026-09-15 11:40:55.311238 | 
2026-09-15 11:40:55.311333 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-15 11:40:55.712541 | localhost | changed
2026-09-15 11:40:55.726308 | 
2026-09-15 11:40:55.726490 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-15 11:40:55.766551 | localhost | ok
2026-09-15 11:40:55.775571 | 
2026-09-15 11:40:55.775690 | TASK [Upload logs]
2026-09-15 11:40:55.795630 | localhost | ok
2026-09-15 11:40:55.858662 | 
2026-09-15 11:40:55.858812 | TASK [Set zuul-log-path fact]
2026-09-15 11:40:55.875876 | localhost | ok
2026-09-15 11:40:55.886936 | 
2026-09-15 11:40:55.887041 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-15 11:40:55.926317 | localhost | ok
2026-09-15 11:40:55.937037 | 
2026-09-15 11:40:55.937144 | TASK [upload-logs : Create log directories]
2026-09-15 11:40:56.384046 | localhost | changed
2026-09-15 11:40:56.389941 | 
2026-09-15 11:40:56.390048 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-15 11:40:56.791722 | localhost -> localhost | ok: Runtime: 0:00:00.005601
2026-09-15 11:40:56.802688 | 
2026-09-15 11:40:56.802916 | TASK [upload-logs : Upload logs to log server]
2026-09-15 11:40:57.291339 | localhost | Output suppressed because no_log was given
2026-09-15 11:40:57.296512 | 
2026-09-15 11:40:57.296672 | LOOP [upload-logs : Compress console log and json output]
2026-09-15 11:40:57.354157 | localhost | skipping: Conditional result was False
2026-09-15 11:40:57.401769 | localhost | skipping: Conditional result was False
2026-09-15 11:40:57.412532 | 
2026-09-15 11:40:57.412726 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-15 11:40:57.447363 | localhost | skipping: Conditional result was False
2026-09-15 11:40:57.447856 | 
2026-09-15 11:40:57.450995 | localhost | skipping: Conditional result was False
2026-09-15 11:40:57.464037 | 
2026-09-15 11:40:57.464200 | LOOP [upload-logs : Upload console log and json output]