2026-08-26 20:52:36.485535 | Job console starting 2026-08-26 20:52:36.496248 | Updating git repos 2026-08-26 20:52:36.520597 | Cloning repos into workspace 2026-08-26 20:52:36.567850 | Restoring repo states 2026-08-26 20:52:36.576810 | Merging changes 2026-08-26 20:52:36.960189 | Checking out repos 2026-08-26 20:52:36.992427 | Preparing playbooks 2026-08-26 20:52:37.959089 | Running Ansible setup 2026-08-26 20:52:41.906734 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 20:52:42.505764 | 2026-08-26 20:52:42.505894 | PLAY [localhost] 2026-08-26 20:52:42.513724 | 2026-08-26 20:52:42.513794 | TASK [Gathering Facts] 2026-08-26 20:52:43.362820 | localhost | ok 2026-08-26 20:52:43.373791 | 2026-08-26 20:52:43.373873 | TASK [Setup log path fact] 2026-08-26 20:52:43.394515 | localhost | ok 2026-08-26 20:52:43.407778 | 2026-08-26 20:52:43.407846 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 20:52:43.438314 | localhost | ok 2026-08-26 20:52:43.446961 | 2026-08-26 20:52:43.447054 | TASK [emit-job-header : Print job information] 2026-08-26 20:52:43.489300 | # Job Information 2026-08-26 20:52:43.489512 | Ansible Version: 2.16.18 2026-08-26 20:52:43.489583 | Job: ansible-collection-ceph-molecule-aio-ubuntu-noble 2026-08-26 20:52:43.489632 | Pipeline: check 2026-08-26 20:52:43.489677 | Executor: 2d72f0692154 2026-08-26 20:52:43.489721 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/116 2026-08-26 20:52:43.489771 | Event ID: 6fcc1630-a18e-11f1-934f-9f0631f6bf76 2026-08-26 20:52:43.494725 | 2026-08-26 20:52:43.494824 | LOOP [emit-job-header : Print node information] 2026-08-26 20:52:43.597814 | localhost | ok: 2026-08-26 20:52:43.598103 | localhost | # Node Information 2026-08-26 20:52:43.598145 | localhost | Inventory Hostname: aio 2026-08-26 20:52:43.598175 | localhost | Hostname: np0000191306 2026-08-26 20:52:43.598204 | localhost | Username: zuul 2026-08-26 20:52:43.598237 | localhost | Distro: Ubuntu 24.04 2026-08-26 20:52:43.598265 | localhost | Provider: yul1 2026-08-26 20:52:43.598292 | localhost | Region: ca-ymq-1 2026-08-26 20:52:43.598318 | localhost | Label: ubuntu-noble 2026-08-26 20:52:43.598344 | localhost | Product Name: OpenStack Nova 2026-08-26 20:52:43.598370 | localhost | Interface IP: 162.253.55.24 2026-08-26 20:52:43.613519 | 2026-08-26 20:52:43.613631 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 20:52:44.002052 | localhost -> localhost | changed 2026-08-26 20:52:44.007602 | 2026-08-26 20:52:44.007672 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 20:52:44.801879 | localhost -> localhost | changed 2026-08-26 20:52:44.813353 | 2026-08-26 20:52:44.813432 | PLAY [all] 2026-08-26 20:52:44.822707 | 2026-08-26 20:52:44.822771 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 20:52:45.050026 | aio -> localhost | ok 2026-08-26 20:52:45.056475 | 2026-08-26 20:52:45.056543 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 20:52:45.092863 | aio | ok 2026-08-26 20:52:45.108426 | aio | included: /var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 20:52:45.114579 | 2026-08-26 20:52:45.114639 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 20:52:45.951990 | aio -> localhost | Generating public/private rsa key pair. 2026-08-26 20:52:45.952180 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/2264985393954e5f8a2bbaae873c8908_id_rsa 2026-08-26 20:52:45.952211 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/2264985393954e5f8a2bbaae873c8908_id_rsa.pub 2026-08-26 20:52:45.952233 | aio -> localhost | The key fingerprint is: 2026-08-26 20:52:45.952254 | aio -> localhost | SHA256:QDy87rzzvLnestZ/GflzWaLL3Xgl3CjOY0GXWcDU/yU zuul-build-sshkey 2026-08-26 20:52:45.952283 | aio -> localhost | The key's randomart image is: 2026-08-26 20:52:45.952304 | aio -> localhost | +---[RSA 3072]----+ 2026-08-26 20:52:45.952333 | aio -> localhost | | o. ooo | 2026-08-26 20:52:45.952354 | aio -> localhost | | .+ . o| 2026-08-26 20:52:45.952374 | aio -> localhost | | .o +.| 2026-08-26 20:52:45.952393 | aio -> localhost | | .. . E o| 2026-08-26 20:52:45.952427 | aio -> localhost | | . S . o =o| 2026-08-26 20:52:45.952452 | aio -> localhost | | . o B =| 2026-08-26 20:52:45.952472 | aio -> localhost | | o . o + *+| 2026-08-26 20:52:45.952492 | aio -> localhost | | +.oo..*.o=+| 2026-08-26 20:52:45.952515 | aio -> localhost | | .*O=.o++o.+| 2026-08-26 20:52:45.952535 | aio -> localhost | +----[SHA256]-----+ 2026-08-26 20:52:45.952590 | aio -> localhost | ok: Runtime: 0:00:00.424136 2026-08-26 20:52:45.958918 | 2026-08-26 20:52:45.958989 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 20:52:45.993944 | aio | ok 2026-08-26 20:52:46.003080 | aio | included: /var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 20:52:46.011018 | 2026-08-26 20:52:46.011079 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 20:52:46.037008 | aio | skipping: Conditional result was False 2026-08-26 20:52:46.047127 | 2026-08-26 20:52:46.047226 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 20:52:46.613514 | aio | changed 2026-08-26 20:52:46.618933 | 2026-08-26 20:52:46.618997 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 20:52:46.866068 | aio | ok 2026-08-26 20:52:46.873643 | 2026-08-26 20:52:46.873730 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 20:52:47.475207 | aio | changed 2026-08-26 20:52:47.483818 | 2026-08-26 20:52:47.483987 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 20:52:48.072804 | aio | changed 2026-08-26 20:52:48.078306 | 2026-08-26 20:52:48.078369 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 20:52:48.103498 | aio | skipping: Conditional result was False 2026-08-26 20:52:48.114537 | 2026-08-26 20:52:48.114638 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 20:52:48.484509 | aio -> localhost | changed 2026-08-26 20:52:48.503544 | 2026-08-26 20:52:48.503641 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 20:52:48.803579 | aio -> localhost | Identity added: /var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/2264985393954e5f8a2bbaae873c8908_id_rsa (zuul-build-sshkey) 2026-08-26 20:52:48.803822 | aio -> localhost | ok: Runtime: 0:00:00.015594 2026-08-26 20:52:48.811466 | 2026-08-26 20:52:48.811528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 20:52:49.190960 | aio | ok 2026-08-26 20:52:49.198795 | 2026-08-26 20:52:49.198860 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 20:52:49.226504 | aio | skipping: Conditional result was False 2026-08-26 20:52:49.244579 | 2026-08-26 20:52:49.244674 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 20:52:49.701793 | aio | ok 2026-08-26 20:52:49.708394 | 2026-08-26 20:52:49.708459 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 20:52:50.533024 | aio | Output suppressed because no_log was given 2026-08-26 20:52:50.548414 | 2026-08-26 20:52:50.548487 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 20:52:50.798219 | aio | ok: "logs" 2026-08-26 20:52:50.798556 | aio | ok: All items complete 2026-08-26 20:52:50.798616 | 2026-08-26 20:52:51.028754 | aio | ok: "artifacts" 2026-08-26 20:52:51.233127 | aio | ok: "docs" 2026-08-26 20:52:51.252354 | 2026-08-26 20:52:51.252510 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 20:52:51.495158 | aio | changed: "logs" 2026-08-26 20:52:51.690114 | aio | changed: "artifacts" 2026-08-26 20:52:51.885992 | aio | changed: "docs" 2026-08-26 20:52:51.905200 | 2026-08-26 20:52:51.905712 | PLAY RECAP 2026-08-26 20:52:51.905783 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 20:52:51.905823 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:52:51.905857 | 2026-08-26 20:52:52.067078 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 20:52:52.069296 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 20:52:52.690215 | 2026-08-26 20:52:52.690409 | PLAY [all] 2026-08-26 20:52:52.703478 | 2026-08-26 20:52:52.703572 | TASK [setup-uv : Extract archive] 2026-08-26 20:52:55.306194 | aio | changed 2026-08-26 20:52:55.312752 | 2026-08-26 20:52:55.312842 | TASK [setup-uv : Print version] 2026-08-26 20:52:55.757035 | aio | uv 0.8.13 2026-08-26 20:52:55.853244 | aio | ok: Runtime: 0:00:00.018334 2026-08-26 20:52:55.868649 | 2026-08-26 20:52:55.868823 | TASK [Install Ansible collection siblings] 2026-08-26 20:52:56.293607 | aio | ok: 2026-08-26 20:52:56.293839 | aio | Skipping community.general: no checked-out sibling 2026-08-26 20:52:56.293879 | aio | Skipping ansible.utils: no checked-out sibling 2026-08-26 20:52:56.293909 | aio | Skipping vexxhost.containers: no checked-out sibling 2026-08-26 20:52:56.296225 | 2026-08-26 20:52:56.296287 | PLAY RECAP 2026-08-26 20:52:56.296348 | aio | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:52:56.296377 | 2026-08-26 20:52:56.439272 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 20:52:56.441166 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 20:52:57.107595 | 2026-08-26 20:52:57.107743 | PLAY [all] 2026-08-26 20:52:57.124276 | 2026-08-26 20:52:57.124445 | LOOP [Check inventory directories] 2026-08-26 20:52:57.531455 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph" 2026-08-26 20:52:57.719224 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory" 2026-08-26 20:52:57.893766 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory" 2026-08-26 20:52:57.913819 | 2026-08-26 20:52:57.914085 | LOOP [Copy inventory file for Zuul] 2026-08-26 20:52:58.913492 | aio | changed: 2026-08-26 20:52:58.913701 | aio | { 2026-08-26 20:52:58.913728 | aio | "ansible_loop_var": "item", 2026-08-26 20:52:58.913751 | aio | "changed": false, 2026-08-26 20:52:58.913771 | aio | "failed": false, 2026-08-26 20:52:58.913793 | aio | "invocation": { 2026-08-26 20:52:58.913811 | aio | "module_args": { 2026-08-26 20:52:58.913829 | aio | "checksum_algorithm": "sha1", 2026-08-26 20:52:58.913846 | aio | "follow": true, 2026-08-26 20:52:58.913863 | aio | "get_attributes": true, 2026-08-26 20:52:58.913882 | aio | "get_checksum": true, 2026-08-26 20:52:58.913900 | aio | "get_mime": true, 2026-08-26 20:52:58.913918 | aio | "path": "src/github.com/vexxhost/ansible-collection-ceph" 2026-08-26 20:52:58.913936 | aio | } 2026-08-26 20:52:58.913954 | aio | }, 2026-08-26 20:52:58.913971 | aio | "item": "src/github.com/vexxhost/ansible-collection-ceph", 2026-08-26 20:52:58.913988 | aio | "stat": { 2026-08-26 20:52:58.914005 | aio | "atime": 1787777570.4124367, 2026-08-26 20:52:58.914022 | aio | "attr_flags": "e", 2026-08-26 20:52:58.914040 | aio | "attributes": [ 2026-08-26 20:52:58.914057 | aio | "extents" 2026-08-26 20:52:58.914073 | aio | ], 2026-08-26 20:52:58.914090 | aio | "block_size": 4096, 2026-08-26 20:52:58.914107 | aio | "blocks": 8, 2026-08-26 20:52:58.914123 | aio | "charset": "unknown", 2026-08-26 20:52:58.914142 | aio | "ctime": 1787777570.432437, 2026-08-26 20:52:58.914159 | aio | "dev": 64769, 2026-08-26 20:52:58.914192 | aio | "device_type": 0, 2026-08-26 20:52:58.914210 | aio | "executable": true, 2026-08-26 20:52:58.914227 | aio | "exists": true, 2026-08-26 20:52:58.914244 | aio | "gid": 1000, 2026-08-26 20:52:58.914260 | aio | "gr_name": "zuul", 2026-08-26 20:52:58.914277 | aio | "inode": 1034272, 2026-08-26 20:52:58.914293 | aio | "isblk": false, 2026-08-26 20:52:58.914311 | aio | "ischr": false, 2026-08-26 20:52:58.914328 | aio | "isdir": true, 2026-08-26 20:52:58.914345 | aio | "isfifo": false, 2026-08-26 20:52:58.914362 | aio | "isgid": false, 2026-08-26 20:52:58.914379 | aio | "islnk": false, 2026-08-26 20:52:58.914395 | aio | "isreg": false, 2026-08-26 20:52:58.914411 | aio | "issock": false, 2026-08-26 20:52:58.914427 | aio | "isuid": false, 2026-08-26 20:52:58.914444 | aio | "mimetype": "unknown", 2026-08-26 20:52:58.914460 | aio | "mode": "0755", 2026-08-26 20:52:58.914476 | aio | "mtime": 1787777556.592084, 2026-08-26 20:52:58.914493 | aio | "nlink": 10, 2026-08-26 20:52:58.914509 | aio | "path": "src/github.com/vexxhost/ansible-collection-ceph", 2026-08-26 20:52:58.914526 | aio | "pw_name": "zuul", 2026-08-26 20:52:58.914547 | aio | "readable": true, 2026-08-26 20:52:58.914564 | aio | "rgrp": true, 2026-08-26 20:52:58.914581 | aio | "roth": true, 2026-08-26 20:52:58.914598 | aio | "rusr": true, 2026-08-26 20:52:58.914614 | aio | "size": 4096, 2026-08-26 20:52:58.914631 | aio | "uid": 1000, 2026-08-26 20:52:58.914648 | aio | "version": "2517320609", 2026-08-26 20:52:58.914665 | aio | "wgrp": false, 2026-08-26 20:52:58.914683 | aio | "woth": false, 2026-08-26 20:52:58.914701 | aio | "writeable": true, 2026-08-26 20:52:58.914718 | aio | "wusr": true, 2026-08-26 20:52:58.914735 | aio | "xgrp": true, 2026-08-26 20:52:58.914752 | aio | "xoth": true, 2026-08-26 20:52:58.914769 | aio | "xusr": true 2026-08-26 20:52:58.914786 | aio | } 2026-08-26 20:52:58.914803 | aio | } 2026-08-26 20:52:58.914840 | aio | ok: All items complete 2026-08-26 20:52:58.914861 | 2026-08-26 20:52:58.916283 | aio | skipping: Conditional result was False 2026-08-26 20:52:58.917101 | aio | skipping: Conditional result was False 2026-08-26 20:52:58.928114 | 2026-08-26 20:52:58.928281 | LOOP [Switch "ansible_host" to private IP] 2026-08-26 20:52:59.373396 | aio | changed: 1 replacements made 2026-08-26 20:52:59.375043 | aio | skipping: Conditional result was False 2026-08-26 20:52:59.375837 | aio | skipping: Conditional result was False 2026-08-26 20:52:59.400230 | 2026-08-26 20:52:59.400401 | TASK [Run Molecule scenario] 2026-08-26 20:52:59.905219 | aio | Using CPython 3.12.3 interpreter at: /usr/bin/python3 2026-08-26 20:52:59.905349 | aio | Creating virtual environment at: .venv 2026-08-26 20:53:02.810922 | aio | Downloading cryptography (4.3MiB) 2026-08-26 20:53:02.813558 | aio | Downloading netaddr (2.2MiB) 2026-08-26 20:53:02.813768 | aio | Downloading ansible-core (2.1MiB) 2026-08-26 20:53:02.814270 | aio | Downloading pygments (1.2MiB) 2026-08-26 20:53:03.025356 | aio | Downloading netaddr 2026-08-26 20:53:03.036498 | aio | Downloading cryptography 2026-08-26 20:53:03.091895 | aio | Downloading pygments 2026-08-26 20:53:03.256804 | aio | Downloading ansible-core 2026-08-26 20:53:03.302320 | aio | Installed 37 packages in 44ms 2026-08-26 20:53:04.064806 | aio | INFO Collection 'vexxhost.ceph' detected. 2026-08-26 20:53:04.064892 | aio | INFO Scenarios will be used from 'extensions/molecule' 2026-08-26 20:53:04.728476 | aio | INFO [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-26 20:53:04.728549 | aio | INFO [default > prerun] Performing prerun with role_name_check=0... 2026-08-26 20:54:17.330356 | aio | WARNING Retrying execution failure 1 of: ansible-galaxy collection install -vvv ansible.utils:>=6.0.0 2026-08-26 20:54:17.330426 | aio | ERROR Command ansible-galaxy collection install -vvv ansible.utils:>=6.0.0, returned 1 code: 2026-08-26 20:54:17.330433 | aio | Starting galaxy collection install process 2026-08-26 20:54:17.330438 | aio | Process install dependency map 2026-08-26 20:54:17.330444 | aio | Starting collection install process 2026-08-26 20:54:17.330455 | aio | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-utils-6.1.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1150e69mztb0/tmpro2xnmpx/ansible-utils-6.1.0-swjeg2uq 2026-08-26 20:54:17.330464 | aio | 2026-08-26 20:54:17.330469 | aio | ansible-galaxy 2026-08-26 20:54:17.330474 | aio | config file = None 2026-08-26 20:54:17.330479 | aio | configured module search path = 2026-08-26 20:54:17.330484 | aio | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible 2026-08-26 20:54:17.330493 | 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-08-26 20:54:17.330502 | aio | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy 2026-08-26 20:54:17.330507 | aio | python version = 3.12.3 (main, Jun 19 2026, 12:46:00) (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python) 2026-08-26 20:54:17.330512 | aio | jinja version = 3.1.6 2026-08-26 20:54:17.330517 | aio | libyaml = True 2026-08-26 20:54:17.330523 | aio | No config file found; using defaults 2026-08-26 20:54:17.330531 | 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-26 20:54:17.330537 | aio | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 20:54:17.330542 | aio | Opened /home/zuul/.ansible/galaxy_token 2026-08-26 20:54:17.330548 | aio | ERROR! Failed to download collection tar from 'default' due to the following unforeseen error: . 2026-08-26 20:54:17.330554 | aio | 2026-08-26 20:54:17.330978 | aio | Traceback (most recent call last): 2026-08-26 20:54:17.331348 | aio | File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in 2026-08-26 20:54:17.331815 | aio | sys.exit(main()) 2026-08-26 20:54:17.332150 | aio | ^^^^^^ 2026-08-26 20:54:17.332453 | 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-08-26 20:54:17.333249 | aio | return self.main(*args, **kwargs) 2026-08-26 20:54:17.333561 | aio | ^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.333798 | 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-08-26 20:54:17.334601 | aio | rv = self.invoke(ctx) 2026-08-26 20:54:17.334869 | aio | ^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.335143 | 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-08-26 20:54:17.336028 | aio | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-08-26 20:54:17.336395 | aio | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.336627 | 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-08-26 20:54:17.337343 | aio | return ctx.invoke(self.callback, **ctx.params) 2026-08-26 20:54:17.337638 | aio | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.337871 | 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-08-26 20:54:17.338465 | aio | return callback(*args, **kwargs) 2026-08-26 20:54:17.338739 | aio | ^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.338974 | 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-08-26 20:54:17.339528 | aio | return func(*args, **kwargs) 2026-08-26 20:54:17.339794 | aio | ^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.340026 | 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-08-26 20:54:17.340417 | aio | return f(get_current_context(), *args, **kwargs) 2026-08-26 20:54:17.340710 | aio | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-26 20:54:17.340946 | 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-08-26 20:54:17.341448 | aio | return func(ctx) 2026-08-26 20:54:17.341698 | aio | ^^^^^^^^^ 2026-08-26 20:54:17.341937 | 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-08-26 20:54:17.342363 | aio | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-08-26 20:54:17.342660 | 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-08-26 20:54:17.343059 | aio | _run_scenarios(scenarios, command_args, default_config) 2026-08-26 20:54:17.343418 | 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-08-26 20:54:17.343819 | aio | scenario.config.runtime.prepare_environment( 2026-08-26 20:54:17.344066 | 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-08-26 20:54:17.344638 | aio | self.install_collection( 2026-08-26 20:54:17.344867 | 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-08-26 20:54:17.345393 | aio | raise InvalidPrerequisiteError(msg) 2026-08-26 20:54:17.346764 | aio | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv ansible.utils:>=6.0.0, returned 1 code: 2026-08-26 20:54:17.346779 | aio | Starting galaxy collection install process 2026-08-26 20:54:17.346800 | aio | Process install dependency map 2026-08-26 20:54:17.346817 | aio | Starting collection install process 2026-08-26 20:54:17.346825 | aio | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-utils-6.1.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1150e69mztb0/tmpro2xnmpx/ansible-utils-6.1.0-swjeg2uq 2026-08-26 20:54:17.346833 | aio | 2026-08-26 20:54:17.346841 | aio | ansible-galaxy [core 2.18.6] 2026-08-26 20:54:17.346849 | aio | config file = None 2026-08-26 20:54:17.346857 | 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-26 20:54:17.346865 | aio | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible 2026-08-26 20:54:17.346875 | 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-08-26 20:54:17.346885 | aio | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy 2026-08-26 20:54:17.346893 | aio | python version = 3.12.3 (main, Jun 19 2026, 12:46:00) [GCC 13.3.0] (/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/python) 2026-08-26 20:54:17.346903 | aio | jinja version = 3.1.6 2026-08-26 20:54:17.346911 | aio | libyaml = True 2026-08-26 20:54:17.346918 | aio | No config file found; using defaults 2026-08-26 20:54:17.346926 | 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-26 20:54:17.346934 | aio | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 20:54:17.346942 | aio | Opened /home/zuul/.ansible/galaxy_token 2026-08-26 20:54:17.346951 | aio | ERROR! Failed to download collection tar from 'default' due to the following unforeseen error: . 2026-08-26 20:54:17.346963 | aio | 2026-08-26 20:54:17.495233 | aio | ERROR 2026-08-26 20:54:17.495699 | aio | { 2026-08-26 20:54:17.495732 | aio | "delta": "0:01:17.626890", 2026-08-26 20:54:17.495754 | aio | "end": "2026-08-26 20:54:17.423584", 2026-08-26 20:54:17.495773 | aio | "msg": "non-zero return code", 2026-08-26 20:54:17.495792 | aio | "rc": 1, 2026-08-26 20:54:17.495810 | aio | "start": "2026-08-26 20:52:59.796694" 2026-08-26 20:54:17.495828 | aio | } failure 2026-08-26 20:54:17.498692 | 2026-08-26 20:54:17.498744 | PLAY RECAP 2026-08-26 20:54:17.498794 | aio | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 20:54:17.498816 | 2026-08-26 20:54:17.634750 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 20:54:17.638133 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 20:54:18.220882 | 2026-08-26 20:54:18.411871 | PLAY [all] 2026-08-26 20:54:18.429188 | 2026-08-26 20:54:18.429273 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 20:54:18.504345 | aio | skipping: Conditional result was False 2026-08-26 20:54:18.514512 | 2026-08-26 20:54:18.514591 | TASK [fetch-output : Set log path for single node] 2026-08-26 20:54:18.558170 | aio | ok 2026-08-26 20:54:18.563866 | 2026-08-26 20:54:18.563935 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 20:54:19.019398 | aio -> localhost | ok: "/var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/logs" 2026-08-26 20:54:19.219960 | aio -> localhost | changed: "/var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/artifacts" 2026-08-26 20:54:19.419612 | aio -> localhost | changed: "/var/lib/zuul/builds/2264985393954e5f8a2bbaae873c8908/work/docs" 2026-08-26 20:54:19.438234 | 2026-08-26 20:54:19.438711 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 20:54:20.156288 | aio | ok 2026-08-26 20:54:20.156509 | aio | changed: All items complete 2026-08-26 20:54:20.156538 | 2026-08-26 20:54:20.693441 | aio | changed: .d..t...... ./ 2026-08-26 20:54:21.225778 | aio | changed: .d..t...... ./ 2026-08-26 20:54:21.248945 | 2026-08-26 20:54:21.250520 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 20:54:21.835564 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.007185 2026-08-26 20:54:22.078379 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.007653 2026-08-26 20:54:22.103136 | 2026-08-26 20:54:22.103256 | PLAY [all] 2026-08-26 20:54:22.120923 | 2026-08-26 20:54:22.121153 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 20:54:22.714250 | aio | changed 2026-08-26 20:54:22.724085 | 2026-08-26 20:54:22.724174 | PLAY RECAP 2026-08-26 20:54:22.724227 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 20:54:22.724250 | 2026-08-26 20:54:22.917191 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 20:54:22.918999 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 20:54:23.540625 | 2026-08-26 20:54:23.733327 | PLAY [localhost] 2026-08-26 20:54:23.750133 | 2026-08-26 20:54:23.750223 | TASK [Generate Zuul manifest] 2026-08-26 20:54:23.771379 | localhost | ok 2026-08-26 20:54:23.787658 | 2026-08-26 20:54:23.787737 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 20:54:24.153273 | localhost | changed 2026-08-26 20:54:24.167153 | 2026-08-26 20:54:24.167229 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 20:54:24.208630 | localhost | ok 2026-08-26 20:54:24.621756 | 2026-08-26 20:54:24.621851 | TASK [Upload logs] 2026-08-26 20:54:24.647739 | localhost | ok 2026-08-26 20:54:24.708997 | 2026-08-26 20:54:24.709113 | TASK [Set zuul-log-path fact] 2026-08-26 20:54:24.731858 | localhost | ok 2026-08-26 20:54:24.745728 | 2026-08-26 20:54:24.745795 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 20:54:24.778592 | localhost | ok 2026-08-26 20:54:24.786449 | 2026-08-26 20:54:24.786513 | TASK [upload-logs : Create log directories] 2026-08-26 20:54:25.213642 | localhost | changed 2026-08-26 20:54:25.220288 | 2026-08-26 20:54:25.220360 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 20:54:25.618371 | localhost -> localhost | ok: Runtime: 0:00:00.005970 2026-08-26 20:54:25.623842 | 2026-08-26 20:54:25.623908 | TASK [upload-logs : Upload logs to log server] 2026-08-26 20:54:26.123119 | localhost | Output suppressed because no_log was given 2026-08-26 20:54:26.127752 | 2026-08-26 20:54:26.127912 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 20:54:26.177842 | localhost | skipping: Conditional result was False 2026-08-26 20:54:26.228334 | localhost | skipping: Conditional result was False 2026-08-26 20:54:26.247094 | 2026-08-26 20:54:26.247306 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 20:54:26.290919 | localhost | skipping: Conditional result was False 2026-08-26 20:54:26.291324 | 2026-08-26 20:54:26.295105 | localhost | skipping: Conditional result was False 2026-08-26 20:54:26.312528 | 2026-08-26 20:54:26.312746 | LOOP [upload-logs : Upload console log and json output]