2026-08-26 20:54:04.876646 | Job console starting
2026-08-26 20:54:04.893208 | Updating git repos
2026-08-26 20:54:04.919085 | Cloning repos into workspace
2026-08-26 20:54:06.943362 | Restoring repo states
2026-08-26 20:54:06.952293 | Merging changes
2026-08-26 20:54:08.294614 | Checking out repos
2026-08-26 20:54:08.423979 | Preparing playbooks
2026-08-26 20:54:14.828262 | Running Ansible setup
2026-08-26 20:54:21.007593 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:54:21.730648 | 
2026-08-26 20:54:21.730807 | PLAY [localhost]
2026-08-26 20:54:21.738750 | 
2026-08-26 20:54:21.738819 | TASK [Gathering Facts]
2026-08-26 20:54:22.742129 | localhost | ok
2026-08-26 20:54:22.756487 | 
2026-08-26 20:54:22.756675 | TASK [Setup log path fact]
2026-08-26 20:54:22.779765 | localhost | ok
2026-08-26 20:54:22.799134 | 
2026-08-26 20:54:22.799272 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 20:54:22.828282 | localhost | ok
2026-08-26 20:54:22.838863 | 
2026-08-26 20:54:22.838940 | TASK [emit-job-header : Print job information]
2026-08-26 20:54:22.879808 | # Job Information
2026-08-26 20:54:22.879954 | Ansible Version: 2.16.18
2026-08-26 20:54:22.879993 | Job: ansible-collection-ceph-molecule-ha-ubuntu-noble
2026-08-26 20:54:22.880018 | Pipeline: check
2026-08-26 20:54:22.880040 | Executor: 2d72f0692154
2026-08-26 20:54:22.880062 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/117
2026-08-26 20:54:22.880086 | Event ID: 67c110d0-a18e-11f1-96e8-dbebb464ef4a
2026-08-26 20:54:22.883133 | 
2026-08-26 20:54:22.883208 | LOOP [emit-job-header : Print node information]
2026-08-26 20:54:22.984052 | localhost | ok:
2026-08-26 20:54:22.984317 | localhost | # Node Information
2026-08-26 20:54:22.984347 | localhost | Inventory Hostname: mon1
2026-08-26 20:54:22.984369 | localhost | Hostname: np0000191309
2026-08-26 20:54:22.984389 | localhost | Username: zuul
2026-08-26 20:54:22.984412 | localhost | Distro: Ubuntu 24.04
2026-08-26 20:54:22.984432 | localhost | Provider: yul1
2026-08-26 20:54:22.984451 | localhost | Region: ca-ymq-1
2026-08-26 20:54:22.984470 | localhost | Label: ubuntu-noble
2026-08-26 20:54:22.984489 | localhost | Product Name: OpenStack Nova
2026-08-26 20:54:22.984508 | localhost | Interface IP: 162.253.55.92
2026-08-26 20:54:23.034668 | localhost | ok:
2026-08-26 20:54:23.034741 | localhost | # Node Information
2026-08-26 20:54:23.034777 | localhost | Inventory Hostname: osd1
2026-08-26 20:54:23.034806 | localhost | Hostname: np0000191310
2026-08-26 20:54:23.034834 | localhost | Username: zuul
2026-08-26 20:54:23.034861 | localhost | Distro: Ubuntu 24.04
2026-08-26 20:54:23.034888 | localhost | Provider: yul1
2026-08-26 20:54:23.034914 | localhost | Region: ca-ymq-1
2026-08-26 20:54:23.034939 | localhost | Label: ubuntu-noble
2026-08-26 20:54:23.034965 | localhost | Product Name: OpenStack Nova
2026-08-26 20:54:23.034992 | localhost | Interface IP: 162.253.55.17
2026-08-26 20:54:23.047501 | 
2026-08-26 20:54:23.047621 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-26 20:54:23.427018 | localhost -> localhost | changed
2026-08-26 20:54:23.436792 | 
2026-08-26 20:54:23.436895 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-26 20:54:24.788563 | localhost -> localhost | changed
2026-08-26 20:54:24.800274 | 
2026-08-26 20:54:24.800329 | PLAY [all]
2026-08-26 20:54:24.809318 | 
2026-08-26 20:54:24.809385 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-26 20:54:25.036456 | mon1 -> localhost | ok
2026-08-26 20:54:25.049173 | 
2026-08-26 20:54:25.049264 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-26 20:54:25.086460 | mon1 | ok
2026-08-26 20:54:25.092277 | osd1 | ok
2026-08-26 20:54:25.111785 | mon1 | included: /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:54:25.111837 | osd1 | included: /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 20:54:25.118577 | 
2026-08-26 20:54:25.118638 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-26 20:54:26.684594 | mon1 -> localhost | Generating public/private rsa key pair.
2026-08-26 20:54:26.684801 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/24bd1d28e0ef4a39a004a1511f0d503d_id_rsa
2026-08-26 20:54:26.684832 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/24bd1d28e0ef4a39a004a1511f0d503d_id_rsa.pub
2026-08-26 20:54:26.684855 | mon1 -> localhost | The key fingerprint is:
2026-08-26 20:54:26.684877 | mon1 -> localhost | SHA256:oVyHazhkP5x95Q2Od9R3bSpf1xv3KZYNK4raYtx/VVw zuul-build-sshkey
2026-08-26 20:54:26.684898 | mon1 -> localhost | The key's randomart image is:
2026-08-26 20:54:26.684919 | mon1 -> localhost | +---[RSA 3072]----+
2026-08-26 20:54:26.684939 | mon1 -> localhost | |                 |
2026-08-26 20:54:26.684975 | mon1 -> localhost | |         .      E|
2026-08-26 20:54:26.684999 | mon1 -> localhost | |      o + .   + O|
2026-08-26 20:54:26.685019 | mon1 -> localhost | |     + * *   = O+|
2026-08-26 20:54:26.685038 | mon1 -> localhost | |      = S . +.*.B|
2026-08-26 20:54:26.685058 | mon1 -> localhost | |       o . . ==oB|
2026-08-26 20:54:26.685077 | mon1 -> localhost | |    . .    ..=.+.|
2026-08-26 20:54:26.685096 | mon1 -> localhost | |     +... ..o .  |
2026-08-26 20:54:26.685115 | mon1 -> localhost | |    ..oo.o.      |
2026-08-26 20:54:26.685134 | mon1 -> localhost | +----[SHA256]-----+
2026-08-26 20:54:26.685189 | mon1 -> localhost | ok: Runtime: 0:00:01.150623
2026-08-26 20:54:26.690904 | 
2026-08-26 20:54:26.690982 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-26 20:54:26.732380 | mon1 | ok
2026-08-26 20:54:26.739023 | osd1 | ok
2026-08-26 20:54:26.753175 | mon1 | included: /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:54:26.753223 | osd1 | included: /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 20:54:26.764495 | 
2026-08-26 20:54:26.764560 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-26 20:54:26.792545 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:26.804020 | osd1 | skipping: Conditional result was False
2026-08-26 20:54:26.814825 | 
2026-08-26 20:54:26.814918 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-26 20:54:27.344924 | osd1 | changed
2026-08-26 20:54:27.376697 | mon1 | changed
2026-08-26 20:54:27.387266 | 
2026-08-26 20:54:27.387474 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-26 20:54:27.606235 | mon1 | ok
2026-08-26 20:54:27.671341 | osd1 | ok
2026-08-26 20:54:27.677600 | 
2026-08-26 20:54:27.677670 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-26 20:54:28.306853 | mon1 | changed
2026-08-26 20:54:28.369701 | osd1 | changed
2026-08-26 20:54:28.377264 | 
2026-08-26 20:54:28.377357 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-26 20:54:29.000245 | osd1 | changed
2026-08-26 20:54:29.006931 | mon1 | changed
2026-08-26 20:54:29.025034 | 
2026-08-26 20:54:29.025104 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-26 20:54:29.056816 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:29.068270 | osd1 | skipping: Conditional result was False
2026-08-26 20:54:29.077498 | 
2026-08-26 20:54:29.077592 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-26 20:54:29.630069 | mon1 -> localhost | changed
2026-08-26 20:54:29.654253 | 
2026-08-26 20:54:29.654323 | TASK [add-build-sshkey : Add back temp key]
2026-08-26 20:54:29.940252 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/24bd1d28e0ef4a39a004a1511f0d503d_id_rsa (zuul-build-sshkey)
2026-08-26 20:54:29.940581 | mon1 -> localhost | ok: Runtime: 0:00:00.014459
2026-08-26 20:54:29.948072 | 
2026-08-26 20:54:29.948135 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-26 20:54:30.269123 | osd1 | ok
2026-08-26 20:54:30.275538 | mon1 | ok
2026-08-26 20:54:30.280985 | 
2026-08-26 20:54:30.281054 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-26 20:54:30.308121 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:30.319579 | osd1 | skipping: Conditional result was False
2026-08-26 20:54:30.340393 | 
2026-08-26 20:54:30.340458 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-26 20:54:30.696606 | mon1 | ok
2026-08-26 20:54:30.703174 | osd1 | ok
2026-08-26 20:54:30.709673 | 
2026-08-26 20:54:30.709736 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-26 20:54:31.591529 | osd1 | Output suppressed because no_log was given
2026-08-26 20:54:31.596651 | mon1 | Output suppressed because no_log was given
2026-08-26 20:54:31.612726 | 
2026-08-26 20:54:31.612795 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-26 20:54:31.862563 | mon1 | ok: "logs"
2026-08-26 20:54:31.862905 | mon1 | ok: All items complete
2026-08-26 20:54:31.862946 | 
2026-08-26 20:54:31.870606 | osd1 | ok: "logs"
2026-08-26 20:54:32.072045 | osd1 | ok: "artifacts"
2026-08-26 20:54:32.107599 | mon1 | ok: "artifacts"
2026-08-26 20:54:32.257498 | osd1 | ok: "docs"
2026-08-26 20:54:32.310798 | mon1 | ok: "docs"
2026-08-26 20:54:32.322439 | 
2026-08-26 20:54:32.322616 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-26 20:54:32.546317 | osd1 | changed: "logs"
2026-08-26 20:54:32.546595 | osd1 | ok: All items complete
2026-08-26 20:54:32.546623 | 
2026-08-26 20:54:32.562694 | mon1 | changed: "logs"
2026-08-26 20:54:32.728060 | osd1 | changed: "artifacts"
2026-08-26 20:54:32.799958 | mon1 | changed: "artifacts"
2026-08-26 20:54:32.908333 | osd1 | changed: "docs"
2026-08-26 20:54:32.993672 | mon1 | changed: "docs"
2026-08-26 20:54:33.013432 | 
2026-08-26 20:54:33.013614 | PLAY RECAP
2026-08-26 20:54:33.013664 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:54:33.013696 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:54:33.013720 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 20:54:33.013739 | 
2026-08-26 20:54:33.184818 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 20:54:33.188232 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:54:33.835934 | 
2026-08-26 20:54:33.836075 | PLAY [all]
2026-08-26 20:54:33.847941 | 
2026-08-26 20:54:33.848083 | TASK [setup-uv : Extract archive]
2026-08-26 20:54:38.742291 | mon1 | changed
2026-08-26 20:54:41.619232 | osd1 | changed
2026-08-26 20:54:41.634960 | 
2026-08-26 20:54:41.635059 | TASK [setup-uv : Print version]
2026-08-26 20:54:42.061295 | osd1 | uv 0.8.13
2026-08-26 20:54:42.056878 | mon1 | uv 0.8.13
2026-08-26 20:54:42.200335 | mon1 | ok: Runtime: 0:00:00.018828
2026-08-26 20:54:42.212743 | osd1 | ok: Runtime: 0:00:00.019145
2026-08-26 20:54:42.227363 | 
2026-08-26 20:54:42.227431 | TASK [Install Ansible collection siblings]
2026-08-26 20:54:42.664726 | mon1 | ok:
2026-08-26 20:54:42.664904 | mon1 | Skipping community.general: no checked-out sibling
2026-08-26 20:54:42.664933 | mon1 | Skipping ansible.utils: no checked-out sibling
2026-08-26 20:54:42.665018 | mon1 | Skipping vexxhost.containers: no checked-out sibling
2026-08-26 20:54:42.670507 | 
2026-08-26 20:54:42.670565 | PLAY RECAP
2026-08-26 20:54:42.670615 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:54:42.670658 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 20:54:42.670678 | 
2026-08-26 20:54:42.841308 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 20:54:42.846011 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 20:54:43.471357 | 
2026-08-26 20:54:43.472063 | PLAY [all]
2026-08-26 20:54:43.484863 | 
2026-08-26 20:54:43.484962 | LOOP [Check inventory directories]
2026-08-26 20:54:43.888751 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:54:44.116811 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-26 20:54:44.317227 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-26 20:54:44.338570 | 
2026-08-26 20:54:44.338786 | LOOP [Copy inventory file for Zuul]
2026-08-26 20:54:45.315297 | mon1 | changed:
2026-08-26 20:54:45.315627 | mon1 | {
2026-08-26 20:54:45.315669 | mon1 |   "ansible_loop_var": "item",
2026-08-26 20:54:45.315693 | mon1 |   "changed": false,
2026-08-26 20:54:45.315713 | mon1 |   "failed": false,
2026-08-26 20:54:45.315742 | mon1 |   "invocation": {
2026-08-26 20:54:45.315762 | mon1 |     "module_args": {
2026-08-26 20:54:45.315780 | mon1 |       "checksum_algorithm": "sha1",
2026-08-26 20:54:45.315798 | mon1 |       "follow": true,
2026-08-26 20:54:45.315815 | mon1 |       "get_attributes": true,
2026-08-26 20:54:45.315834 | mon1 |       "get_checksum": true,
2026-08-26 20:54:45.315852 | mon1 |       "get_mime": true,
2026-08-26 20:54:45.315869 | mon1 |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-26 20:54:45.315887 | mon1 |     }
2026-08-26 20:54:45.315904 | mon1 |   },
2026-08-26 20:54:45.315921 | mon1 |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:54:45.315938 | mon1 |   "stat": {
2026-08-26 20:54:45.315955 | mon1 |     "atime": 1787777671.463281,
2026-08-26 20:54:45.315972 | mon1 |     "attr_flags": "e",
2026-08-26 20:54:45.315989 | mon1 |     "attributes": [
2026-08-26 20:54:45.316006 | mon1 |       "extents"
2026-08-26 20:54:45.316022 | mon1 |     ],
2026-08-26 20:54:45.316039 | mon1 |     "block_size": 4096,
2026-08-26 20:54:45.316056 | mon1 |     "blocks": 8,
2026-08-26 20:54:45.316072 | mon1 |     "charset": "unknown",
2026-08-26 20:54:45.316090 | mon1 |     "ctime": 1787777671.4842868,
2026-08-26 20:54:45.316107 | mon1 |     "dev": 64769,
2026-08-26 20:54:45.316125 | mon1 |     "device_type": 0,
2026-08-26 20:54:45.316142 | mon1 |     "executable": true,
2026-08-26 20:54:45.316158 | mon1 |     "exists": true,
2026-08-26 20:54:45.316175 | mon1 |     "gid": 1000,
2026-08-26 20:54:45.316191 | mon1 |     "gr_name": "zuul",
2026-08-26 20:54:45.316207 | mon1 |     "inode": 1034272,
2026-08-26 20:54:45.316224 | mon1 |     "isblk": false,
2026-08-26 20:54:45.316240 | mon1 |     "ischr": false,
2026-08-26 20:54:45.316257 | mon1 |     "isdir": true,
2026-08-26 20:54:45.316273 | mon1 |     "isfifo": false,
2026-08-26 20:54:45.316290 | mon1 |     "isgid": false,
2026-08-26 20:54:45.316306 | mon1 |     "islnk": false,
2026-08-26 20:54:45.316322 | mon1 |     "isreg": false,
2026-08-26 20:54:45.316338 | mon1 |     "issock": false,
2026-08-26 20:54:45.316355 | mon1 |     "isuid": false,
2026-08-26 20:54:45.316371 | mon1 |     "mimetype": "unknown",
2026-08-26 20:54:45.316387 | mon1 |     "mode": "0755",
2026-08-26 20:54:45.316403 | mon1 |     "mtime": 1787777647.9461303,
2026-08-26 20:54:45.316419 | mon1 |     "nlink": 10,
2026-08-26 20:54:45.316435 | mon1 |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-26 20:54:45.316452 | mon1 |     "pw_name": "zuul",
2026-08-26 20:54:45.316469 | mon1 |     "readable": true,
2026-08-26 20:54:45.316486 | mon1 |     "rgrp": true,
2026-08-26 20:54:45.316502 | mon1 |     "roth": true,
2026-08-26 20:54:45.316518 | mon1 |     "rusr": true,
2026-08-26 20:54:45.316535 | mon1 |     "size": 4096,
2026-08-26 20:54:45.316564 | mon1 |     "uid": 1000,
2026-08-26 20:54:45.316581 | mon1 |     "version": "358781795",
2026-08-26 20:54:45.316598 | mon1 |     "wgrp": false,
2026-08-26 20:54:45.316616 | mon1 |     "woth": false,
2026-08-26 20:54:45.316633 | mon1 |     "writeable": true,
2026-08-26 20:54:45.316650 | mon1 |     "wusr": true,
2026-08-26 20:54:45.316667 | mon1 |     "xgrp": true,
2026-08-26 20:54:45.316683 | mon1 |     "xoth": true,
2026-08-26 20:54:45.316700 | mon1 |     "xusr": true
2026-08-26 20:54:45.316717 | mon1 |   }
2026-08-26 20:54:45.316734 | mon1 | }
2026-08-26 20:54:45.316772 | mon1 | ok: All items complete
2026-08-26 20:54:45.316794 | 
2026-08-26 20:54:45.318128 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:45.320300 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:45.338730 | 
2026-08-26 20:54:45.338908 | LOOP [Switch "ansible_host" to private IP]
2026-08-26 20:54:45.751131 | mon1 | changed: 2 replacements made
2026-08-26 20:54:45.752522 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:45.754688 | mon1 | skipping: Conditional result was False
2026-08-26 20:54:45.774908 | 
2026-08-26 20:54:45.775073 | TASK [Run Molecule scenario]
2026-08-26 20:54:46.305642 | mon1 | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-08-26 20:54:46.305833 | mon1 | Creating virtual environment at: .venv
2026-08-26 20:54:49.560125 | mon1 | Downloading pygments (1.2MiB)
2026-08-26 20:54:49.578302 | mon1 | Downloading ansible-core (2.3MiB)
2026-08-26 20:54:49.581574 | mon1 | Downloading netaddr (2.2MiB)
2026-08-26 20:54:49.581961 | mon1 | Downloading cryptography (4.3MiB)
2026-08-26 20:54:49.777029 | mon1 |  Downloading netaddr
2026-08-26 20:54:49.792168 | mon1 |  Downloading cryptography
2026-08-26 20:54:49.849183 | mon1 |  Downloading pygments
2026-08-26 20:54:50.026843 | mon1 |  Downloading ansible-core
2026-08-26 20:54:50.096728 | mon1 | Installed 37 packages in 69ms
2026-08-26 20:54:51.064094 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-08-26 20:54:51.064180 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-26 20:54:52.118038 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-26 20:54:52.118123 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-26 21:00:20.171171 | mon1 | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv community.general:>=4.5.0
2026-08-26 21:00:20.171308 | mon1 | ERROR    Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-08-26 21:00:20.171324 | mon1 | Starting galaxy collection install process
2026-08-26 21:00:20.171336 | mon1 | Process install dependency map
2026-08-26 21:00:20.171348 | mon1 | Starting collection install process
2026-08-26 21:00:20.171378 | mon1 | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.3.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141udm81tw4/tmp60phinve/community-general-13.3.0-eqcsi9sz
2026-08-26 21:00:20.171398 | mon1 | Installing 'community.general:13.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-26 21:00:20.171410 | mon1 | community.general:13.3.0 was installed successfully
2026-08-26 21:00:20.171422 | mon1 | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-library_inventory_filtering_v1-1.1.5.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141udm81tw4/tmp60phinve/community-library_inventory_filtering_v1-1.1.5-ka29r01h
2026-08-26 21:00:20.171440 | mon1 |
2026-08-26 21:00:20.171452 | mon1 | ansible-galaxy
2026-08-26 21:00:20.171466 | mon1 |   config file = None
2026-08-26 21:00:20.171478 | mon1 |   configured module search path =
2026-08-26 21:00:20.171489 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-08-26 21:00:20.171506 | 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 21:00:20.171554 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 21:00:20.171570 | 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 21:00:20.171581 | mon1 |   jinja version = 3.1.6
2026-08-26 21:00:20.171592 | mon1 |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-26 21:00:20.171604 | mon1 | No config file found; using defaults
2026-08-26 21:00:20.171615 | mon1 | Created /home/zuul/.ansible/galaxy_token
2026-08-26 21:00:20.171626 | mon1 | Collection 'community.general:13.3.0' obtained from server default https://galaxy.ansible.com/api/
2026-08-26 21:00:20.171637 | mon1 | : Failed to download collection tar from 'default': <urlopen error  Temporary failure in name resolution>
2026-08-26 21:00:20.171648 | mon1 |
2026-08-26 21:00:20.171660 | mon1 | Failed to download collection tar from 'default': <urlopen error  Temporary failure in name resolution>
2026-08-26 21:00:20.171707 | mon1 |
2026-08-26 21:00:20.171716 | mon1 | <<< caused by >>>
2026-08-26 21:00:20.171724 | mon1 |
2026-08-26 21:00:20.171732 | mon1 | <urlopen error  Temporary failure in name resolution>
2026-08-26 21:00:20.171740 | mon1 |
2026-08-26 21:00:20.171748 | mon1 |
2026-08-26 21:00:20.171757 | mon1 | Traceback (most recent call last):
2026-08-26 21:00:20.171771 | mon1 |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/molecule", line 10, in <module>
2026-08-26 21:00:20.171902 | mon1 |     sys.exit(main())
2026-08-26 21:00:20.172181 | mon1 |              ^^^^^^
2026-08-26 21:00:20.172428 | 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 21:00:20.173225 | mon1 |     return self.main(*args, **kwargs)
2026-08-26 21:00:20.173513 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.173813 | 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 21:00:20.174496 | mon1 |     rv = self.invoke(ctx)
2026-08-26 21:00:20.174828 | mon1 |          ^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.175053 | 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 21:00:20.175972 | mon1 |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-26 21:00:20.176221 | mon1 |                            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.176453 | 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 21:00:20.177179 | mon1 |     return ctx.invoke(self.callback, **ctx.params)
2026-08-26 21:00:20.177466 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.177775 | 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 21:00:20.178277 | mon1 |     return callback(*args, **kwargs)
2026-08-26 21:00:20.178578 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.178865 | 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 21:00:20.179329 | mon1 |     return func(*args, **kwargs)
2026-08-26 21:00:20.179673 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.180149 | 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 21:00:20.180524 | mon1 |     return f(get_current_context(), *args, **kwargs)
2026-08-26 21:00:20.180918 | mon1 |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-26 21:00:20.181171 | 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 21:00:20.181711 | mon1 |     return func(ctx)
2026-08-26 21:00:20.182064 | mon1 |            ^^^^^^^^^
2026-08-26 21:00:20.182310 | 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 21:00:20.182771 | mon1 |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-26 21:00:20.183111 | 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 21:00:20.183499 | mon1 |     _run_scenarios(scenarios, command_args, default_config)
2026-08-26 21:00:20.183910 | 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 21:00:20.184358 | mon1 |     scenario.config.runtime.prepare_environment(
2026-08-26 21:00:20.184661 | 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 21:00:20.185223 | mon1 |     self.install_collection(
2026-08-26 21:00:20.185461 | 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 21:00:20.185989 | mon1 |     raise InvalidPrerequisiteError(msg)
2026-08-26 21:00:20.187727 | mon1 | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-08-26 21:00:20.187744 | mon1 | Starting galaxy collection install process
2026-08-26 21:00:20.187752 | mon1 | Process install dependency map
2026-08-26 21:00:20.187760 | mon1 | Starting collection install process
2026-08-26 21:00:20.187769 | mon1 | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.3.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141udm81tw4/tmp60phinve/community-general-13.3.0-eqcsi9sz
2026-08-26 21:00:20.187777 | mon1 | Installing 'community.general:13.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-26 21:00:20.187786 | mon1 | community.general:13.3.0 was installed successfully
2026-08-26 21:00:20.187794 | mon1 | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-library_inventory_filtering_v1-1.1.5.tar.gz to /home/zuul/.ansible/tmp/ansible-local-1141udm81tw4/tmp60phinve/community-library_inventory_filtering_v1-1.1.5-ka29r01h
2026-08-26 21:00:20.187803 | mon1 |
2026-08-26 21:00:20.187812 | mon1 | ansible-galaxy [core 2.21.3]
2026-08-26 21:00:20.187820 | mon1 |   config file = None
2026-08-26 21:00:20.187828 | 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 21:00:20.187837 | mon1 |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/lib/python3.12/site-packages/ansible
2026-08-26 21:00:20.187845 | 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 21:00:20.187854 | mon1 |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/.venv/bin/ansible-galaxy
2026-08-26 21:00:20.187862 | 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 21:00:20.187870 | mon1 |   jinja version = 3.1.6
2026-08-26 21:00:20.187878 | mon1 |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-26 21:00:20.187886 | mon1 | No config file found; using defaults
2026-08-26 21:00:20.187894 | mon1 | Created /home/zuul/.ansible/galaxy_token
2026-08-26 21:00:20.187902 | mon1 | Collection 'community.general:13.3.0' obtained from server default https://galaxy.ansible.com/api/
2026-08-26 21:00:20.187911 | mon1 | [ERROR]: Failed to download collection tar from 'default': <urlopen error [Errno -3] Temporary failure in name resolution>
2026-08-26 21:00:20.187919 | mon1 |
2026-08-26 21:00:20.187927 | mon1 | Failed to download collection tar from 'default': <urlopen error [Errno -3] Temporary failure in name resolution>
2026-08-26 21:00:20.187935 | mon1 |
2026-08-26 21:00:20.187943 | mon1 | <<< caused by >>>
2026-08-26 21:00:20.187951 | mon1 |
2026-08-26 21:00:20.187959 | mon1 | <urlopen error [Errno -3] Temporary failure in name resolution>
2026-08-26 21:00:20.187967 | mon1 |
2026-08-26 21:00:20.187980 | mon1 |
2026-08-26 21:00:30.600092 | mon1 | ERROR
2026-08-26 21:00:30.600322 | mon1 | {
2026-08-26 21:00:30.600363 | mon1 |   "delta": "0:05:34.094652",
2026-08-26 21:00:30.600392 | mon1 |   "end": "2026-08-26 21:00:20.287384",
2026-08-26 21:00:30.600419 | mon1 |   "msg": "non-zero return code",
2026-08-26 21:00:30.600444 | mon1 |   "rc": 1,
2026-08-26 21:00:30.600469 | mon1 |   "start": "2026-08-26 20:54:46.192732"
2026-08-26 21:00:30.600494 | mon1 | }
failure
2026-08-26 21:00:30.604304 | 
2026-08-26 21:00:30.604387 | PLAY RECAP
2026-08-26 21:00:30.604455 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-26 21:00:30.604486 | 
2026-08-26 21:00:30.734944 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 21:00:30.740186 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 21:00:31.359611 | 
2026-08-26 21:00:31.359748 | PLAY [all]
2026-08-26 21:00:31.372418 | 
2026-08-26 21:00:31.372493 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-26 21:00:31.437997 | mon1 | ok
2026-08-26 21:00:31.442597 | osd1 | ok
2026-08-26 21:00:31.447922 | 
2026-08-26 21:00:31.447995 | TASK [fetch-output : Set log path for single node]
2026-08-26 21:00:31.473661 | mon1 | skipping: Conditional result was False
2026-08-26 21:00:31.485137 | osd1 | skipping: Conditional result was False
2026-08-26 21:00:31.497035 | 
2026-08-26 21:00:31.497185 | LOOP [fetch-output : Ensure local output dirs]
2026-08-26 21:00:31.932287 | mon1 -> localhost | changed: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/logs/mon1"
2026-08-26 21:00:31.950682 | osd1 -> localhost | changed: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/logs/osd1"
2026-08-26 21:00:32.142366 | mon1 -> localhost | changed: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/artifacts"
2026-08-26 21:00:32.162526 | osd1 -> localhost | ok: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/artifacts"
2026-08-26 21:00:32.366579 | osd1 -> localhost | changed: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/docs"
2026-08-26 21:00:32.384125 | mon1 -> localhost | ok: "/var/lib/zuul/builds/24bd1d28e0ef4a39a004a1511f0d503d/work/docs"
2026-08-26 21:00:32.384219 | mon1 -> localhost | changed: All items complete
2026-08-26 21:00:32.384257 | 
2026-08-26 21:00:32.401663 | 
2026-08-26 21:00:32.401746 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-26 21:00:33.107206 | osd1 | changed: .d..t...... ./
2026-08-26 21:00:33.112515 | mon1 | changed: .d..t...... ./
2026-08-26 21:00:33.605361 | mon1 | changed: .d..t...... ./
2026-08-26 21:00:33.613403 | osd1 | ok
2026-08-26 21:00:34.111134 | mon1 | changed: .d..t...... ./
2026-08-26 21:00:34.134238 | osd1 | ok
2026-08-26 21:00:34.134297 | osd1 | changed: All items complete
2026-08-26 21:00:34.134322 | 
2026-08-26 21:00:34.164806 | 
2026-08-26 21:00:34.165002 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-26 21:00:34.605466 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008615
2026-08-26 21:00:34.825477 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.008536
2026-08-26 21:00:34.853572 | 
2026-08-26 21:00:34.853720 | PLAY [all]
2026-08-26 21:00:34.860437 | 
2026-08-26 21:00:34.860507 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-26 21:00:35.356507 | mon1 | changed
2026-08-26 21:00:35.582416 | osd1 | changed
2026-08-26 21:00:35.592786 | 
2026-08-26 21:00:35.592838 | PLAY RECAP
2026-08-26 21:00:35.592888 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 21:00:35.592917 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 21:00:35.592936 | 
2026-08-26 21:00:35.734145 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 21:00:35.737819 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-26 21:00:36.336689 | 
2026-08-26 21:00:36.336845 | PLAY [localhost]
2026-08-26 21:00:36.346925 | 
2026-08-26 21:00:36.346997 | TASK [Generate Zuul manifest]
2026-08-26 21:00:36.369796 | localhost | ok
2026-08-26 21:00:36.388040 | 
2026-08-26 21:00:36.388139 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-26 21:00:36.769745 | localhost | changed
2026-08-26 21:00:36.783714 | 
2026-08-26 21:00:36.783811 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-26 21:00:36.816964 | localhost | ok
2026-08-26 21:00:36.826633 | 
2026-08-26 21:00:36.826700 | TASK [Upload logs]
2026-08-26 21:00:36.848735 | localhost | ok
2026-08-26 21:00:36.913323 | 
2026-08-26 21:00:36.913449 | TASK [Set zuul-log-path fact]
2026-08-26 21:00:36.936804 | localhost | ok
2026-08-26 21:00:36.950447 | 
2026-08-26 21:00:36.950518 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 21:00:36.983429 | localhost | ok
2026-08-26 21:00:36.992113 | 
2026-08-26 21:00:36.992184 | TASK [upload-logs : Create log directories]
2026-08-26 21:00:37.391952 | localhost | changed
2026-08-26 21:00:37.398612 | 
2026-08-26 21:00:37.398681 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-26 21:00:37.777340 | localhost -> localhost | ok: Runtime: 0:00:00.005293
2026-08-26 21:00:37.784237 | 
2026-08-26 21:00:37.784308 | TASK [upload-logs : Upload logs to log server]
2026-08-26 21:00:38.232642 | localhost | Output suppressed because no_log was given
2026-08-26 21:00:38.237828 | 
2026-08-26 21:00:38.237918 | LOOP [upload-logs : Compress console log and json output]
2026-08-26 21:00:38.328223 | localhost | skipping: Conditional result was False
2026-08-26 21:00:38.335852 | localhost | skipping: Conditional result was False
2026-08-26 21:00:38.354399 | 
2026-08-26 21:00:38.354582 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-26 21:00:38.440535 | localhost | skipping: Conditional result was False
2026-08-26 21:00:38.440892 | 
2026-08-26 21:00:38.444713 | localhost | skipping: Conditional result was False
2026-08-26 21:00:38.500184 | 
2026-08-26 21:00:38.500352 | LOOP [upload-logs : Upload console log and json output]