2026-08-24 15:26:58.553850 | Job console starting
2026-08-24 15:26:58.574366 | Updating git repos
2026-08-24 15:26:58.605128 | Cloning repos into workspace
2026-08-24 15:27:00.678451 | Restoring repo states
2026-08-24 15:27:00.687504 | Merging changes
2026-08-24 15:27:01.459635 | Checking out repos
2026-08-24 15:27:01.517396 | Preparing playbooks
2026-08-24 15:27:02.614949 | Running Ansible setup
2026-08-24 15:27:08.921083 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:27:09.512201 | 
2026-08-24 15:27:09.512312 | PLAY [localhost]
2026-08-24 15:27:09.519720 | 
2026-08-24 15:27:09.519791 | TASK [Gathering Facts]
2026-08-24 15:27:10.454940 | localhost | ok
2026-08-24 15:27:10.467021 | 
2026-08-24 15:27:10.467135 | TASK [Setup log path fact]
2026-08-24 15:27:10.489989 | localhost | ok
2026-08-24 15:27:10.503025 | 
2026-08-24 15:27:10.503122 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:27:10.536442 | localhost | ok
2026-08-24 15:27:10.544894 | 
2026-08-24 15:27:10.544986 | TASK [emit-job-header : Print job information]
2026-08-24 15:27:10.587318 | # Job Information
2026-08-24 15:27:10.587960 | Ansible Version: 2.16.18
2026-08-24 15:27:10.588048 | Job: ansible-collection-ceph-molecule-ha-ubuntu-noble
2026-08-24 15:27:10.588103 | Pipeline: check
2026-08-24 15:27:10.588147 | Executor: 2d72f0692154
2026-08-24 15:27:10.588186 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/42
2026-08-24 15:27:10.588261 | Event ID: 0042dcd0-9fcd-11f1-88c7-0d9f38273f22
2026-08-24 15:27:10.592576 | 
2026-08-24 15:27:10.592677 | LOOP [emit-job-header : Print node information]
2026-08-24 15:27:10.701587 | localhost | ok:
2026-08-24 15:27:10.702253 | localhost | # Node Information
2026-08-24 15:27:10.702307 | localhost | Inventory Hostname: mon1
2026-08-24 15:27:10.702341 | localhost | Hostname: np0000190874
2026-08-24 15:27:10.702370 | localhost | Username: zuul
2026-08-24 15:27:10.702405 | localhost | Distro: Ubuntu 24.04
2026-08-24 15:27:10.702435 | localhost | Provider: yul1
2026-08-24 15:27:10.702463 | localhost | Region: ca-ymq-1
2026-08-24 15:27:10.702490 | localhost | Label: ubuntu-noble
2026-08-24 15:27:10.702518 | localhost | Product Name: OpenStack Nova
2026-08-24 15:27:10.702545 | localhost | Interface IP: 199.19.213.151
2026-08-24 15:27:10.750490 | localhost | ok:
2026-08-24 15:27:10.750614 | localhost | # Node Information
2026-08-24 15:27:10.750652 | localhost | Inventory Hostname: osd1
2026-08-24 15:27:10.750683 | localhost | Hostname: np0000190875
2026-08-24 15:27:10.750712 | localhost | Username: zuul
2026-08-24 15:27:10.750740 | localhost | Distro: Ubuntu 24.04
2026-08-24 15:27:10.750768 | localhost | Provider: yul1
2026-08-24 15:27:10.750795 | localhost | Region: ca-ymq-1
2026-08-24 15:27:10.750822 | localhost | Label: ubuntu-noble
2026-08-24 15:27:10.750849 | localhost | Product Name: OpenStack Nova
2026-08-24 15:27:10.750877 | localhost | Interface IP: 199.19.213.133
2026-08-24 15:27:10.767234 | 
2026-08-24 15:27:10.767480 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 15:27:11.168438 | localhost -> localhost | changed
2026-08-24 15:27:11.177566 | 
2026-08-24 15:27:11.177962 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 15:27:12.139109 | localhost -> localhost | changed
2026-08-24 15:27:12.151112 | 
2026-08-24 15:27:12.151201 | PLAY [all]
2026-08-24 15:27:12.163450 | 
2026-08-24 15:27:12.163524 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 15:27:12.431091 | mon1 -> localhost | ok
2026-08-24 15:27:12.441052 | 
2026-08-24 15:27:12.441136 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 15:27:12.476513 | mon1 | ok
2026-08-24 15:27:12.483272 | osd1 | ok
2026-08-24 15:27:12.510140 | mon1 | included: /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 15:27:12.510214 | osd1 | included: /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 15:27:12.519731 | 
2026-08-24 15:27:12.519816 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 15:27:13.331676 | mon1 -> localhost | Generating public/private rsa key pair.
2026-08-24 15:27:13.331952 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/b81c5f88b7d543d180349e9b204d493a_id_rsa
2026-08-24 15:27:13.332014 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/b81c5f88b7d543d180349e9b204d493a_id_rsa.pub
2026-08-24 15:27:13.332053 | mon1 -> localhost | The key fingerprint is:
2026-08-24 15:27:13.332087 | mon1 -> localhost | SHA256:YN6N4Sho0z/Zi0RvR/i++v8CBmOJMJBeyHfHsrnap2Q zuul-build-sshkey
2026-08-24 15:27:13.332118 | mon1 -> localhost | The key's randomart image is:
2026-08-24 15:27:13.332148 | mon1 -> localhost | +---[RSA 3072]----+
2026-08-24 15:27:13.332178 | mon1 -> localhost | | ..+   .         |
2026-08-24 15:27:13.332208 | mon1 -> localhost | |  + = o o        |
2026-08-24 15:27:13.332237 | mon1 -> localhost | | . o +o*..       |
2026-08-24 15:27:13.332266 | mon1 -> localhost | |  .o o+===       |
2026-08-24 15:27:13.332295 | mon1 -> localhost | |  + o +oSoo      |
2026-08-24 15:27:13.332322 | mon1 -> localhost | | . . +.+ oo      |
2026-08-24 15:27:13.332350 | mon1 -> localhost | |     oE +.o.     |
2026-08-24 15:27:13.332378 | mon1 -> localhost | |    .+.+.+  .    |
2026-08-24 15:27:13.332406 | mon1 -> localhost | |      oooo+o.o.  |
2026-08-24 15:27:13.332435 | mon1 -> localhost | +----[SHA256]-----+
2026-08-24 15:27:13.332502 | mon1 -> localhost | ok: Runtime: 0:00:00.355216
2026-08-24 15:27:13.342263 | 
2026-08-24 15:27:13.342427 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 15:27:13.384619 | mon1 | ok
2026-08-24 15:27:13.403175 | osd1 | ok
2026-08-24 15:27:13.424803 | mon1 | included: /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 15:27:13.425054 | osd1 | included: /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 15:27:13.445420 | 
2026-08-24 15:27:13.445516 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 15:27:13.474825 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:13.476905 | osd1 | skipping: Conditional result was False
2026-08-24 15:27:13.485543 | 
2026-08-24 15:27:13.485655 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 15:27:14.069004 | mon1 | changed
2026-08-24 15:27:14.076083 | osd1 | changed
2026-08-24 15:27:14.086036 | 
2026-08-24 15:27:14.086228 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 15:27:14.318778 | mon1 | ok
2026-08-24 15:27:14.343914 | osd1 | ok
2026-08-24 15:27:14.351582 | 
2026-08-24 15:27:14.351716 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 15:27:15.011831 | osd1 | changed
2026-08-24 15:27:15.018927 | mon1 | changed
2026-08-24 15:27:15.027547 | 
2026-08-24 15:27:15.027679 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 15:27:15.646625 | mon1 | changed
2026-08-24 15:27:15.655520 | osd1 | changed
2026-08-24 15:27:15.663616 | 
2026-08-24 15:27:15.663700 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 15:27:15.699985 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:15.711267 | osd1 | skipping: Conditional result was False
2026-08-24 15:27:15.721074 | 
2026-08-24 15:27:15.721170 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 15:27:16.070223 | mon1 -> localhost | changed
2026-08-24 15:27:16.091773 | 
2026-08-24 15:27:16.091905 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 15:27:16.409782 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/b81c5f88b7d543d180349e9b204d493a_id_rsa (zuul-build-sshkey)
2026-08-24 15:27:16.410054 | mon1 -> localhost | ok: Runtime: 0:00:00.013466
2026-08-24 15:27:16.418308 | 
2026-08-24 15:27:16.418419 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 15:27:16.757088 | osd1 | ok
2026-08-24 15:27:16.765832 | mon1 | ok
2026-08-24 15:27:16.773141 | 
2026-08-24 15:27:16.773227 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 15:27:16.803489 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:16.814712 | osd1 | skipping: Conditional result was False
2026-08-24 15:27:16.837470 | 
2026-08-24 15:27:16.837592 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 15:27:17.175422 | osd1 | ok
2026-08-24 15:27:17.194074 | mon1 | ok
2026-08-24 15:27:17.201887 | 
2026-08-24 15:27:17.201966 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 15:27:18.071262 | mon1 | Output suppressed because no_log was given
2026-08-24 15:27:18.092714 | osd1 | Output suppressed because no_log was given
2026-08-24 15:27:18.106692 | 
2026-08-24 15:27:18.106767 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 15:27:18.333594 | mon1 | ok: "logs"
2026-08-24 15:27:18.333887 | mon1 | ok: All items complete
2026-08-24 15:27:18.333930 | 
2026-08-24 15:27:18.374984 | osd1 | ok: "logs"
2026-08-24 15:27:18.554442 | mon1 | ok: "artifacts"
2026-08-24 15:27:18.613227 | osd1 | ok: "artifacts"
2026-08-24 15:27:18.756482 | mon1 | ok: "docs"
2026-08-24 15:27:18.847611 | osd1 | ok: "docs"
2026-08-24 15:27:18.865826 | 
2026-08-24 15:27:18.866040 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 15:27:19.104184 | mon1 | changed: "logs"
2026-08-24 15:27:19.104475 | mon1 | ok: All items complete
2026-08-24 15:27:19.104505 | 
2026-08-24 15:27:19.125878 | osd1 | changed: "logs"
2026-08-24 15:27:19.296552 | mon1 | changed: "artifacts"
2026-08-24 15:27:19.350684 | osd1 | changed: "artifacts"
2026-08-24 15:27:19.503691 | mon1 | changed: "docs"
2026-08-24 15:27:19.559293 | osd1 | changed: "docs"
2026-08-24 15:27:19.588814 | 
2026-08-24 15:27:19.588921 | PLAY RECAP
2026-08-24 15:27:19.588991 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:27:19.589026 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 15:27:19.589053 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 15:27:19.589071 | 
2026-08-24 15:27:19.727562 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:27:19.733926 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:27:20.374730 | 
2026-08-24 15:27:20.374924 | PLAY [all]
2026-08-24 15:27:20.387843 | 
2026-08-24 15:27:20.388007 | TASK [setup-uv : Extract archive]
2026-08-24 15:27:22.822689 | mon1 | changed
2026-08-24 15:27:22.905736 | osd1 | changed
2026-08-24 15:27:22.912633 | 
2026-08-24 15:27:22.912727 | TASK [setup-uv : Print version]
2026-08-24 15:27:23.343418 | osd1 | uv 0.8.13
2026-08-24 15:27:23.354267 | mon1 | uv 0.8.13
2026-08-24 15:27:23.479986 | osd1 | ok: Runtime: 0:00:00.015119
2026-08-24 15:27:23.491015 | mon1 | ok: Runtime: 0:00:00.017015
2026-08-24 15:27:23.506699 | 
2026-08-24 15:27:23.506820 | TASK [Install Ansible collection siblings]
2026-08-24 15:27:23.967961 | mon1 | ok:
2026-08-24 15:27:23.968192 | mon1 | Skipping community.general: no checked-out sibling
2026-08-24 15:27:23.968231 | mon1 | Skipping ansible.utils: no checked-out sibling
2026-08-24 15:27:23.968262 | mon1 | Skipping vexxhost.containers: no checked-out sibling
2026-08-24 15:27:23.970865 | 
2026-08-24 15:27:23.970939 | PLAY RECAP
2026-08-24 15:27:23.971003 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:27:23.971058 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:27:23.971088 | 
2026-08-24 15:27:24.180118 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:27:24.184702 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:27:24.845171 | 
2026-08-24 15:27:24.845315 | PLAY [all]
2026-08-24 15:27:24.857840 | 
2026-08-24 15:27:24.857932 | LOOP [Check inventory directories]
2026-08-24 15:27:25.226460 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-24 15:27:25.440617 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-24 15:27:25.638781 | mon1 | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-24 15:27:25.658604 | 
2026-08-24 15:27:25.658894 | LOOP [Copy inventory file for Zuul]
2026-08-24 15:27:26.672752 | mon1 | changed:
2026-08-24 15:27:26.673003 | mon1 | {
2026-08-24 15:27:26.673046 | mon1 |   "ansible_loop_var": "item",
2026-08-24 15:27:26.673119 | mon1 |   "changed": false,
2026-08-24 15:27:26.673177 | mon1 |   "failed": false,
2026-08-24 15:27:26.673221 | mon1 |   "invocation": {
2026-08-24 15:27:26.673251 | mon1 |     "module_args": {
2026-08-24 15:27:26.673278 | mon1 |       "checksum_algorithm": "sha1",
2026-08-24 15:27:26.673305 | mon1 |       "follow": true,
2026-08-24 15:27:26.673332 | mon1 |       "get_attributes": true,
2026-08-24 15:27:26.673359 | mon1 |       "get_checksum": true,
2026-08-24 15:27:26.673385 | mon1 |       "get_mime": true,
2026-08-24 15:27:26.673410 | mon1 |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-24 15:27:26.673543 | mon1 |     }
2026-08-24 15:27:26.673586 | mon1 |   },
2026-08-24 15:27:26.673614 | mon1 |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-24 15:27:26.673640 | mon1 |   "stat": {
2026-08-24 15:27:26.673666 | mon1 |     "atime": 1787585237.942807,
2026-08-24 15:27:26.673694 | mon1 |     "attr_flags": "e",
2026-08-24 15:27:26.673722 | mon1 |     "attributes": [
2026-08-24 15:27:26.673753 | mon1 |       "extents"
2026-08-24 15:27:26.673781 | mon1 |     ],
2026-08-24 15:27:26.673807 | mon1 |     "block_size": 4096,
2026-08-24 15:27:26.673834 | mon1 |     "blocks": 8,
2026-08-24 15:27:26.673861 | mon1 |     "charset": "unknown",
2026-08-24 15:27:26.673891 | mon1 |     "ctime": 1787585237.9588084,
2026-08-24 15:27:26.673919 | mon1 |     "dev": 64769,
2026-08-24 15:27:26.673946 | mon1 |     "device_type": 0,
2026-08-24 15:27:26.673974 | mon1 |     "executable": true,
2026-08-24 15:27:26.674001 | mon1 |     "exists": true,
2026-08-24 15:27:26.674028 | mon1 |     "gid": 1000,
2026-08-24 15:27:26.674055 | mon1 |     "gr_name": "zuul",
2026-08-24 15:27:26.674083 | mon1 |     "inode": 1034272,
2026-08-24 15:27:26.674110 | mon1 |     "isblk": false,
2026-08-24 15:27:26.674138 | mon1 |     "ischr": false,
2026-08-24 15:27:26.674164 | mon1 |     "isdir": true,
2026-08-24 15:27:26.674192 | mon1 |     "isfifo": false,
2026-08-24 15:27:26.674219 | mon1 |     "isgid": false,
2026-08-24 15:27:26.674248 | mon1 |     "islnk": false,
2026-08-24 15:27:26.674276 | mon1 |     "isreg": false,
2026-08-24 15:27:26.674302 | mon1 |     "issock": false,
2026-08-24 15:27:26.674329 | mon1 |     "isuid": false,
2026-08-24 15:27:26.674356 | mon1 |     "mimetype": "unknown",
2026-08-24 15:27:26.674382 | mon1 |     "mode": "0755",
2026-08-24 15:27:26.674408 | mon1 |     "mtime": 1787585220.7301862,
2026-08-24 15:27:26.674433 | mon1 |     "nlink": 10,
2026-08-24 15:27:26.674460 | mon1 |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-24 15:27:26.674488 | mon1 |     "pw_name": "zuul",
2026-08-24 15:27:26.674516 | mon1 |     "readable": true,
2026-08-24 15:27:26.674545 | mon1 |     "rgrp": true,
2026-08-24 15:27:26.674575 | mon1 |     "roth": true,
2026-08-24 15:27:26.674605 | mon1 |     "rusr": true,
2026-08-24 15:27:26.674636 | mon1 |     "size": 4096,
2026-08-24 15:27:26.674683 | mon1 |     "uid": 1000,
2026-08-24 15:27:26.674714 | mon1 |     "version": "2240279472",
2026-08-24 15:27:26.674742 | mon1 |     "wgrp": false,
2026-08-24 15:27:26.674773 | mon1 |     "woth": false,
2026-08-24 15:27:26.674804 | mon1 |     "writeable": true,
2026-08-24 15:27:26.674832 | mon1 |     "wusr": true,
2026-08-24 15:27:26.674858 | mon1 |     "xgrp": true,
2026-08-24 15:27:26.674884 | mon1 |     "xoth": true,
2026-08-24 15:27:26.674909 | mon1 |     "xusr": true
2026-08-24 15:27:26.674936 | mon1 |   }
2026-08-24 15:27:26.674962 | mon1 | }
2026-08-24 15:27:26.675068 | mon1 | ok: All items complete
2026-08-24 15:27:26.675105 | 
2026-08-24 15:27:26.676993 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:26.677850 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:26.691144 | 
2026-08-24 15:27:26.691339 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 15:27:27.082401 | mon1 | changed: 2 replacements made
2026-08-24 15:27:27.084364 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:27.085336 | mon1 | skipping: Conditional result was False
2026-08-24 15:27:27.108116 | 
2026-08-24 15:27:27.108231 | TASK [Run Molecule scenario]
2026-08-24 15:27:27.598176 | mon1 | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-08-24 15:27:27.598315 | mon1 | Creating virtual environment at: .venv
2026-08-24 15:27:27.927241 | mon1 | Downloading netaddr (2.2MiB)
2026-08-24 15:27:27.927403 | mon1 | Downloading pygments (1.2MiB)
2026-08-24 15:27:27.927912 | mon1 | Downloading cryptography (4.3MiB)
2026-08-24 15:27:27.928189 | mon1 | Downloading ansible-core (2.1MiB)
2026-08-24 15:27:28.131411 | mon1 |  Downloading netaddr
2026-08-24 15:27:28.143709 | mon1 |  Downloading cryptography
2026-08-24 15:27:28.211912 | mon1 |  Downloading pygments
2026-08-24 15:27:28.401019 | mon1 |  Downloading ansible-core
2026-08-24 15:27:28.446495 | mon1 | Installed 37 packages in 44ms
2026-08-24 15:27:29.333277 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-08-24 15:27:29.333390 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-24 15:27:30.047287 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 15:27:30.047388 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-24 15:27:55.109030 | mon1 | INFO     [default > dependency] Executing
2026-08-24 15:27:55.109285 | mon1 | WARNING  [default > dependency] Missing roles requirements file: requirements.yml
2026-08-24 15:27:55.109498 | mon1 | WARNING  [default > dependency] Missing collections requirements file: collections.yml
2026-08-24 15:27:55.109654 | mon1 | WARNING  [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 15:27:55.116204 | mon1 | INFO     [default > cleanup] Executing
2026-08-24 15:27:55.116578 | mon1 | WARNING  [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:27:55.123853 | mon1 | INFO     [default > destroy] Executing
2026-08-24 15:27:55.123910 | mon1 | WARNING  [default > destroy] Skipping, '--destroy=never' requested.
2026-08-24 15:27:55.123994 | mon1 | INFO     [default > destroy] Executed: Successful
2026-08-24 15:27:55.132302 | mon1 | INFO     [default > syntax] Executing
2026-08-24 15:27:56.468955 | mon1 |
2026-08-24 15:27:56.469087 | mon1 | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-08-24 15:27:56.538859 | mon1 | INFO     [default > syntax] Executed: Successful
2026-08-24 15:27:56.549409 | mon1 | INFO     [default > create] Executing
2026-08-24 15:27:56.551560 | mon1 | WARNING  [default > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:27:56.558662 | mon1 | INFO     [default > prepare] Executing
2026-08-24 15:27:57.438512 | mon1 |
2026-08-24 15:27:57.438824 | mon1 | PLAY [Prepare] *****************************************************************
2026-08-24 15:27:57.439080 | mon1 |
2026-08-24 15:27:57.439360 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-24 15:27:57.439647 | mon1 | Monday 24 August 2026  15:27:57 +0000 (0:00:00.039)       0:00:00.039 *********
2026-08-24 15:27:58.719010 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-08-24 15:27:58.719208 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-08-24 15:27:58.719432 | mon1 | interpreter could change the meaning of that path. See
2026-08-24 15:27:58.719698 | mon1 | https://docs.ansible.com/ansible-
2026-08-24 15:27:58.719922 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:27:58.747794 | mon1 | [WARNING]: Platform linux on host osd1 is using the discovered Python
2026-08-24 15:27:58.747960 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-08-24 15:27:58.748143 | mon1 | interpreter could change the meaning of that path. See
2026-08-24 15:27:58.748290 | mon1 | https://docs.ansible.com/ansible-
2026-08-24 15:27:58.748422 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:27:58.753942 | mon1 | ok: [mon1]
2026-08-24 15:27:58.754103 | mon1 | ok: [osd1]
2026-08-24 15:27:58.754252 | mon1 |
2026-08-24 15:27:58.754435 | mon1 | TASK [Configure short hostname] ************************************************
2026-08-24 15:27:58.754651 | mon1 | Monday 24 August 2026  15:27:58 +0000 (0:00:01.316)       0:00:01.356 *********
2026-08-24 15:27:59.602487 | mon1 | changed: [mon1]
2026-08-24 15:27:59.602760 | mon1 | changed: [osd1]
2026-08-24 15:27:59.602952 | mon1 |
2026-08-24 15:27:59.603164 | mon1 | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 15:27:59.603388 | mon1 | Monday 24 August 2026  15:27:59 +0000 (0:00:00.848)       0:00:02.204 *********
2026-08-24 15:27:59.931256 | mon1 | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 15:27:59.931481 | mon1 | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 15:27:59.931788 | mon1 | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 15:27:59.968576 | mon1 | changed: [osd1]
2026-08-24 15:27:59.968746 | mon1 | changed: [mon1]
2026-08-24 15:27:59.968952 | mon1 |
2026-08-24 15:27:59.969123 | mon1 | TASK [Update apt cache] ********************************************************
2026-08-24 15:27:59.969288 | mon1 | Monday 24 August 2026  15:27:59 +0000 (0:00:00.366)       0:00:02.570 *********
2026-08-24 15:28:06.153479 | mon1 | changed: [osd1]
2026-08-24 15:28:06.153744 | mon1 | changed: [mon1]
2026-08-24 15:28:06.153985 | mon1 |
2026-08-24 15:28:06.154370 | mon1 | PLAY [Create devices for Ceph] *************************************************
2026-08-24 15:28:06.154644 | mon1 |
2026-08-24 15:28:06.154915 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-24 15:28:06.155213 | mon1 | Monday 24 August 2026  15:28:06 +0000 (0:00:06.184)       0:00:08.755 *********
2026-08-24 15:28:07.063223 | mon1 | ok: [osd1]
2026-08-24 15:28:07.063385 | mon1 |
2026-08-24 15:28:07.063717 | mon1 | TASK [Install depedencies] *****************************************************
2026-08-24 15:28:07.064008 | mon1 | Monday 24 August 2026  15:28:07 +0000 (0:00:00.909)       0:00:09.664 *********
2026-08-24 15:28:30.976377 | mon1 | changed: [osd1]
2026-08-24 15:28:30.976470 | mon1 |
2026-08-24 15:28:30.976646 | mon1 | TASK [Start up service] ********************************************************
2026-08-24 15:28:30.976779 | mon1 | Monday 24 August 2026  15:28:30 +0000 (0:00:23.913)       0:00:33.578 *********
2026-08-24 15:28:31.686837 | mon1 | ok: [osd1]
2026-08-24 15:28:31.686926 | mon1 |
2026-08-24 15:28:31.687144 | mon1 | TASK [Generate lvm.conf] *******************************************************
2026-08-24 15:28:31.687349 | mon1 | Monday 24 August 2026  15:28:31 +0000 (0:00:00.710)       0:00:34.288 *********
2026-08-24 15:28:32.082491 | mon1 | ok: [osd1]
2026-08-24 15:28:32.082654 | mon1 |
2026-08-24 15:28:32.082958 | mon1 | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 15:28:32.083219 | mon1 | Monday 24 August 2026  15:28:32 +0000 (0:00:00.395)       0:00:34.684 *********
2026-08-24 15:28:32.919501 | mon1 | changed: [osd1]
2026-08-24 15:28:32.919700 | mon1 |
2026-08-24 15:28:32.919978 | mon1 | TASK [Get list of all loopback devices] ****************************************
2026-08-24 15:28:32.920268 | mon1 | Monday 24 August 2026  15:28:32 +0000 (0:00:00.836)       0:00:35.520 *********
2026-08-24 15:28:33.205769 | mon1 | ok: [osd1]
2026-08-24 15:28:33.206078 | mon1 |
2026-08-24 15:28:33.206314 | mon1 | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 15:28:33.206555 | mon1 | Monday 24 August 2026  15:28:33 +0000 (0:00:00.286)       0:00:35.807 *********
2026-08-24 15:28:33.235864 | mon1 | skipping: [osd1]
2026-08-24 15:28:33.236115 | mon1 |
2026-08-24 15:28:33.236192 | mon1 | TASK [Create devices for Ceph] *************************************************
2026-08-24 15:28:33.236366 | mon1 | Monday 24 August 2026  15:28:33 +0000 (0:00:00.030)       0:00:35.837 *********
2026-08-24 15:28:33.974682 | mon1 | changed: [osd1] => (item=osd0)
2026-08-24 15:28:33.974776 | mon1 | changed: [osd1] => (item=osd1)
2026-08-24 15:28:33.974890 | mon1 | changed: [osd1] => (item=osd2)
2026-08-24 15:28:33.975063 | mon1 |
2026-08-24 15:28:33.975226 | mon1 | TASK [Set permissions on loopback devices] *************************************
2026-08-24 15:28:33.975408 | mon1 | Monday 24 August 2026  15:28:33 +0000 (0:00:00.738)       0:00:36.575 *********
2026-08-24 15:28:34.869762 | mon1 | changed: [osd1] => (item=osd0)
2026-08-24 15:28:34.869893 | mon1 | changed: [osd1] => (item=osd1)
2026-08-24 15:28:34.870081 | mon1 | changed: [osd1] => (item=osd2)
2026-08-24 15:28:34.870344 | mon1 |
2026-08-24 15:28:34.870592 | mon1 | TASK [Start loop devices] ******************************************************
2026-08-24 15:28:34.870877 | mon1 | Monday 24 August 2026  15:28:34 +0000 (0:00:00.895)       0:00:37.471 *********
2026-08-24 15:28:35.765823 | mon1 | changed: [osd1] => (item=osd0)
2026-08-24 15:28:35.766076 | mon1 | changed: [osd1] => (item=osd1)
2026-08-24 15:28:35.766416 | mon1 | changed: [osd1] => (item=osd2)
2026-08-24 15:28:35.766697 | mon1 |
2026-08-24 15:28:35.766960 | mon1 | TASK [Create a volume group for each loop device] ******************************
2026-08-24 15:28:35.767230 | mon1 | Monday 24 August 2026  15:28:35 +0000 (0:00:00.896)       0:00:38.367 *********
2026-08-24 15:28:37.321876 | mon1 | changed: [osd1] => (item=osd0)
2026-08-24 15:28:37.322126 | mon1 | changed: [osd1] => (item=osd1)
2026-08-24 15:28:37.322409 | mon1 | changed: [osd1] => (item=osd2)
2026-08-24 15:28:37.322746 | mon1 |
2026-08-24 15:28:37.323029 | mon1 | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 15:28:37.323342 | mon1 | Monday 24 August 2026  15:28:37 +0000 (0:00:01.555)       0:00:39.923 *********
2026-08-24 15:28:38.842750 | mon1 | changed: [osd1] => (item=ceph-osd1-osd0)
2026-08-24 15:28:38.842803 | mon1 | changed: [osd1] => (item=ceph-osd1-osd1)
2026-08-24 15:28:38.842811 | mon1 | changed: [osd1] => (item=ceph-osd1-osd2)
2026-08-24 15:28:38.842819 | mon1 |
2026-08-24 15:28:38.842830 | mon1 | PLAY RECAP *********************************************************************
2026-08-24 15:28:38.843694 | mon1 | mon1                       : ok=4    changed=3    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-24 15:28:38.843859 | mon1 | osd1                       : ok=15   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 15:28:38.844161 | mon1 |
2026-08-24 15:28:38.844294 | mon1 |
2026-08-24 15:28:38.844445 | mon1 | TASKS RECAP ********************************************************************
2026-08-24 15:28:38.844600 | mon1 | Monday 24 August 2026  15:28:38 +0000 (0:00:01.520)       0:00:41.443 *********
2026-08-24 15:28:38.844762 | mon1 | ===============================================================================
2026-08-24 15:28:38.844905 | mon1 | Install depedencies ---------------------------------------------------- 23.91s
2026-08-24 15:28:38.845046 | mon1 | Update apt cache -------------------------------------------------------- 6.18s
2026-08-24 15:28:38.845186 | mon1 | Create a volume group for each loop device ------------------------------ 1.56s
2026-08-24 15:28:38.845327 | mon1 | Create a logical volume for each loop device ---------------------------- 1.52s
2026-08-24 15:28:38.845465 | mon1 | Gathering Facts --------------------------------------------------------- 1.32s
2026-08-24 15:28:38.845602 | mon1 | Gathering Facts --------------------------------------------------------- 0.91s
2026-08-24 15:28:38.845786 | mon1 | Start loop devices ------------------------------------------------------ 0.90s
2026-08-24 15:28:38.845942 | mon1 | Set permissions on loopback devices ------------------------------------- 0.90s
2026-08-24 15:28:38.846888 | mon1 | Configure short hostname ------------------------------------------------ 0.85s
2026-08-24 15:28:38.846902 | mon1 | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.84s
2026-08-24 15:28:38.846908 | mon1 | Create devices for Ceph ------------------------------------------------- 0.74s
2026-08-24 15:28:38.846914 | mon1 | Start up service -------------------------------------------------------- 0.71s
2026-08-24 15:28:38.846919 | mon1 | Generate lvm.conf ------------------------------------------------------- 0.40s
2026-08-24 15:28:38.846924 | mon1 | Ensure hostname inside hosts file --------------------------------------- 0.37s
2026-08-24 15:28:38.846930 | mon1 | Get list of all loopback devices ---------------------------------------- 0.29s
2026-08-24 15:28:38.846935 | mon1 | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-24 15:28:38.927670 | mon1 | INFO     [default > prepare] Executed: Successful
2026-08-24 15:28:38.937528 | mon1 | INFO     [default > converge] Executing
2026-08-24 15:28:40.061325 | mon1 |
2026-08-24 15:28:40.061747 | mon1 | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 15:28:40.062060 | mon1 |
2026-08-24 15:28:40.062369 | mon1 | TASK [Gathering Facts] *********************************************************
2026-08-24 15:28:40.062707 | mon1 | Monday 24 August 2026  15:28:40 +0000 (0:00:00.055)       0:00:00.055 *********
2026-08-24 15:28:41.180771 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-08-24 15:28:41.180955 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-08-24 15:28:41.181108 | mon1 | interpreter could change the meaning of that path. See
2026-08-24 15:28:41.181294 | mon1 | https://docs.ansible.com/ansible-
2026-08-24 15:28:41.181491 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:28:41.196884 | mon1 | ok: [mon1]
2026-08-24 15:28:41.197470 | mon1 |
2026-08-24 15:28:41.197485 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:28:41.197491 | mon1 | Monday 24 August 2026  15:28:41 +0000 (0:00:01.135)       0:00:01.190 *********
2026-08-24 15:28:41.531807 | mon1 | ok: [mon1]
2026-08-24 15:28:41.532086 | mon1 |
2026-08-24 15:28:41.532475 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:28:41.532954 | mon1 | Monday 24 August 2026  15:28:41 +0000 (0:00:00.334)       0:00:01.524 *********
2026-08-24 15:28:41.578703 | mon1 | skipping: [mon1]
2026-08-24 15:28:41.578978 | mon1 |
2026-08-24 15:28:41.579254 | mon1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 15:28:41.579514 | mon1 | Monday 24 August 2026  15:28:41 +0000 (0:00:00.047)       0:00:01.572 *********
2026-08-24 15:28:41.993894 | mon1 | changed: [mon1]
2026-08-24 15:28:41.994180 | mon1 |
2026-08-24 15:28:41.994479 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:28:41.994774 | mon1 | Monday 24 August 2026  15:28:41 +0000 (0:00:00.415)       0:00:01.987 *********
2026-08-24 15:28:42.097431 | mon1 | ok: [mon1] => {
2026-08-24 15:28:42.097807 | mon1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 15:28:42.098219 | mon1 | }
2026-08-24 15:28:42.098472 | mon1 |
2026-08-24 15:28:42.098962 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:28:42.099261 | mon1 | Monday 24 August 2026  15:28:42 +0000 (0:00:00.103)       0:00:02.090 *********
2026-08-24 15:28:42.956802 | mon1 | changed: [mon1]
2026-08-24 15:28:42.956910 | mon1 |
2026-08-24 15:28:42.956982 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:28:42.957343 | mon1 | Monday 24 August 2026  15:28:42 +0000 (0:00:00.859)       0:00:02.949 *********
2026-08-24 15:28:43.006685 | mon1 | skipping: [mon1]
2026-08-24 15:28:43.006735 | mon1 |
2026-08-24 15:28:43.006740 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:28:43.006745 | mon1 | Monday 24 August 2026  15:28:43 +0000 (0:00:00.050)       0:00:02.999 *********
2026-08-24 15:28:43.060666 | mon1 | skipping: [mon1]
2026-08-24 15:28:43.060965 | mon1 |
2026-08-24 15:28:43.061237 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:28:43.061494 | mon1 | Monday 24 August 2026  15:28:43 +0000 (0:00:00.054)       0:00:03.054 *********
2026-08-24 15:28:43.341559 | mon1 | ok: [mon1]
2026-08-24 15:28:43.341724 | mon1 |
2026-08-24 15:28:43.341919 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:28:43.342083 | mon1 | Monday 24 August 2026  15:28:43 +0000 (0:00:00.281)       0:00:03.335 *********
2026-08-24 15:28:44.698729 | mon1 | ok: [mon1]
2026-08-24 15:28:44.699003 | mon1 |
2026-08-24 15:28:44.699347 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:28:44.699747 | mon1 | Monday 24 August 2026  15:28:44 +0000 (0:00:01.356)       0:00:04.692 *********
2026-08-24 15:28:44.938298 | mon1 | ok: [mon1] => {
2026-08-24 15:28:44.938475 | mon1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 15:28:44.938807 | mon1 | }
2026-08-24 15:28:44.939094 | mon1 |
2026-08-24 15:28:44.939362 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:28:44.939642 | mon1 | Monday 24 August 2026  15:28:44 +0000 (0:00:00.239)       0:00:04.931 *********
2026-08-24 15:28:46.077071 | mon1 | changed: [mon1]
2026-08-24 15:28:46.077268 | mon1 |
2026-08-24 15:28:46.077576 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:28:46.077917 | mon1 | Monday 24 August 2026  15:28:46 +0000 (0:00:01.138)       0:00:06.070 *********
2026-08-24 15:28:49.421734 | mon1 | changed: [mon1]
2026-08-24 15:28:49.421811 | mon1 |
2026-08-24 15:28:49.421822 | mon1 | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 15:28:49.421997 | mon1 | Monday 24 August 2026  15:28:49 +0000 (0:00:03.344)       0:00:09.414 *********
2026-08-24 15:28:49.459209 | mon1 | skipping: [mon1]
2026-08-24 15:28:49.459349 | mon1 |
2026-08-24 15:28:49.459607 | mon1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 15:28:49.459939 | mon1 | Monday 24 August 2026  15:28:49 +0000 (0:00:00.036)       0:00:09.451 *********
2026-08-24 15:28:49.498197 | mon1 | skipping: [mon1]
2026-08-24 15:28:49.498514 | mon1 |
2026-08-24 15:28:49.498958 | mon1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 15:28:49.499230 | mon1 | Monday 24 August 2026  15:28:49 +0000 (0:00:00.039)       0:00:09.491 *********
2026-08-24 15:28:49.529719 | mon1 | skipping: [mon1]
2026-08-24 15:28:49.529926 | mon1 |
2026-08-24 15:28:49.530240 | mon1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 15:28:49.530536 | mon1 | Monday 24 August 2026  15:28:49 +0000 (0:00:00.031)       0:00:09.523 *********
2026-08-24 15:28:57.924240 | mon1 | changed: [mon1]
2026-08-24 15:28:57.924454 | mon1 |
2026-08-24 15:28:57.924770 | mon1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 15:28:57.925067 | mon1 | Monday 24 August 2026  15:28:57 +0000 (0:00:08.394)       0:00:17.917 *********
2026-08-24 15:28:58.604220 | mon1 | changed: [mon1]
2026-08-24 15:28:58.604427 | mon1 |
2026-08-24 15:28:58.604937 | mon1 | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 15:28:58.605221 | mon1 | Monday 24 August 2026  15:28:58 +0000 (0:00:00.679)       0:00:18.597 *********
2026-08-24 15:28:59.828822 | mon1 | changed: [mon1] => (item={'path': '/etc/containerd'})
2026-08-24 15:28:59.828909 | mon1 | changed: [mon1] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 15:28:59.828919 | mon1 | changed: [mon1] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 15:28:59.828932 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 15:28:59.829553 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 15:28:59.829653 | mon1 |
2026-08-24 15:28:59.829667 | mon1 | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 15:28:59.829675 | mon1 | Monday 24 August 2026  15:28:59 +0000 (0:00:01.224)       0:00:19.821 *********
2026-08-24 15:29:00.677697 | mon1 | changed: [mon1]
2026-08-24 15:29:00.677746 | mon1 |
2026-08-24 15:29:00.677755 | mon1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 15:29:00.677763 | mon1 | Monday 24 August 2026  15:29:00 +0000 (0:00:00.839)       0:00:20.661 *********
2026-08-24 15:29:00.677771 | mon1 |
2026-08-24 15:29:00.677782 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:29:00.678026 | mon1 | Monday 24 August 2026  15:29:00 +0000 (0:00:00.008)       0:00:20.670 *********
2026-08-24 15:29:01.815245 | mon1 | ok: [mon1]
2026-08-24 15:29:01.815325 | mon1 |
2026-08-24 15:29:01.815528 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 15:29:01.815699 | mon1 | Monday 24 August 2026  15:29:01 +0000 (0:00:01.137)       0:00:21.807 *********
2026-08-24 15:29:03.411705 | mon1 | changed: [mon1]
2026-08-24 15:29:03.411867 | mon1 |
2026-08-24 15:29:03.412548 | mon1 | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 15:29:03.412592 | mon1 | Monday 24 August 2026  15:29:03 +0000 (0:00:01.597)       0:00:23.404 *********
2026-08-24 15:29:04.145390 | mon1 | changed: [mon1]
2026-08-24 15:29:04.145461 | mon1 |
2026-08-24 15:29:04.145475 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:29:04.145489 | mon1 | Monday 24 August 2026  15:29:04 +0000 (0:00:00.732)       0:00:24.137 *********
2026-08-24 15:29:04.437355 | mon1 | ok: [mon1]
2026-08-24 15:29:04.437408 | mon1 |
2026-08-24 15:29:04.437420 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:29:04.437431 | mon1 | Monday 24 August 2026  15:29:04 +0000 (0:00:00.291)       0:00:24.429 *********
2026-08-24 15:29:04.549781 | mon1 | ok: [mon1] => {
2026-08-24 15:29:04.549847 | mon1 |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 15:29:04.549859 | mon1 | }
2026-08-24 15:29:04.549870 | mon1 |
2026-08-24 15:29:04.549886 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:29:04.550000 | mon1 | Monday 24 August 2026  15:29:04 +0000 (0:00:00.113)       0:00:24.542 *********
2026-08-24 15:29:05.609186 | mon1 | changed: [mon1]
2026-08-24 15:29:05.609295 | mon1 |
2026-08-24 15:29:05.611864 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:29:05.611983 | mon1 | Monday 24 August 2026  15:29:05 +0000 (0:00:01.059)       0:00:25.602 *********
2026-08-24 15:29:10.321471 | mon1 | changed: [mon1]
2026-08-24 15:29:10.321513 | mon1 |
2026-08-24 15:29:10.321518 | mon1 | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 15:29:10.321523 | mon1 | Monday 24 August 2026  15:29:10 +0000 (0:00:04.711)       0:00:30.314 *********
2026-08-24 15:29:11.287814 | mon1 | ok: [mon1]
2026-08-24 15:29:11.287907 | mon1 |
2026-08-24 15:29:11.287918 | mon1 | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 15:29:11.287928 | mon1 | Monday 24 August 2026  15:29:11 +0000 (0:00:00.965)       0:00:31.280 *********
2026-08-24 15:29:11.847265 | mon1 | changed: [mon1]
2026-08-24 15:29:11.847324 | mon1 |
2026-08-24 15:29:11.847334 | mon1 | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 15:29:11.847343 | mon1 | Monday 24 August 2026  15:29:11 +0000 (0:00:00.559)       0:00:31.839 *********
2026-08-24 15:29:12.415291 | mon1 | changed: [mon1]
2026-08-24 15:29:12.415340 | mon1 |
2026-08-24 15:29:12.415351 | mon1 | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 15:29:12.415361 | mon1 | Monday 24 August 2026  15:29:12 +0000 (0:00:00.568)       0:00:32.407 *********
2026-08-24 15:29:13.115399 | mon1 | changed: [mon1] => (item={'path': '/etc/docker'})
2026-08-24 15:29:13.115448 | mon1 | changed: [mon1] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 15:29:13.115453 | mon1 | changed: [mon1] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 15:29:13.115457 | mon1 |
2026-08-24 15:29:13.115461 | mon1 | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 15:29:13.115465 | mon1 | Monday 24 August 2026  15:29:13 +0000 (0:00:00.698)       0:00:33.105 *********
2026-08-24 15:29:13.705845 | mon1 | changed: [mon1]
2026-08-24 15:29:13.705901 | mon1 |
2026-08-24 15:29:13.705910 | mon1 | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 15:29:13.705919 | mon1 | Monday 24 August 2026  15:29:13 +0000 (0:00:00.592)       0:00:33.698 *********
2026-08-24 15:29:14.295812 | mon1 | changed: [mon1]
2026-08-24 15:29:14.295915 | mon1 |
2026-08-24 15:29:14.295932 | mon1 | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 15:29:14.295944 | mon1 | Monday 24 August 2026  15:29:14 +0000 (0:00:00.581)       0:00:34.279 *********
2026-08-24 15:29:14.295955 | mon1 |
2026-08-24 15:29:14.295964 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:29:14.295974 | mon1 | Monday 24 August 2026  15:29:14 +0000 (0:00:00.008)       0:00:34.287 *********
2026-08-24 15:29:15.201807 | mon1 | ok: [mon1]
2026-08-24 15:29:15.201880 | mon1 |
2026-08-24 15:29:15.201891 | mon1 | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 15:29:15.201908 | mon1 | Monday 24 August 2026  15:29:15 +0000 (0:00:00.906)       0:00:35.194 *********
2026-08-24 15:29:17.451854 | mon1 | changed: [mon1]
2026-08-24 15:29:17.451929 | mon1 |
2026-08-24 15:29:17.452392 | mon1 | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 15:29:17.452860 | mon1 | Monday 24 August 2026  15:29:17 +0000 (0:00:02.250)       0:00:37.444 *********
2026-08-24 15:29:18.140517 | mon1 | changed: [mon1]
2026-08-24 15:29:18.140737 | mon1 |
2026-08-24 15:29:18.141115 | mon1 | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 15:29:18.141695 | mon1 | Monday 24 August 2026  15:29:18 +0000 (0:00:00.688)       0:00:38.133 *********
2026-08-24 15:29:18.199421 | mon1 | ok: [mon1] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/debian.yml)
2026-08-24 15:29:18.199643 | mon1 |
2026-08-24 15:29:18.199932 | mon1 | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 15:29:18.200234 | mon1 | Monday 24 August 2026  15:29:18 +0000 (0:00:00.059)       0:00:38.192 *********
2026-08-24 15:29:38.141873 | mon1 | changed: [mon1]
2026-08-24 15:29:38.141971 | mon1 |
2026-08-24 15:29:38.141982 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 15:29:38.141994 | mon1 | Monday 24 August 2026  15:29:38 +0000 (0:00:19.940)       0:00:58.133 *********
2026-08-24 15:29:38.983334 | mon1 | ok: [mon1] => (item=systemd-timesyncd)
2026-08-24 15:29:38.983384 | mon1 | ok: [mon1] => (item=ssh)
2026-08-24 15:29:38.983397 | mon1 |
2026-08-24 15:29:38.983527 | mon1 | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 15:29:38.983831 | mon1 | Monday 24 August 2026  15:29:38 +0000 (0:00:00.843)       0:00:58.976 *********
2026-08-24 15:29:40.067384 | mon1 | changed: [mon1]
2026-08-24 15:29:40.067465 | mon1 |
2026-08-24 15:29:40.067479 | mon1 | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 15:29:40.067491 | mon1 | Monday 24 August 2026  15:29:40 +0000 (0:00:01.083)       0:01:00.059 *********
2026-08-24 15:29:40.335593 | mon1 | ok: [mon1]
2026-08-24 15:29:40.335701 | mon1 |
2026-08-24 15:29:40.335716 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 15:29:40.335730 | mon1 | Monday 24 August 2026  15:29:40 +0000 (0:00:00.268)       0:01:00.327 *********
2026-08-24 15:29:41.051087 | mon1 | changed: [mon1]
2026-08-24 15:29:41.051166 | mon1 |
2026-08-24 15:29:41.051241 | mon1 | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 15:29:41.051381 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.715)       0:01:01.043 *********
2026-08-24 15:29:41.431793 | mon1 | changed: [mon1]
2026-08-24 15:29:41.431941 | mon1 |
2026-08-24 15:29:41.431993 | mon1 | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 15:29:41.432018 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.380)       0:01:01.424 *********
2026-08-24 15:29:41.567086 | mon1 | ok: [mon1]
2026-08-24 15:29:41.567150 | mon1 |
2026-08-24 15:29:41.567259 | mon1 | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 15:29:41.567380 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.136)       0:01:01.560 *********
2026-08-24 15:29:41.839819 | mon1 | ok: [mon1] => (item=mon1)
2026-08-24 15:29:41.839899 | mon1 |
2026-08-24 15:29:41.839913 | mon1 | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 15:29:41.839932 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.270)       0:01:01.830 *********
2026-08-24 15:29:41.902408 | mon1 | ok: [mon1]
2026-08-24 15:29:41.902504 | mon1 |
2026-08-24 15:29:41.902531 | mon1 | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 15:29:41.902544 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.062)       0:01:01.893 *********
2026-08-24 15:29:41.990754 | mon1 | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for mon1
2026-08-24 15:29:41.990837 | mon1 |
2026-08-24 15:29:41.991436 | mon1 | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 15:29:41.991508 | mon1 | Monday 24 August 2026  15:29:41 +0000 (0:00:00.089)       0:01:01.983 *********
2026-08-24 15:29:42.342215 | mon1 | changed: [mon1]
2026-08-24 15:29:42.342273 | mon1 |
2026-08-24 15:29:42.342287 | mon1 | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 15:29:42.342299 | mon1 | Monday 24 August 2026  15:29:42 +0000 (0:00:00.350)       0:01:02.334 *********
2026-08-24 15:29:43.123761 | mon1 | changed: [mon1] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 15:29:43.123823 | mon1 | changed: [mon1] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 15:29:43.124666 | mon1 | changed: [mon1] => (item={'option': 'mon data avail warn', 'section': 'mon', 'value': 10})
2026-08-24 15:29:43.124682 | mon1 |
2026-08-24 15:29:43.124692 | mon1 | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 15:29:43.124810 | mon1 | Monday 24 August 2026  15:29:43 +0000 (0:00:00.782)       0:01:03.116 *********
2026-08-24 15:31:22.519735 | mon1 | ok: [mon1]
2026-08-24 15:31:22.519798 | mon1 |
2026-08-24 15:31:22.519817 | mon1 | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 15:31:22.520034 | mon1 | Monday 24 August 2026  15:31:22 +0000 (0:01:39.396)       0:02:42.512 *********
2026-08-24 15:31:22.795017 | mon1 | changed: [mon1]
2026-08-24 15:31:22.795092 | mon1 |
2026-08-24 15:31:22.795106 | mon1 | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 15:31:22.795119 | mon1 | Monday 24 August 2026  15:31:22 +0000 (0:00:00.274)       0:02:42.787 *********
2026-08-24 15:31:22.842545 | mon1 | ok: [mon1]
2026-08-24 15:31:22.842581 | mon1 |
2026-08-24 15:31:22.842590 | mon1 | TASK [Install Ceph host] *******************************************************
2026-08-24 15:31:22.842598 | mon1 | Monday 24 August 2026  15:31:22 +0000 (0:00:00.045)       0:02:42.833 *********
2026-08-24 15:31:22.919633 | mon1 | included: vexxhost.ceph.cephadm_host for mon1
2026-08-24 15:31:22.919662 | mon1 |
2026-08-24 15:31:22.919676 | mon1 | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 15:31:22.919682 | mon1 | Monday 24 August 2026  15:31:22 +0000 (0:00:00.080)       0:02:42.913 *********
2026-08-24 15:31:24.843030 | mon1 | ok: [mon1]
2026-08-24 15:31:24.843136 | mon1 |
2026-08-24 15:31:24.843289 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 15:31:24.843429 | mon1 | Monday 24 August 2026  15:31:24 +0000 (0:00:01.920)       0:02:44.833 *********
2026-08-24 15:31:24.909074 | mon1 | ok: [mon1] => (item=mon1)
2026-08-24 15:31:24.909250 | mon1 |
2026-08-24 15:31:24.909456 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 15:31:24.909677 | mon1 | Monday 24 August 2026  15:31:24 +0000 (0:00:00.068)       0:02:44.902 *********
2026-08-24 15:31:25.380101 | mon1 | ok: [mon1]
2026-08-24 15:31:25.380161 | mon1 |
2026-08-24 15:31:25.380288 | mon1 | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 15:31:25.380414 | mon1 | Monday 24 August 2026  15:31:25 +0000 (0:00:00.471)       0:02:45.374 *********
2026-08-24 15:31:28.507394 | mon1 | ok: [mon1]
2026-08-24 15:31:28.507475 | mon1 |
2026-08-24 15:31:28.507658 | mon1 | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 15:31:28.507854 | mon1 | Monday 24 August 2026  15:31:28 +0000 (0:00:03.126)       0:02:48.501 *********
2026-08-24 15:32:21.730038 | mon1 | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-24 15:32:21.730142 | mon1 | fatal: [mon1]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n  File \"<stdin>\", line 107, in <module>\n  File \"<stdin>\", line 99, in _ansiballz_main\n  File \"<stdin>\", line 47, in invoke_module\n  File \"<frozen runpy>\", line 226, in run_module\n  File \"<frozen runpy>\", line 98, in _run_module_code\n  File \"<frozen runpy>\", line 88, in _run_code\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_igwyeo_r/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in <module>\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_igwyeo_r/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 198, in main\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_igwyeo_r/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 177, in run_module\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_igwyeo_r/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/1dff0e0f-3c44-48da-81cd-4f3c6e8722b2/mon.mon1/config\n2026-08-24T15:32:21.554+0000 7978cca65640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYY4xqMA7ZBSAAPeU3eZBx4IEVp0Bkgk9jVY52kn58b+OYZ5Wryj8nvlo=: Malformed input [buffer:3]\n2026-08-24T15:32:21.554+0000 7978cca65640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:32:21.556+0000 7978cca65640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYY4xqMA7ZBSAAPeU3eZBx4IEVp0Bkgk9jVY52kn58b+OYZ5Wryj8nvlo=: Malformed input [buffer:3]\n2026-08-24T15:32:21.556+0000 7978cca65640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:32:21.557+0000 7978cca65640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYY4xqMA7ZBSAAPeU3eZBx4IEVp0Bkgk9jVY52kn58b+OYZ5Wryj8nvlo=: Malformed input [buffer:3]\n2026-08-24T15:32:21.557+0000 7978cca65640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:32:21.557+0000 7978cca65640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE: No start of json char found\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-24 15:32:21.732746 | mon1 |
2026-08-24 15:32:21.732821 | mon1 | PLAY RECAP *********************************************************************
2026-08-24 15:32:21.732834 | mon1 | mon1                       : ok=51   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-24 15:32:21.732852 | mon1 |
2026-08-24 15:32:21.733688 | mon1 |
2026-08-24 15:32:21.733728 | mon1 | TASKS RECAP ********************************************************************
2026-08-24 15:32:21.733737 | mon1 | Monday 24 August 2026  15:32:21 +0000 (0:00:53.225)       0:03:41.726 *********
2026-08-24 15:32:21.733744 | mon1 | ===============================================================================
2026-08-24 15:32:21.733751 | mon1 | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 99.40s
2026-08-24 15:32:21.733762 | mon1 | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 53.23s
2026-08-24 15:32:21.734732 | mon1 | vexxhost.ceph.cephadm : Install packages ------------------------------- 19.94s
2026-08-24 15:32:21.734795 | mon1 | vexxhost.containers.containerd : Install AppArmor packages -------------- 8.39s
2026-08-24 15:32:21.734806 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 4.71s
2026-08-24 15:32:21.734816 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 3.34s
2026-08-24 15:32:21.734825 | mon1 | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 3.13s
2026-08-24 15:32:21.734834 | mon1 | vexxhost.containers.docker : Restart docker ----------------------------- 2.25s
2026-08-24 15:32:21.734850 | mon1 | vexxhost.containers.containerd : Reload systemd ------------------------- 2.04s
2026-08-24 15:32:21.734985 | mon1 | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.92s
2026-08-24 15:32:21.736654 | mon1 | vexxhost.containers.containerd : Restart containerd --------------------- 1.60s
2026-08-24 15:32:21.736679 | mon1 | vexxhost.containers.package : Update state for tar ---------------------- 1.36s
2026-08-24 15:32:21.736685 | mon1 | vexxhost.containers.containerd : Create folders for configuration ------- 1.22s
2026-08-24 15:32:21.736690 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 1.14s
2026-08-24 15:32:21.736696 | mon1 | Gathering Facts --------------------------------------------------------- 1.14s
2026-08-24 15:32:21.736701 | mon1 | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.08s
2026-08-24 15:32:21.736707 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 1.06s
2026-08-24 15:32:21.736712 | mon1 | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.97s
2026-08-24 15:32:21.736717 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.86s
2026-08-24 15:32:21.736722 | mon1 | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.84s
2026-08-24 15:32:21.821816 | mon1 | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.kre9.default/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-08-24 15:32:21.821882 | mon1 | ERROR    [default > converge] Executed: Failed
2026-08-24 15:32:21.823666 | mon1 | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.kre9.default/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-ceph/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-08-24 15:32:32.092074 | mon1 | ERROR
2026-08-24 15:32:32.092242 | mon1 | {
2026-08-24 15:32:32.092272 | mon1 |   "delta": "0:04:54.379554",
2026-08-24 15:32:32.092292 | mon1 |   "end": "2026-08-24 15:32:21.896161",
2026-08-24 15:32:32.092310 | mon1 |   "msg": "non-zero return code",
2026-08-24 15:32:32.092328 | mon1 |   "rc": 2,
2026-08-24 15:32:32.092346 | mon1 |   "start": "2026-08-24 15:27:27.516607"
2026-08-24 15:32:32.092364 | mon1 | }
failure
2026-08-24 15:32:32.096788 | 
2026-08-24 15:32:32.097117 | PLAY RECAP
2026-08-24 15:32:32.097166 | mon1 | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:32:32.097190 | 
2026-08-24 15:32:32.273255 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:32:32.283747 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:32:33.182207 | 
2026-08-24 15:32:33.182414 | PLAY [all]
2026-08-24 15:32:33.207782 | 
2026-08-24 15:32:33.208024 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 15:32:33.276762 | mon1 | ok
2026-08-24 15:32:33.282424 | osd1 | ok
2026-08-24 15:32:33.287698 | 
2026-08-24 15:32:33.287793 | TASK [fetch-output : Set log path for single node]
2026-08-24 15:32:33.317175 | mon1 | skipping: Conditional result was False
2026-08-24 15:32:33.329243 | osd1 | skipping: Conditional result was False
2026-08-24 15:32:33.342026 | 
2026-08-24 15:32:33.342197 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 15:32:33.779917 | osd1 -> localhost | changed: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/logs/osd1"
2026-08-24 15:32:33.805166 | mon1 -> localhost | changed: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/logs/mon1"
2026-08-24 15:32:34.079693 | mon1 -> localhost | changed: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/artifacts"
2026-08-24 15:32:34.089117 | osd1 -> localhost | ok: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/artifacts"
2026-08-24 15:32:34.312066 | mon1 -> localhost | changed: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/docs"
2026-08-24 15:32:34.361006 | osd1 -> localhost | ok: "/var/lib/zuul/builds/b81c5f88b7d543d180349e9b204d493a/work/docs"
2026-08-24 15:32:34.361197 | osd1 -> localhost | changed: All items complete
2026-08-24 15:32:34.361265 | 
2026-08-24 15:32:34.375941 | 
2026-08-24 15:32:34.376159 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 15:32:35.221321 | osd1 | changed: .d..t...... ./
2026-08-24 15:32:35.227463 | mon1 | changed: .d..t...... ./
2026-08-24 15:32:35.751534 | osd1 | changed: .d..t...... ./
2026-08-24 15:32:35.886420 | mon1 | ok
2026-08-24 15:32:36.319266 | osd1 | changed: .d..t...... ./
2026-08-24 15:32:36.402489 | mon1 | ok
2026-08-24 15:32:36.402589 | mon1 | changed: All items complete
2026-08-24 15:32:36.402615 | 
2026-08-24 15:32:36.431322 | 
2026-08-24 15:32:36.431408 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 15:32:36.908306 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008057
2026-08-24 15:32:37.154715 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.007521
2026-08-24 15:32:37.182566 | 
2026-08-24 15:32:37.183131 | PLAY [all]
2026-08-24 15:32:37.189522 | 
2026-08-24 15:32:37.189590 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 15:32:37.700710 | mon1 | changed
2026-08-24 15:32:37.889472 | osd1 | changed
2026-08-24 15:32:37.904254 | 
2026-08-24 15:32:37.904408 | PLAY RECAP
2026-08-24 15:32:37.904459 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 15:32:37.904488 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 15:32:37.904508 | 
2026-08-24 15:32:38.039880 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:32:38.045272 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 15:32:38.707911 | 
2026-08-24 15:32:38.708058 | PLAY [localhost]
2026-08-24 15:32:38.719019 | 
2026-08-24 15:32:38.719168 | TASK [Generate Zuul manifest]
2026-08-24 15:32:38.741511 | localhost | ok
2026-08-24 15:32:38.759617 | 
2026-08-24 15:32:38.759751 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 15:32:39.175837 | localhost | changed
2026-08-24 15:32:39.187793 | 
2026-08-24 15:32:39.187980 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 15:32:39.217127 | localhost | ok
2026-08-24 15:32:39.225971 | 
2026-08-24 15:32:39.226145 | TASK [Upload logs]
2026-08-24 15:32:39.248844 | localhost | ok
2026-08-24 15:32:39.321947 | 
2026-08-24 15:32:39.322062 | TASK [Set zuul-log-path fact]
2026-08-24 15:32:39.339132 | localhost | ok
2026-08-24 15:32:39.351365 | 
2026-08-24 15:32:39.351484 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:32:39.382664 | localhost | ok
2026-08-24 15:32:39.391385 | 
2026-08-24 15:32:39.391504 | TASK [upload-logs : Create log directories]
2026-08-24 15:32:39.883558 | localhost | changed
2026-08-24 15:32:39.891233 | 
2026-08-24 15:32:39.891396 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 15:32:40.463238 | localhost -> localhost | ok: Runtime: 0:00:00.007586
2026-08-24 15:32:40.471150 | 
2026-08-24 15:32:40.471295 | TASK [upload-logs : Upload logs to log server]
2026-08-24 15:32:40.979290 | localhost | Output suppressed because no_log was given
2026-08-24 15:32:40.984999 | 
2026-08-24 15:32:40.985315 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 15:32:41.135898 | localhost | skipping: Conditional result was False
2026-08-24 15:32:41.149664 | localhost | skipping: Conditional result was False
2026-08-24 15:32:41.165895 | 
2026-08-24 15:32:41.166068 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 15:32:41.292044 | localhost | skipping: Conditional result was False
2026-08-24 15:32:41.292488 | 
2026-08-24 15:32:41.297267 | localhost | skipping: Conditional result was False
2026-08-24 15:32:41.381324 | 
2026-08-24 15:32:41.381512 | LOOP [upload-logs : Upload console log and json output]