2026-08-26 20:45:42.102475 | Job console starting
2026-08-26 20:45:42.116670 | Updating git repos
2026-08-26 20:45:42.145183 | Cloning repos into workspace
2026-08-26 20:45:42.248626 | Restoring repo states
2026-08-26 20:45:42.261730 | Merging changes
2026-08-26 20:45:43.345085 | Checking out repos
2026-08-26 20:45:43.657621 | Preparing playbooks
2026-08-26 20:45:48.651114 | Running Ansible setup
2026-08-26 20:45:56.695546 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:45:57.441259 | 
2026-08-26 20:45:57.441432 | PLAY [localhost]
2026-08-26 20:45:57.449888 | 
2026-08-26 20:45:57.449971 | TASK [Gathering Facts]
2026-08-26 20:45:58.403451 | localhost | ok
2026-08-26 20:45:58.415437 | 
2026-08-26 20:45:58.415518 | TASK [Setup log path fact]
2026-08-26 20:45:58.439308 | localhost | ok
2026-08-26 20:45:58.450184 | 
2026-08-26 20:45:58.450252 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 20:45:58.483650 | localhost | ok
2026-08-26 20:45:58.492165 | 
2026-08-26 20:45:58.492245 | TASK [emit-job-header : Print job information]
2026-08-26 20:45:58.535511 | # Job Information
2026-08-26 20:45:58.535840 | Ansible Version: 2.16.18
2026-08-26 20:45:58.535898 | Job: ansible-collection-ceph-molecule-ha-ubuntu-noble
2026-08-26 20:45:58.535930 | Pipeline: check
2026-08-26 20:45:58.535958 | Executor: 2d72f0692154
2026-08-26 20:45:58.535986 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/118
2026-08-26 20:45:58.536017 | Event ID: 6b24ae30-a18e-11f1-9c41-ecc345c57c50
2026-08-26 20:45:58.540027 | 
2026-08-26 20:45:58.540121 | LOOP [emit-job-header : Print node information]
2026-08-26 20:45:58.638387 | localhost | ok:
2026-08-26 20:45:58.638634 | localhost | # Node Information
2026-08-26 20:45:58.638665 | localhost | Inventory Hostname: mon1
2026-08-26 20:45:58.638686 | localhost | Hostname: np0000191281
2026-08-26 20:45:58.638707 | localhost | Username: zuul
2026-08-26 20:45:58.638737 | localhost | Distro: Ubuntu 24.04
2026-08-26 20:45:58.638758 | localhost | Provider: yul1
2026-08-26 20:45:58.638778 | localhost | Region: ca-ymq-1
2026-08-26 20:45:58.638802 | localhost | Label: ubuntu-noble
2026-08-26 20:45:58.638826 | localhost | Product Name: OpenStack Nova
2026-08-26 20:45:58.638852 | localhost | Interface IP: 162.253.55.10
2026-08-26 20:45:58.687427 | localhost | ok:
2026-08-26 20:45:58.687550 | localhost | # Node Information
2026-08-26 20:45:58.687577 | localhost | Inventory Hostname: osd1
2026-08-26 20:45:58.687612 | localhost | Hostname: np0000191282
2026-08-26 20:45:58.687632 | localhost | Username: zuul
2026-08-26 20:45:58.687651 | localhost | Distro: Ubuntu 24.04
2026-08-26 20:45:58.687669 | localhost | Provider: yul1
2026-08-26 20:45:58.687688 | localhost | Region: ca-ymq-1
2026-08-26 20:45:58.687706 | localhost | Label: ubuntu-noble
2026-08-26 20:45:58.687724 | localhost | Product Name: OpenStack Nova
2026-08-26 20:45:58.687742 | localhost | Interface IP: 162.253.55.191
2026-08-26 20:45:58.704041 | 
2026-08-26 20:45:58.704209 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-26 20:45:59.247461 | localhost -> localhost | changed
2026-08-26 20:45:59.255350 | 
2026-08-26 20:45:59.255703 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-26 20:46:00.204136 | localhost -> localhost | changed
2026-08-26 20:46:00.209619 | 
2026-08-26 20:46:00.209668 | PLAY [all]
2026-08-26 20:46:00.218001 | 
2026-08-26 20:46:00.218064 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-26 20:46:00.484897 | mon1 -> localhost | ok
2026-08-26 20:46:00.493267 | 
2026-08-26 20:46:00.493333 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-26 20:46:00.524942 | mon1 | ok
2026-08-26 20:46:00.529656 | osd1 | ok
2026-08-26 20:46:00.548691 | mon1 | included: /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:46:00.548744 | osd1 | included: /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:46:00.555438 | 
2026-08-26 20:46:00.555498 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-26 20:46:01.556034 | mon1 -> localhost | Generating public/private rsa key pair.
2026-08-26 20:46:01.556399 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/4c4e1fd399a34ee98dce71f7ec3d49f3_id_rsa
2026-08-26 20:46:01.556469 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/4c4e1fd399a34ee98dce71f7ec3d49f3_id_rsa.pub
2026-08-26 20:46:01.556521 | mon1 -> localhost | The key fingerprint is:
2026-08-26 20:46:01.556570 | mon1 -> localhost | SHA256:2dc/BFsX63W0LBJZtG/nX15L2D54umgZmrgE/25NNJ8 zuul-build-sshkey
2026-08-26 20:46:01.556619 | mon1 -> localhost | The key's randomart image is:
2026-08-26 20:46:01.556665 | mon1 -> localhost | +---[RSA 3072]----+
2026-08-26 20:46:01.556711 | mon1 -> localhost | |           .+o ..|
2026-08-26 20:46:01.556757 | mon1 -> localhost | |           .. o.+|
2026-08-26 20:46:01.556802 | mon1 -> localhost | |           . + =+|
2026-08-26 20:46:01.556847 | mon1 -> localhost | |         o o..B +|
2026-08-26 20:46:01.556892 | mon1 -> localhost | |     .  S o +.o=.|
2026-08-26 20:46:01.556935 | mon1 -> localhost | |      o    + E=o.|
2026-08-26 20:46:01.557021 | mon1 -> localhost | |       o. = o..+=|
2026-08-26 20:46:01.557084 | mon1 -> localhost | |      ...+ +..o+*|
2026-08-26 20:46:01.557150 | mon1 -> localhost | |       .+o.. o+o+|
2026-08-26 20:46:01.557209 | mon1 -> localhost | +----[SHA256]-----+
2026-08-26 20:46:01.557346 | mon1 -> localhost | ok: Runtime: 0:00:00.567815
2026-08-26 20:46:01.567736 | 
2026-08-26 20:46:01.567820 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-26 20:46:01.605632 | mon1 | ok
2026-08-26 20:46:01.612289 | osd1 | ok
2026-08-26 20:46:01.625922 | mon1 | included: /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:46:01.625970 | osd1 | included: /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:46:01.637065 | 
2026-08-26 20:46:01.637131 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-26 20:46:01.663436 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:01.664173 | osd1 | skipping: Conditional result was False
2026-08-26 20:46:01.670097 | 
2026-08-26 20:46:01.670175 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-26 20:46:02.222419 | mon1 | changed
2026-08-26 20:46:02.228501 | osd1 | changed
2026-08-26 20:46:02.233970 | 
2026-08-26 20:46:02.234037 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-26 20:46:02.487163 | mon1 | ok
2026-08-26 20:46:02.507285 | osd1 | ok
2026-08-26 20:46:02.513231 | 
2026-08-26 20:46:02.513299 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-26 20:46:03.081987 | mon1 | changed
2026-08-26 20:46:03.193968 | osd1 | changed
2026-08-26 20:46:03.201685 | 
2026-08-26 20:46:03.201831 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-26 20:46:03.831862 | osd1 | changed
2026-08-26 20:46:04.217049 | mon1 | changed
2026-08-26 20:46:04.224359 | 
2026-08-26 20:46:04.224428 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-26 20:46:04.255176 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:04.266906 | osd1 | skipping: Conditional result was False
2026-08-26 20:46:04.275875 | 
2026-08-26 20:46:04.275970 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-26 20:46:04.606587 | mon1 -> localhost | changed
2026-08-26 20:46:04.628147 | 
2026-08-26 20:46:04.628217 | TASK [add-build-sshkey : Add back temp key]
2026-08-26 20:46:04.938906 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/4c4e1fd399a34ee98dce71f7ec3d49f3_id_rsa (zuul-build-sshkey)
2026-08-26 20:46:04.939128 | mon1 -> localhost | ok: Runtime: 0:00:00.011336
2026-08-26 20:46:04.944841 | 
2026-08-26 20:46:04.944906 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-26 20:46:05.246460 | mon1 | ok
2026-08-26 20:46:05.279043 | osd1 | ok
2026-08-26 20:46:05.284428 | 
2026-08-26 20:46:05.284493 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-26 20:46:05.310812 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:05.322365 | osd1 | skipping: Conditional result was False
2026-08-26 20:46:05.346197 | 
2026-08-26 20:46:05.346384 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-26 20:46:05.703542 | mon1 | ok
2026-08-26 20:46:05.710117 | osd1 | ok
2026-08-26 20:46:05.716364 | 
2026-08-26 20:46:05.716424 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-26 20:46:06.595541 | mon1 | Output suppressed because no_log was given
2026-08-26 20:46:06.601558 | osd1 | Output suppressed because no_log was given
2026-08-26 20:46:06.616481 | 
2026-08-26 20:46:06.616548 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-26 20:46:06.873735 | mon1 | ok: "logs"
2026-08-26 20:46:06.874414 | mon1 | ok: All items complete
2026-08-26 20:46:06.874471 | 
2026-08-26 20:46:06.879692 | osd1 | ok: "logs"
2026-08-26 20:46:07.104002 | mon1 | ok: "artifacts"
2026-08-26 20:46:07.108868 | osd1 | ok: "artifacts"
2026-08-26 20:46:07.325545 | mon1 | ok: "docs"
2026-08-26 20:46:07.333295 | osd1 | ok: "docs"
2026-08-26 20:46:07.348008 | 
2026-08-26 20:46:07.348134 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-26 20:46:07.617240 | mon1 | changed: "logs"
2026-08-26 20:46:07.617574 | mon1 | ok: All items complete
2026-08-26 20:46:07.617606 | 
2026-08-26 20:46:07.634367 | osd1 | changed: "logs"
2026-08-26 20:46:07.820618 | mon1 | changed: "artifacts"
2026-08-26 20:46:07.860457 | osd1 | changed: "artifacts"
2026-08-26 20:46:08.009476 | mon1 | changed: "docs"
2026-08-26 20:46:08.048999 | osd1 | changed: "docs"
2026-08-26 20:46:08.073373 | 
2026-08-26 20:46:08.073496 | PLAY RECAP
2026-08-26 20:46:08.073548 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:46:08.073581 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:46:08.073605 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:46:08.073624 | 
2026-08-26 20:46:08.236883 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:46:08.243102 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:46:08.840565 | 
2026-08-26 20:46:08.952645 | PLAY [all]
2026-08-26 20:46:08.969323 | 
2026-08-26 20:46:08.969401 | TASK [setup-uv : Extract archive]
2026-08-26 20:46:14.456517 | osd1 | changed
2026-08-26 20:46:17.485214 | mon1 | changed
2026-08-26 20:46:17.494340 | 
2026-08-26 20:46:17.494436 | TASK [setup-uv : Print version]
2026-08-26 20:46:17.940133 | mon1 | uv 0.8.13
2026-08-26 20:46:17.938478 | osd1 | uv 0.8.13
2026-08-26 20:46:18.071834 | osd1 | ok: Runtime: 0:00:00.022349
2026-08-26 20:46:18.084167 | mon1 | ok: Runtime: 0:00:00.019259
2026-08-26 20:46:18.101014 | 
2026-08-26 20:46:18.101083 | TASK [Install Ansible collection siblings]
2026-08-26 20:46:18.541291 | mon1 | ok:
2026-08-26 20:46:18.541492 | mon1 | Skipping community.general: no checked-out sibling
2026-08-26 20:46:18.541531 | mon1 | Skipping ansible.utils: no checked-out sibling
2026-08-26 20:46:18.541638 | mon1 | Skipping vexxhost.containers: no checked-out sibling
2026-08-26 20:46:18.543779 | 
2026-08-26 20:46:18.543838 | PLAY RECAP
2026-08-26 20:46:18.543901 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:46:18.543951 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:46:18.543980 | 
2026-08-26 20:46:18.784908 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:46:18.790466 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 20:46:19.420331 | 
2026-08-26 20:46:19.420483 | PLAY [all]
2026-08-26 20:46:19.432398 | 
2026-08-26 20:46:19.432474 | LOOP [Check inventory directories]
2026-08-26 20:46:19.816240 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:46:20.031462 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-26 20:46:20.240638 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-26 20:46:20.254531 | 
2026-08-26 20:46:20.254727 | LOOP [Copy inventory file for Zuul]
2026-08-26 20:46:21.295767 | mon1 | changed:
2026-08-26 20:46:21.296066 | mon1 | {
2026-08-26 20:46:21.296099 | mon1 |   "ansible_loop_var": "item",
2026-08-26 20:46:21.296122 | mon1 |   "changed": false,
2026-08-26 20:46:21.296143 | mon1 |   "failed": false,
2026-08-26 20:46:21.296171 | mon1 |   "invocation": {
2026-08-26 20:46:21.296192 | mon1 |     "module_args": {
2026-08-26 20:46:21.296211 | mon1 |       "checksum_algorithm": "sha1",
2026-08-26 20:46:21.296229 | mon1 |       "follow": true,
2026-08-26 20:46:21.296248 | mon1 |       "get_attributes": true,
2026-08-26 20:46:21.296267 | mon1 |       "get_checksum": true,
2026-08-26 20:46:21.296286 | mon1 |       "get_mime": true,
2026-08-26 20:46:21.296305 | mon1 |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:46:21.296323 | mon1 |     }
2026-08-26 20:46:21.296341 | mon1 |   },
2026-08-26 20:46:21.296359 | mon1 |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:46:21.296377 | mon1 |   "stat": {
2026-08-26 20:46:21.296395 | mon1 |     "atime": 1787777166.4685018,
2026-08-26 20:46:21.296414 | mon1 |     "attr_flags": "e",
2026-08-26 20:46:21.296432 | mon1 |     "attributes": [
2026-08-26 20:46:21.296450 | mon1 |       "extents"
2026-08-26 20:46:21.296469 | mon1 |     ],
2026-08-26 20:46:21.296487 | mon1 |     "block_size": 4096,
2026-08-26 20:46:21.296505 | mon1 |     "blocks": 8,
2026-08-26 20:46:21.296523 | mon1 |     "charset": "unknown",
2026-08-26 20:46:21.296542 | mon1 |     "ctime": 1787777166.4885063,
2026-08-26 20:46:21.296560 | mon1 |     "dev": 64769,
2026-08-26 20:46:21.296578 | mon1 |     "device_type": 0,
2026-08-26 20:46:21.296598 | mon1 |     "executable": true,
2026-08-26 20:46:21.296615 | mon1 |     "exists": true,
2026-08-26 20:46:21.296633 | mon1 |     "gid": 1000,
2026-08-26 20:46:21.296651 | mon1 |     "gr_name": "zuul",
2026-08-26 20:46:21.296669 | mon1 |     "inode": 1034272,
2026-08-26 20:46:21.296686 | mon1 |     "isblk": false,
2026-08-26 20:46:21.296705 | mon1 |     "ischr": false,
2026-08-26 20:46:21.296724 | mon1 |     "isdir": true,
2026-08-26 20:46:21.296741 | mon1 |     "isfifo": false,
2026-08-26 20:46:21.296758 | mon1 |     "isgid": false,
2026-08-26 20:46:21.296775 | mon1 |     "islnk": false,
2026-08-26 20:46:21.296793 | mon1 |     "isreg": false,
2026-08-26 20:46:21.296810 | mon1 |     "issock": false,
2026-08-26 20:46:21.296828 | mon1 |     "isuid": false,
2026-08-26 20:46:21.296844 | mon1 |     "mimetype": "unknown",
2026-08-26 20:46:21.296862 | mon1 |     "mode": "0755",
2026-08-26 20:46:21.296879 | mon1 |     "mtime": 1787777142.3188279,
2026-08-26 20:46:21.296896 | mon1 |     "nlink": 10,
2026-08-26 20:46:21.296914 | mon1 |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:46:21.296932 | mon1 |     "pw_name": "zuul",
2026-08-26 20:46:21.296950 | mon1 |     "readable": true,
2026-08-26 20:46:21.296986 | mon1 |     "rgrp": true,
2026-08-26 20:46:21.297005 | mon1 |     "roth": true,
2026-08-26 20:46:21.297024 | mon1 |     "rusr": true,
2026-08-26 20:46:21.297042 | mon1 |     "size": 4096,
2026-08-26 20:46:21.297068 | mon1 |     "uid": 1000,
2026-08-26 20:46:21.297087 | mon1 |     "version": "4079848145",
2026-08-26 20:46:21.297105 | mon1 |     "wgrp": false,
2026-08-26 20:46:21.297124 | mon1 |     "woth": false,
2026-08-26 20:46:21.297142 | mon1 |     "writeable": true,
2026-08-26 20:46:21.297160 | mon1 |     "wusr": true,
2026-08-26 20:46:21.297177 | mon1 |     "xgrp": true,
2026-08-26 20:46:21.297193 | mon1 |     "xoth": true,
2026-08-26 20:46:21.297210 | mon1 |     "xusr": true
2026-08-26 20:46:21.297227 | mon1 |   }
2026-08-26 20:46:21.297245 | mon1 | }
2026-08-26 20:46:21.297281 | mon1 | ok: All items complete
2026-08-26 20:46:21.297303 | 
2026-08-26 20:46:21.298515 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:21.301923 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:21.315725 | 
2026-08-26 20:46:21.315917 | LOOP [Switch "ansible_host" to private IP]
2026-08-26 20:46:21.760623 | mon1 | changed: 2 replacements made
2026-08-26 20:46:21.761900 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:21.762495 | mon1 | skipping: Conditional result was False
2026-08-26 20:46:21.780899 | 
2026-08-26 20:46:21.781059 | TASK [Run Molecule scenario]
2026-08-26 20:46:22.383052 | mon1 | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-08-26 20:46:22.383198 | mon1 | Creating virtual environment at: .venv
2026-08-26 20:46:52.173410 | mon1 | Downloading pygments (1.2MiB)
2026-08-26 20:46:52.193821 | mon1 | Downloading netaddr (2.2MiB)
2026-08-26 20:46:52.198248 | mon1 | Downloading cryptography (4.3MiB)
2026-08-26 20:46:52.201165 | mon1 | Downloading ansible-core (2.1MiB)
2026-08-26 20:46:52.414571 | mon1 |  Downloading netaddr
2026-08-26 20:46:52.426627 | mon1 |  Downloading cryptography
2026-08-26 20:46:52.484184 | mon1 |  Downloading pygments
2026-08-26 20:46:52.626124 | mon1 |  Downloading ansible-core
2026-08-26 20:46:53.200081 | mon1 | Installed 37 packages in 71ms
2026-08-26 20:46:53.967664 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-08-26 20:46:53.967701 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-26 20:46:54.690028 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-26 20:46:54.690139 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-26 20:47:22.395156 | mon1 | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv community.general:>=4.5.0
2026-08-26 20:47:22.395223 | mon1 | ERROR    Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-08-26 20:47:22.395232 | mon1 | Starting galaxy collection install process
2026-08-26 20:47:22.395238 | mon1 | Process install dependency map
2026-08-26 20:47:22.395245 | mon1 |
2026-08-26 20:47:22.395273 | mon1 | ansible-galaxy
2026-08-26 20:47:22.395282 | mon1 |   config file = None
2026-08-26 20:47:22.395288 | mon1 |   configured module search path =
2026-08-26 20:47:22.395306 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-08-26 20:47:22.395317 | mon1 |   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:47:22.395325 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 20:47:22.395332 | mon1 |   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:47:22.395339 | mon1 |   jinja version = 3.1.6
2026-08-26 20:47:22.395345 | mon1 |   libyaml = True
2026-08-26 20:47:22.395352 | mon1 | No config file found; using defaults
2026-08-26 20:47:22.395359 | mon1 | Created /home/zuul/.ansible/galaxy_token
2026-08-26 20:47:22.395366 | mon1 | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-26 20:47:22.395372 | mon1 | unexpected error when getting available versions of collection
2026-08-26 20:47:22.395379 | mon1 | community.general: Unknown error when attempting to call Galaxy at
2026-08-26 20:47:22.395385 | mon1 | 'https://galaxy.ansible.com/api/v3/collections/community/general/': <urlopen
2026-08-26 20:47:22.395392 | mon1 | error  Temporary failure in name resolution>. <urlopen error  Temporary failure in name resolution>
2026-08-26 20:47:22.395499 | mon1 | ERROR! Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/community/general/': <urlopen error  Temporary failure in name resolution>. <urlopen error  Temporary failure in name resolution>
2026-08-26 20:47:22.395515 | mon1 |
2026-08-26 20:47:22.395642 | mon1 | Traceback (most recent call last):
2026-08-26 20:47:22.395841 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in <module>
2026-08-26 20:47:22.396090 | mon1 |     sys.exit(main())
2026-08-26 20:47:22.396277 | mon1 |              ^^^^^^
2026-08-26 20:47:22.396425 | mon1 |   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:47:22.396870 | mon1 |     return self.main(*args, **kwargs)
2026-08-26 20:47:22.397046 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.397195 | mon1 |   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:47:22.397589 | mon1 |     rv = self.invoke(ctx)
2026-08-26 20:47:22.397761 | mon1 |          ^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.397910 | mon1 |   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:47:22.398370 | mon1 |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-26 20:47:22.398547 | mon1 |                            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.398682 | mon1 |   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:47:22.399065 | mon1 |     return ctx.invoke(self.callback, **ctx.params)
2026-08-26 20:47:22.399242 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.399396 | mon1 |   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:47:22.399696 | mon1 |     return callback(*args, **kwargs)
2026-08-26 20:47:22.399883 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.400024 | mon1 |   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:47:22.400320 | mon1 |     return func(*args, **kwargs)
2026-08-26 20:47:22.400481 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.400615 | mon1 |   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:47:22.400821 | mon1 |     return f(get_current_context(), *args, **kwargs)
2026-08-26 20:47:22.401005 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 20:47:22.401142 | mon1 |   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:47:22.401411 | mon1 |     return func(ctx)
2026-08-26 20:47:22.401561 | mon1 |            ^^^^^^^^^
2026-08-26 20:47:22.401698 | mon1 |   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:47:22.401978 | mon1 |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-26 20:47:22.402129 | mon1 |   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:47:22.402400 | mon1 |     _run_scenarios(scenarios, command_args, default_config)
2026-08-26 20:47:22.402558 | mon1 |   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:47:22.402820 | mon1 |     scenario.config.runtime.prepare_environment(
2026-08-26 20:47:22.402971 | mon1 |   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:47:22.403294 | mon1 |     self.install_collection(
2026-08-26 20:47:22.403439 | mon1 |   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:47:22.403845 | mon1 |     raise InvalidPrerequisiteError(msg)
2026-08-26 20:47:22.404508 | mon1 | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-08-26 20:47:22.404519 | mon1 | Starting galaxy collection install process
2026-08-26 20:47:22.404524 | mon1 | Process install dependency map
2026-08-26 20:47:22.404530 | mon1 |
2026-08-26 20:47:22.404536 | mon1 | ansible-galaxy [core 2.18.6]
2026-08-26 20:47:22.404551 | mon1 |   config file = None
2026-08-26 20:47:22.404557 | 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:47:22.404563 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-08-26 20:47:22.404574 | mon1 |   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:47:22.404581 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 20:47:22.404586 | mon1 |   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:47:22.404592 | mon1 |   jinja version = 3.1.6
2026-08-26 20:47:22.404597 | mon1 |   libyaml = True
2026-08-26 20:47:22.404602 | mon1 | No config file found; using defaults
2026-08-26 20:47:22.404608 | mon1 | Created /home/zuul/.ansible/galaxy_token
2026-08-26 20:47:22.404613 | mon1 | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-26 20:47:22.404618 | mon1 | unexpected error when getting available versions of collection
2026-08-26 20:47:22.404624 | mon1 | community.general: Unknown error when attempting to call Galaxy at
2026-08-26 20:47:22.404629 | mon1 | 'https://galaxy.ansible.com/api/v3/collections/community/general/': <urlopen
2026-08-26 20:47:22.404635 | mon1 | error [Errno -3] Temporary failure in name resolution>. <urlopen error [Errno
2026-08-26 20:47:22.404640 | mon1 | -3] Temporary failure in name resolution>
2026-08-26 20:47:22.404649 | mon1 | ERROR! Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/community/general/': <urlopen error [Errno -3] Temporary failure in name resolution>. <urlopen error [Errno -3] Temporary failure in name resolution>
2026-08-26 20:47:22.404659 | mon1 |
2026-08-26 20:47:32.908202 | mon1 | ERROR
2026-08-26 20:47:32.908418 | mon1 | {
2026-08-26 20:47:32.908448 | mon1 |   "delta": "0:01:00.220573",
2026-08-26 20:47:32.908469 | mon1 |   "end": "2026-08-26 20:47:22.495806",
2026-08-26 20:47:32.908487 | mon1 |   "msg": "non-zero return code",
2026-08-26 20:47:32.908505 | mon1 |   "rc": 1,
2026-08-26 20:47:32.908522 | mon1 |   "start": "2026-08-26 20:46:22.275233"
2026-08-26 20:47:32.908539 | mon1 | }
failure
2026-08-26 20:47:32.911259 | 
2026-08-26 20:47:32.911307 | PLAY RECAP
2026-08-26 20:47:32.911353 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:47:32.911375 | 
2026-08-26 20:47:33.120512 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 20:47:33.135322 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 20:47:33.750237 | 
2026-08-26 20:47:33.750424 | PLAY [all]
2026-08-26 20:47:33.763860 | 
2026-08-26 20:47:33.763949 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-26 20:47:33.819056 | mon1 | ok
2026-08-26 20:47:33.825626 | osd1 | ok
2026-08-26 20:47:33.830464 | 
2026-08-26 20:47:33.830546 | TASK [fetch-output : Set log path for single node]
2026-08-26 20:47:33.857266 | mon1 | skipping: Conditional result was False
2026-08-26 20:47:33.868914 | osd1 | skipping: Conditional result was False
2026-08-26 20:47:33.881090 | 
2026-08-26 20:47:33.881197 | LOOP [fetch-output : Ensure local output dirs]
2026-08-26 20:47:34.321977 | osd1 -> localhost | changed: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/logs/osd1"
2026-08-26 20:47:34.324239 | mon1 -> localhost | changed: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/logs/mon1"
2026-08-26 20:47:34.528877 | osd1 -> localhost | changed: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/artifacts"
2026-08-26 20:47:34.537178 | mon1 -> localhost | ok: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/artifacts"
2026-08-26 20:47:34.734137 | osd1 -> localhost | changed: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/docs"
2026-08-26 20:47:34.741872 | mon1 -> localhost | ok: "/var/lib/zuul/builds/4c4e1fd399a34ee98dce71f7ec3d49f3/work/docs"
2026-08-26 20:47:34.760586 | 
2026-08-26 20:47:34.760744 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-26 20:47:35.465189 | osd1 | changed: .d..t...... ./
2026-08-26 20:47:35.465486 | osd1 | changed: All items complete
2026-08-26 20:47:35.465523 | 
2026-08-26 20:47:35.475509 | mon1 | changed: .d..t...... ./
2026-08-26 20:47:35.955730 | mon1 | changed: .d..t...... ./
2026-08-26 20:47:35.965147 | osd1 | ok
2026-08-26 20:47:36.443146 | mon1 | changed: .d..t...... ./
2026-08-26 20:47:36.460995 | osd1 | changed: .d..t...... ./
2026-08-26 20:47:36.485352 | 
2026-08-26 20:47:36.485548 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-26 20:47:36.907605 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008329
2026-08-26 20:47:36.907845 | mon1 -> localhost | changed: All items complete
2026-08-26 20:47:36.907885 | 
2026-08-26 20:47:37.143067 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.008367
2026-08-26 20:47:37.171759 | 
2026-08-26 20:47:37.171916 | PLAY [all]
2026-08-26 20:47:37.181146 | 
2026-08-26 20:47:37.181236 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-26 20:47:37.668643 | mon1 | changed
2026-08-26 20:47:37.893675 | osd1 | changed
2026-08-26 20:47:37.903843 | 
2026-08-26 20:47:37.903893 | PLAY RECAP
2026-08-26 20:47:37.903940 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 20:47:37.903969 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 20:47:37.903989 | 
2026-08-26 20:47:38.052045 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 20:47:38.057681 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-26 20:47:38.647125 | 
2026-08-26 20:47:38.647289 | PLAY [localhost]
2026-08-26 20:47:38.658616 | 
2026-08-26 20:47:38.658716 | TASK [Generate Zuul manifest]
2026-08-26 20:47:38.680517 | localhost | ok
2026-08-26 20:47:38.700026 | 
2026-08-26 20:47:38.700277 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-26 20:47:39.067668 | localhost | changed
2026-08-26 20:47:39.081069 | 
2026-08-26 20:47:39.081154 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-26 20:47:39.115512 | localhost | ok
2026-08-26 20:47:39.123559 | 
2026-08-26 20:47:39.123628 | TASK [Upload logs]
2026-08-26 20:47:39.142566 | localhost | ok
2026-08-26 20:47:39.201871 | 
2026-08-26 20:47:39.202011 | TASK [Set zuul-log-path fact]
2026-08-26 20:47:39.225850 | localhost | ok
2026-08-26 20:47:39.239730 | 
2026-08-26 20:47:39.239802 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 20:47:39.268373 | localhost | ok
2026-08-26 20:47:39.276826 | 
2026-08-26 20:47:39.276894 | TASK [upload-logs : Create log directories]
2026-08-26 20:47:39.674537 | localhost | changed
2026-08-26 20:47:39.681319 | 
2026-08-26 20:47:39.681390 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-26 20:47:40.108530 | localhost -> localhost | ok: Runtime: 0:00:00.007131
2026-08-26 20:47:40.115704 | 
2026-08-26 20:47:40.115774 | TASK [upload-logs : Upload logs to log server]
2026-08-26 20:47:40.583542 | localhost | Output suppressed because no_log was given
2026-08-26 20:47:40.588657 | 
2026-08-26 20:47:40.588749 | LOOP [upload-logs : Compress console log and json output]
2026-08-26 20:47:40.680358 | localhost | skipping: Conditional result was False
2026-08-26 20:47:40.687339 | localhost | skipping: Conditional result was False
2026-08-26 20:47:40.705045 | 
2026-08-26 20:47:40.705177 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-26 20:47:40.791844 | localhost | skipping: Conditional result was False
2026-08-26 20:47:40.792230 | 
2026-08-26 20:47:40.796136 | localhost | skipping: Conditional result was False
2026-08-26 20:47:40.855310 | 
2026-08-26 20:47:40.855489 | LOOP [upload-logs : Upload console log and json output]