2026-08-18 08:59:46.166344 | Job console starting
2026-08-18 08:59:46.175103 | Updating git repos
2026-08-18 08:59:46.209155 | Cloning repos into workspace
2026-08-18 08:59:46.263921 | Restoring repo states
2026-08-18 08:59:46.273859 | Merging changes
2026-08-18 08:59:46.629178 | Checking out repos
2026-08-18 08:59:46.725467 | Preparing playbooks
2026-08-18 08:59:47.650651 | Running Ansible setup
2026-08-18 08:59:51.352813 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-18 08:59:51.999261 | 
2026-08-18 08:59:51.999404 | PLAY [localhost]
2026-08-18 08:59:52.007205 | 
2026-08-18 08:59:52.007274 | TASK [Gathering Facts]
2026-08-18 08:59:52.852397 | localhost | ok
2026-08-18 08:59:52.859412 | 
2026-08-18 08:59:52.859498 | TASK [Setup log path fact]
2026-08-18 08:59:52.878543 | localhost | ok
2026-08-18 08:59:52.892737 | 
2026-08-18 08:59:52.892819 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-18 08:59:52.923791 | localhost | ok
2026-08-18 08:59:52.931366 | 
2026-08-18 08:59:52.931516 | TASK [emit-job-header : Print job information]
2026-08-18 08:59:52.973484 | # Job Information
2026-08-18 08:59:52.973758 | Ansible Version: 2.16.18
2026-08-18 08:59:52.973828 | Job: ansible-collection-ceph-molecule-aio-ubuntu-noble
2026-08-18 08:59:52.973879 | Pipeline: check
2026-08-18 08:59:52.973924 | Executor: 2d72f0692154
2026-08-18 08:59:52.973968 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/123
2026-08-18 08:59:52.974019 | Event ID: c29a3b10-9ae2-11f1-99c4-ef1c8392bf52
2026-08-18 08:59:52.979979 | 
2026-08-18 08:59:52.980115 | LOOP [emit-job-header : Print node information]
2026-08-18 08:59:53.087703 | localhost | ok:
2026-08-18 08:59:53.088099 | localhost | # Node Information
2026-08-18 08:59:53.088183 | localhost | Inventory Hostname: aio
2026-08-18 08:59:53.088251 | localhost | Hostname: np0000189952
2026-08-18 08:59:53.088311 | localhost | Username: zuul
2026-08-18 08:59:53.088371 | localhost | Distro: Ubuntu 24.04
2026-08-18 08:59:53.088429 | localhost | Provider: yul1
2026-08-18 08:59:53.088488 | localhost | Region: ca-ymq-1
2026-08-18 08:59:53.088544 | localhost | Label: ubuntu-noble
2026-08-18 08:59:53.088594 | localhost | Product Name: OpenStack Nova
2026-08-18 08:59:53.088645 | localhost | Interface IP: 199.204.45.144
2026-08-18 08:59:53.100369 | 
2026-08-18 08:59:53.100507 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-18 08:59:53.484163 | localhost -> localhost | changed
2026-08-18 08:59:53.494152 | 
2026-08-18 08:59:53.494252 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-18 08:59:54.318877 | localhost -> localhost | changed
2026-08-18 08:59:54.329037 | 
2026-08-18 08:59:54.329119 | PLAY [all]
2026-08-18 08:59:54.338743 | 
2026-08-18 08:59:54.338825 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-18 08:59:54.555275 | aio -> localhost | ok
2026-08-18 08:59:54.567098 | 
2026-08-18 08:59:54.567186 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-18 08:59:54.602899 | aio | ok
2026-08-18 08:59:54.615969 | aio | included: /var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-18 08:59:54.621947 | 
2026-08-18 08:59:54.622008 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-18 08:59:55.419907 | aio -> localhost | Generating public/private rsa key pair.
2026-08-18 08:59:55.420105 | aio -> localhost | Your identification has been saved in /var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/a64e5a49549444b8939a523f2a446551_id_rsa
2026-08-18 08:59:55.420137 | aio -> localhost | Your public key has been saved in /var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/a64e5a49549444b8939a523f2a446551_id_rsa.pub
2026-08-18 08:59:55.420160 | aio -> localhost | The key fingerprint is:
2026-08-18 08:59:55.420182 | aio -> localhost | SHA256:EAqCi6vcB4GJNRzVbADWTiBMUw+/sv28sQtWqcsSsao zuul-build-sshkey
2026-08-18 08:59:55.420214 | aio -> localhost | The key's randomart image is:
2026-08-18 08:59:55.420236 | aio -> localhost | +---[RSA 3072]----+
2026-08-18 08:59:55.420261 | aio -> localhost | |*+BOo+.          |
2026-08-18 08:59:55.420283 | aio -> localhost | |.==.*.+.         |
2026-08-18 08:59:55.420303 | aio -> localhost | |ooo+.+.          |
2026-08-18 08:59:55.420324 | aio -> localhost | |+o o. ...        |
2026-08-18 08:59:55.420344 | aio -> localhost | | . .+. oS        |
2026-08-18 08:59:55.420365 | aio -> localhost | |.  ++ o          |
2026-08-18 08:59:55.420386 | aio -> localhost | |o o.o= .         |
2026-08-18 08:59:55.420407 | aio -> localhost | |.o oo.= o        |
2026-08-18 08:59:55.420429 | aio -> localhost | |E   oo *o        |
2026-08-18 08:59:55.420451 | aio -> localhost | +----[SHA256]-----+
2026-08-18 08:59:55.420498 | aio -> localhost | ok: Runtime: 0:00:00.390131
2026-08-18 08:59:55.426449 | 
2026-08-18 08:59:55.426514 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-18 08:59:55.461097 | aio | ok
2026-08-18 08:59:55.469550 | aio | included: /var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-18 08:59:55.477448 | 
2026-08-18 08:59:55.477510 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-18 08:59:55.491098 | aio | skipping: Conditional result was False
2026-08-18 08:59:55.502045 | 
2026-08-18 08:59:55.502107 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-18 08:59:56.013773 | aio | changed
2026-08-18 08:59:56.021058 | 
2026-08-18 08:59:56.021140 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-18 08:59:56.248226 | aio | ok
2026-08-18 08:59:56.253554 | 
2026-08-18 08:59:56.253615 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-18 08:59:56.793876 | aio | changed
2026-08-18 08:59:56.801369 | 
2026-08-18 08:59:56.801455 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-18 08:59:57.340477 | aio | changed
2026-08-18 08:59:57.346807 | 
2026-08-18 08:59:57.346871 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-18 08:59:57.365184 | aio | skipping: Conditional result was False
2026-08-18 08:59:57.371173 | 
2026-08-18 08:59:57.371241 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-18 08:59:57.729014 | aio -> localhost | changed
2026-08-18 08:59:57.748158 | 
2026-08-18 08:59:57.748234 | TASK [add-build-sshkey : Add back temp key]
2026-08-18 08:59:58.012796 | aio -> localhost | Identity added: /var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/a64e5a49549444b8939a523f2a446551_id_rsa (zuul-build-sshkey)
2026-08-18 08:59:58.013026 | aio -> localhost | ok: Runtime: 0:00:00.012895
2026-08-18 08:59:58.018455 | 
2026-08-18 08:59:58.018513 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-18 08:59:58.363946 | aio | ok
2026-08-18 08:59:58.371226 | 
2026-08-18 08:59:58.371289 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-18 08:59:58.395327 | aio | skipping: Conditional result was False
2026-08-18 08:59:58.411611 | 
2026-08-18 08:59:58.411674 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-18 08:59:58.832913 | aio | ok
2026-08-18 08:59:58.838634 | 
2026-08-18 08:59:58.838696 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-18 08:59:59.565303 | aio | Output suppressed because no_log was given
2026-08-18 08:59:59.577211 | 
2026-08-18 08:59:59.577294 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-18 08:59:59.819943 | aio | ok: "logs"
2026-08-18 08:59:59.820183 | aio | ok: All items complete
2026-08-18 08:59:59.820211 | 
2026-08-18 09:00:00.010899 | aio | ok: "artifacts"
2026-08-18 09:00:00.204403 | aio | ok: "docs"
2026-08-18 09:00:00.224273 | 
2026-08-18 09:00:00.224479 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-18 09:00:00.453208 | aio | changed: "logs"
2026-08-18 09:00:00.647909 | aio | changed: "artifacts"
2026-08-18 09:00:00.838186 | aio | changed: "docs"
2026-08-18 09:00:00.859558 | 
2026-08-18 09:00:00.859708 | PLAY RECAP
2026-08-18 09:00:00.859776 | aio | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-18 09:00:00.859817 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-18 09:00:00.859851 | 
2026-08-18 09:00:01.025763 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-18 09:00:01.029173 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-18 09:00:01.621784 | 
2026-08-18 09:00:01.622150 | PLAY [all]
2026-08-18 09:00:01.634959 | 
2026-08-18 09:00:01.635064 | TASK [setup-uv : Extract archive]
2026-08-18 09:00:04.053422 | aio | changed
2026-08-18 09:00:04.062116 | 
2026-08-18 09:00:04.062222 | TASK [setup-uv : Print version]
2026-08-18 09:00:04.456156 | aio | uv 0.8.13
2026-08-18 09:00:04.605631 | aio | ok: Runtime: 0:00:00.015602
2026-08-18 09:00:04.615828 | 
2026-08-18 09:00:04.615896 | TASK [Install Ansible collection siblings]
2026-08-18 09:00:05.037220 | aio | ok:
2026-08-18 09:00:05.037433 | aio | Skipping community.docker: no checked-out sibling
2026-08-18 09:00:05.037473 | aio | Skipping community.general: no checked-out sibling
2026-08-18 09:00:05.037502 | aio | Skipping ansible.utils: no checked-out sibling
2026-08-18 09:00:05.037530 | aio | Skipping vexxhost.containers: no checked-out sibling
2026-08-18 09:00:05.039490 | 
2026-08-18 09:00:05.039548 | PLAY RECAP
2026-08-18 09:00:05.039607 | aio | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-18 09:00:05.039639 | 
2026-08-18 09:00:05.170016 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-18 09:00:05.173212 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-18 09:00:05.771273 | 
2026-08-18 09:00:05.771393 | PLAY [all]
2026-08-18 09:00:05.784867 | 
2026-08-18 09:00:05.785329 | LOOP [Check inventory directories]
2026-08-18 09:00:06.163206 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-18 09:00:06.349913 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/molecule/default/inventory"
2026-08-18 09:00:06.548276 | aio | ok: "src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/inventory"
2026-08-18 09:00:06.567620 | 
2026-08-18 09:00:06.567862 | LOOP [Copy inventory file for Zuul]
2026-08-18 09:00:07.466853 | aio | changed:
2026-08-18 09:00:07.467079 | aio | {
2026-08-18 09:00:07.467110 | aio |   "ansible_loop_var": "item",
2026-08-18 09:00:07.467134 | aio |   "changed": false,
2026-08-18 09:00:07.467154 | aio |   "failed": false,
2026-08-18 09:00:07.467176 | aio |   "invocation": {
2026-08-18 09:00:07.467196 | aio |     "module_args": {
2026-08-18 09:00:07.467218 | aio |       "checksum_algorithm": "sha1",
2026-08-18 09:00:07.467238 | aio |       "follow": true,
2026-08-18 09:00:07.467257 | aio |       "get_attributes": true,
2026-08-18 09:00:07.467276 | aio |       "get_checksum": true,
2026-08-18 09:00:07.467295 | aio |       "get_mime": true,
2026-08-18 09:00:07.467314 | aio |       "path": "src/github.com/vexxhost/ansible-collection-ceph"
2026-08-18 09:00:07.467332 | aio |     }
2026-08-18 09:00:07.467350 | aio |   },
2026-08-18 09:00:07.467369 | aio |   "item": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-18 09:00:07.467387 | aio |   "stat": {
2026-08-18 09:00:07.467405 | aio |     "atime": 1787043599.4572926,
2026-08-18 09:00:07.467424 | aio |     "attr_flags": "e",
2026-08-18 09:00:07.467442 | aio |     "attributes": [
2026-08-18 09:00:07.467460 | aio |       "extents"
2026-08-18 09:00:07.467477 | aio |     ],
2026-08-18 09:00:07.467495 | aio |     "block_size": 4096,
2026-08-18 09:00:07.467513 | aio |     "blocks": 8,
2026-08-18 09:00:07.467531 | aio |     "charset": "unknown",
2026-08-18 09:00:07.467560 | aio |     "ctime": 1787043599.4682944,
2026-08-18 09:00:07.467580 | aio |     "dev": 64769,
2026-08-18 09:00:07.467599 | aio |     "device_type": 0,
2026-08-18 09:00:07.467617 | aio |     "executable": true,
2026-08-18 09:00:07.467634 | aio |     "exists": true,
2026-08-18 09:00:07.467652 | aio |     "gid": 1000,
2026-08-18 09:00:07.467670 | aio |     "gr_name": "zuul",
2026-08-18 09:00:07.467687 | aio |     "inode": 1034272,
2026-08-18 09:00:07.467705 | aio |     "isblk": false,
2026-08-18 09:00:07.467723 | aio |     "ischr": false,
2026-08-18 09:00:07.467740 | aio |     "isdir": true,
2026-08-18 09:00:07.467758 | aio |     "isfifo": false,
2026-08-18 09:00:07.467775 | aio |     "isgid": false,
2026-08-18 09:00:07.467793 | aio |     "islnk": false,
2026-08-18 09:00:07.467810 | aio |     "isreg": false,
2026-08-18 09:00:07.467828 | aio |     "issock": false,
2026-08-18 09:00:07.467845 | aio |     "isuid": false,
2026-08-18 09:00:07.467862 | aio |     "mimetype": "unknown",
2026-08-18 09:00:07.467880 | aio |     "mode": "0755",
2026-08-18 09:00:07.467897 | aio |     "mtime": 1787043586.573385,
2026-08-18 09:00:07.467915 | aio |     "nlink": 10,
2026-08-18 09:00:07.467932 | aio |     "path": "src/github.com/vexxhost/ansible-collection-ceph",
2026-08-18 09:00:07.467992 | aio |     "pw_name": "zuul",
2026-08-18 09:00:07.468028 | aio |     "readable": true,
2026-08-18 09:00:07.468048 | aio |     "rgrp": true,
2026-08-18 09:00:07.468067 | aio |     "roth": true,
2026-08-18 09:00:07.468085 | aio |     "rusr": true,
2026-08-18 09:00:07.468102 | aio |     "size": 4096,
2026-08-18 09:00:07.468124 | aio |     "uid": 1000,
2026-08-18 09:00:07.468161 | aio |     "version": "3086104707",
2026-08-18 09:00:07.468205 | aio |     "wgrp": false,
2026-08-18 09:00:07.468237 | aio |     "woth": false,
2026-08-18 09:00:07.468259 | aio |     "writeable": true,
2026-08-18 09:00:07.468278 | aio |     "wusr": true,
2026-08-18 09:00:07.468296 | aio |     "xgrp": true,
2026-08-18 09:00:07.468314 | aio |     "xoth": true,
2026-08-18 09:00:07.468331 | aio |     "xusr": true
2026-08-18 09:00:07.468348 | aio |   }
2026-08-18 09:00:07.468367 | aio | }
2026-08-18 09:00:07.468406 | aio | ok: All items complete
2026-08-18 09:00:07.468428 | 
2026-08-18 09:00:07.469699 | aio | skipping: Conditional result was False
2026-08-18 09:00:07.471591 | aio | skipping: Conditional result was False
2026-08-18 09:00:07.486956 | 
2026-08-18 09:00:07.487116 | LOOP [Switch "ansible_host" to private IP]
2026-08-18 09:00:07.882694 | aio | changed: 1 replacements made
2026-08-18 09:00:07.883957 | aio | skipping: Conditional result was False
2026-08-18 09:00:07.889352 | aio | skipping: Conditional result was False
2026-08-18 09:00:07.905968 | 
2026-08-18 09:00:07.906169 | TASK [Run Molecule scenario]
2026-08-18 09:00:08.367955 | aio | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-08-18 09:00:08.368115 | aio | Creating virtual environment at: .venv
2026-08-18 09:00:08.421626 | aio | Downloading cryptography (4.3MiB)
2026-08-18 09:00:08.421982 | aio | Downloading ansible-core (2.1MiB)
2026-08-18 09:00:08.422193 | aio | Downloading netaddr (2.2MiB)
2026-08-18 09:00:08.424697 | aio | Downloading pygments (1.2MiB)
2026-08-18 09:00:08.642001 | aio |  Downloading netaddr
2026-08-18 09:00:08.657634 | aio |  Downloading cryptography
2026-08-18 09:00:08.712670 | aio |  Downloading pygments
2026-08-18 09:00:08.849527 | aio |  Downloading ansible-core
2026-08-18 09:00:08.897159 | aio | Installed 43 packages in 47ms
2026-08-18 09:00:09.683654 | aio | INFO     Collection 'vexxhost.ceph' detected.
2026-08-18 09:00:09.683749 | aio | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-18 09:00:10.351698 | aio | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-18 09:00:10.351758 | aio | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-08-18 09:02:28.850858 | aio | INFO     [default > dependency] Executing
2026-08-18 09:02:28.851404 | aio | WARNING  [default > dependency] Missing roles requirements file: requirements.yml
2026-08-18 09:02:28.851597 | aio | WARNING  [default > dependency] Missing collections requirements file: collections.yml
2026-08-18 09:02:28.852160 | aio | WARNING  [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-18 09:02:28.858055 | aio | INFO     [default > cleanup] Executing
2026-08-18 09:02:28.858385 | aio | WARNING  [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-18 09:02:28.864473 | aio | INFO     [default > destroy] Executing
2026-08-18 09:02:28.864549 | aio | WARNING  [default > destroy] Skipping, '--destroy=never' requested.
2026-08-18 09:02:28.864568 | aio | INFO     [default > destroy] Executed: Successful
2026-08-18 09:02:28.870698 | aio | INFO     [default > syntax] Executing
2026-08-18 09:02:30.210183 | aio |
2026-08-18 09:02:30.210496 | aio | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-08-18 09:02:30.305082 | aio | INFO     [default > syntax] Executed: Successful
2026-08-18 09:02:30.315561 | aio | INFO     [default > create] Executing
2026-08-18 09:02:30.317119 | aio | WARNING  [default > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-18 09:02:30.323000 | aio | INFO     [default > prepare] Executing
2026-08-18 09:02:31.169869 | aio |
2026-08-18 09:02:31.170116 | aio | PLAY [Prepare] *****************************************************************
2026-08-18 09:02:31.170443 | aio |
2026-08-18 09:02:31.170686 | aio | TASK [Gathering Facts] *********************************************************
2026-08-18 09:02:31.170936 | aio | Tuesday 18 August 2026  09:02:31 +0000 (0:00:00.035)       0:00:00.035 ********
2026-08-18 09:02:32.436631 | aio | [WARNING]: Platform linux on host aio is using the discovered Python
2026-08-18 09:02:32.436864 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-08-18 09:02:32.437091 | aio | interpreter could change the meaning of that path. See
2026-08-18 09:02:32.437356 | aio | https://docs.ansible.com/ansible-
2026-08-18 09:02:32.437614 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-18 09:02:32.445615 | aio | ok: [aio]
2026-08-18 09:02:32.445858 | aio |
2026-08-18 09:02:32.446118 | aio | TASK [Configure short hostname] ************************************************
2026-08-18 09:02:32.446405 | aio | Tuesday 18 August 2026  09:02:32 +0000 (0:00:01.276)       0:00:01.312 ********
2026-08-18 09:02:33.252208 | aio | changed: [aio]
2026-08-18 09:02:33.252450 | aio |
2026-08-18 09:02:33.252726 | aio | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-18 09:02:33.252966 | aio | Tuesday 18 August 2026  09:02:33 +0000 (0:00:00.805)       0:00:02.117 ********
2026-08-18 09:02:33.574246 | aio | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-18 09:02:33.574487 | aio | with a mode of 0700, this may cause issues when running as another user. To
2026-08-18 09:02:33.574738 | aio | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-18 09:02:33.585598 | aio | changed: [aio]
2026-08-18 09:02:33.585765 | aio |
2026-08-18 09:02:33.586012 | aio | TASK [Update apt cache] ********************************************************
2026-08-18 09:02:33.586332 | aio | Tuesday 18 August 2026  09:02:33 +0000 (0:00:00.334)       0:00:02.452 ********
2026-08-18 09:02:39.393524 | aio | changed: [aio]
2026-08-18 09:02:39.393727 | aio |
2026-08-18 09:02:39.394008 | aio | PLAY [Create devices for Ceph] *************************************************
2026-08-18 09:02:39.394357 | aio |
2026-08-18 09:02:39.394736 | aio | TASK [Gathering Facts] *********************************************************
2026-08-18 09:02:39.394998 | aio | Tuesday 18 August 2026  09:02:39 +0000 (0:00:05.807)       0:00:08.260 ********
2026-08-18 09:02:40.225574 | aio | ok: [aio]
2026-08-18 09:02:40.225775 | aio |
2026-08-18 09:02:40.226024 | aio | TASK [Install depedencies] *****************************************************
2026-08-18 09:02:40.226268 | aio | Tuesday 18 August 2026  09:02:40 +0000 (0:00:00.831)       0:00:09.092 ********
2026-08-18 09:03:00.576792 | aio | changed: [aio]
2026-08-18 09:03:00.576931 | aio |
2026-08-18 09:03:00.577336 | aio | TASK [Start up service] ********************************************************
2026-08-18 09:03:00.577480 | aio | Tuesday 18 August 2026  09:03:00 +0000 (0:00:20.344)       0:00:29.436 ********
2026-08-18 09:03:01.248333 | aio | ok: [aio]
2026-08-18 09:03:01.248368 | aio |
2026-08-18 09:03:01.248470 | aio | TASK [Generate lvm.conf] *******************************************************
2026-08-18 09:03:01.248721 | aio | Tuesday 18 August 2026  09:03:01 +0000 (0:00:00.678)       0:00:30.114 ********
2026-08-18 09:03:01.602128 | aio | ok: [aio]
2026-08-18 09:03:01.602402 | aio |
2026-08-18 09:03:01.602674 | aio | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-18 09:03:01.602927 | aio | Tuesday 18 August 2026  09:03:01 +0000 (0:00:00.354)       0:00:30.468 ********
2026-08-18 09:03:02.380089 | aio | changed: [aio]
2026-08-18 09:03:02.380501 | aio |
2026-08-18 09:03:02.381098 | aio | TASK [Get list of all loopback devices] ****************************************
2026-08-18 09:03:02.381121 | aio | Tuesday 18 August 2026  09:03:02 +0000 (0:00:00.776)       0:00:31.245 ********
2026-08-18 09:03:02.643959 | aio | ok: [aio]
2026-08-18 09:03:02.644189 | aio |
2026-08-18 09:03:02.644203 | aio | TASK [Fail if there is any existing loopback devices] **************************
2026-08-18 09:03:02.644216 | aio | Tuesday 18 August 2026  09:03:02 +0000 (0:00:00.264)       0:00:31.510 ********
2026-08-18 09:03:02.676422 | aio | skipping: [aio]
2026-08-18 09:03:02.676503 | aio |
2026-08-18 09:03:02.676748 | aio | TASK [Create devices for Ceph] *************************************************
2026-08-18 09:03:02.676990 | aio | Tuesday 18 August 2026  09:03:02 +0000 (0:00:00.032)       0:00:31.542 ********
2026-08-18 09:03:03.421073 | aio | changed: [aio] => (item=osd0)
2026-08-18 09:03:03.421407 | aio | changed: [aio] => (item=osd1)
2026-08-18 09:03:03.421601 | aio | changed: [aio] => (item=osd2)
2026-08-18 09:03:03.421819 | aio |
2026-08-18 09:03:03.422088 | aio | TASK [Set permissions on loopback devices] *************************************
2026-08-18 09:03:03.422366 | aio | Tuesday 18 August 2026  09:03:03 +0000 (0:00:00.744)       0:00:32.287 ********
2026-08-18 09:03:04.211095 | aio | changed: [aio] => (item=osd0)
2026-08-18 09:03:04.211313 | aio | changed: [aio] => (item=osd1)
2026-08-18 09:03:04.211585 | aio | changed: [aio] => (item=osd2)
2026-08-18 09:03:04.211818 | aio |
2026-08-18 09:03:04.212087 | aio | TASK [Start loop devices] ******************************************************
2026-08-18 09:03:04.212356 | aio | Tuesday 18 August 2026  09:03:04 +0000 (0:00:00.790)       0:00:33.077 ********
2026-08-18 09:03:05.031963 | aio | changed: [aio] => (item=osd0)
2026-08-18 09:03:05.032503 | aio | changed: [aio] => (item=osd1)
2026-08-18 09:03:05.035377 | aio | changed: [aio] => (item=osd2)
2026-08-18 09:03:05.035391 | aio |
2026-08-18 09:03:05.035402 | aio | TASK [Create a volume group for each loop device] ******************************
2026-08-18 09:03:05.035419 | aio | Tuesday 18 August 2026  09:03:05 +0000 (0:00:00.820)       0:00:33.898 ********
2026-08-18 09:03:06.620876 | aio | changed: [aio] => (item=osd0)
2026-08-18 09:03:06.621066 | aio | changed: [aio] => (item=osd1)
2026-08-18 09:03:06.621394 | aio | changed: [aio] => (item=osd2)
2026-08-18 09:03:06.621651 | aio |
2026-08-18 09:03:06.621919 | aio | TASK [Create a logical volume for each loop device] ****************************
2026-08-18 09:03:06.622178 | aio | Tuesday 18 August 2026  09:03:06 +0000 (0:00:01.588)       0:00:35.486 ********
2026-08-18 09:03:08.574429 | aio | changed: [aio] => (item=ceph-aio-osd0)
2026-08-18 09:03:08.574504 | aio | changed: [aio] => (item=ceph-aio-osd1)
2026-08-18 09:03:08.574515 | aio | changed: [aio] => (item=ceph-aio-osd2)
2026-08-18 09:03:08.574524 | aio |
2026-08-18 09:03:08.574541 | aio | PLAY RECAP *********************************************************************
2026-08-18 09:03:08.576355 | aio | aio                        : ok=15   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-18 09:03:08.576526 | aio |
2026-08-18 09:03:08.576547 | aio |
2026-08-18 09:03:08.576558 | aio | TASKS RECAP ********************************************************************
2026-08-18 09:03:08.576568 | aio | Tuesday 18 August 2026  09:03:08 +0000 (0:00:01.953)       0:00:37.440 ********
2026-08-18 09:03:08.576577 | aio | ===============================================================================
2026-08-18 09:03:08.576586 | aio | Install depedencies ---------------------------------------------------- 20.34s
2026-08-18 09:03:08.576926 | aio | Update apt cache -------------------------------------------------------- 5.81s
2026-08-18 09:03:08.577125 | aio | Create a logical volume for each loop device ---------------------------- 1.95s
2026-08-18 09:03:08.577344 | aio | Create a volume group for each loop device ------------------------------ 1.59s
2026-08-18 09:03:08.577540 | aio | Gathering Facts --------------------------------------------------------- 1.28s
2026-08-18 09:03:08.577727 | aio | Gathering Facts --------------------------------------------------------- 0.83s
2026-08-18 09:03:08.577917 | aio | Start loop devices ------------------------------------------------------ 0.82s
2026-08-18 09:03:08.578105 | aio | Configure short hostname ------------------------------------------------ 0.81s
2026-08-18 09:03:08.578343 | aio | Set permissions on loopback devices ------------------------------------- 0.79s
2026-08-18 09:03:08.578542 | aio | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.78s
2026-08-18 09:03:08.578732 | aio | Create devices for Ceph ------------------------------------------------- 0.74s
2026-08-18 09:03:08.578918 | aio | Start up service -------------------------------------------------------- 0.68s
2026-08-18 09:03:08.579105 | aio | Generate lvm.conf ------------------------------------------------------- 0.35s
2026-08-18 09:03:08.579316 | aio | Ensure hostname inside hosts file --------------------------------------- 0.33s
2026-08-18 09:03:08.579512 | aio | Get list of all loopback devices ---------------------------------------- 0.26s
2026-08-18 09:03:08.579702 | aio | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-18 09:03:08.692417 | aio | INFO     [default > prepare] Executed: Successful
2026-08-18 09:03:08.701232 | aio | INFO     [default > converge] Executing
2026-08-18 09:03:09.900185 | aio |
2026-08-18 09:03:09.900627 | aio | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-18 09:03:09.900924 | aio |
2026-08-18 09:03:09.901229 | aio | TASK [Gathering Facts] *********************************************************
2026-08-18 09:03:09.901570 | aio | Tuesday 18 August 2026  09:03:09 +0000 (0:00:00.058)       0:00:00.058 ********
2026-08-18 09:03:11.192404 | aio | [WARNING]: Platform linux on host aio is using the discovered Python
2026-08-18 09:03:11.194311 | aio | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-08-18 09:03:11.194344 | aio | interpreter could change the meaning of that path. See
2026-08-18 09:03:11.194354 | aio | https://docs.ansible.com/ansible-
2026-08-18 09:03:11.194364 | aio | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-08-18 09:03:11.226509 | aio | ok: [aio]
2026-08-18 09:03:11.226583 | aio |
2026-08-18 09:03:11.226595 | aio | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 09:03:11.226719 | aio | Tuesday 18 August 2026  09:03:11 +0000 (0:00:01.326)       0:00:01.384 ********
2026-08-18 09:03:11.574986 | aio | ok: [aio]
2026-08-18 09:03:11.575229 | aio |
2026-08-18 09:03:11.575651 | aio | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 09:03:11.575940 | aio | Tuesday 18 August 2026  09:03:11 +0000 (0:00:00.348)       0:00:01.733 ********
2026-08-18 09:03:11.622553 | aio | skipping: [aio]
2026-08-18 09:03:11.622790 | aio |
2026-08-18 09:03:11.623060 | aio | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-18 09:03:11.623358 | aio | Tuesday 18 August 2026  09:03:11 +0000 (0:00:00.047)       0:00:01.781 ********
2026-08-18 09:03:12.027820 | aio | changed: [aio]
2026-08-18 09:03:12.028036 | aio |
2026-08-18 09:03:12.028423 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 09:03:12.028693 | aio | Tuesday 18 August 2026  09:03:12 +0000 (0:00:00.405)       0:00:02.186 ********
2026-08-18 09:03:12.136328 | aio | ok: [aio] => {
2026-08-18 09:03:12.136519 | aio |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-18 09:03:12.136759 | aio | }
2026-08-18 09:03:12.136985 | aio |
2026-08-18 09:03:12.137225 | aio | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 09:03:12.137548 | aio | Tuesday 18 August 2026  09:03:12 +0000 (0:00:00.108)       0:00:02.294 ********
2026-08-18 09:03:12.994039 | aio | changed: [aio]
2026-08-18 09:03:12.994134 | aio |
2026-08-18 09:03:12.994346 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 09:03:12.994502 | aio | Tuesday 18 August 2026  09:03:12 +0000 (0:00:00.857)       0:00:03.152 ********
2026-08-18 09:03:13.050753 | aio | skipping: [aio]
2026-08-18 09:03:13.050867 | aio |
2026-08-18 09:03:13.051158 | aio | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 09:03:13.051431 | aio | Tuesday 18 August 2026  09:03:13 +0000 (0:00:00.056)       0:00:03.209 ********
2026-08-18 09:03:13.105901 | aio | skipping: [aio]
2026-08-18 09:03:13.105993 | aio |
2026-08-18 09:03:13.106351 | aio | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 09:03:13.106612 | aio | Tuesday 18 August 2026  09:03:13 +0000 (0:00:00.055)       0:00:03.264 ********
2026-08-18 09:03:13.366428 | aio | ok: [aio]
2026-08-18 09:03:13.366584 | aio |
2026-08-18 09:03:13.366897 | aio | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-18 09:03:13.367161 | aio | Tuesday 18 August 2026  09:03:13 +0000 (0:00:00.260)       0:00:03.525 ********
2026-08-18 09:03:14.633494 | aio | ok: [aio]
2026-08-18 09:03:14.633579 | aio |
2026-08-18 09:03:14.633625 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 09:03:14.633915 | aio | Tuesday 18 August 2026  09:03:14 +0000 (0:00:01.266)       0:00:04.791 ********
2026-08-18 09:03:14.905272 | aio | ok: [aio] => {
2026-08-18 09:03:14.905646 | aio |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-18 09:03:14.906009 | aio | }
2026-08-18 09:03:14.906424 | aio |
2026-08-18 09:03:14.906771 | aio | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 09:03:14.907091 | aio | Tuesday 18 August 2026  09:03:14 +0000 (0:00:00.271)       0:00:05.063 ********
2026-08-18 09:03:15.872162 | aio | changed: [aio]
2026-08-18 09:03:15.872400 | aio |
2026-08-18 09:03:15.872671 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 09:03:15.872981 | aio | Tuesday 18 August 2026  09:03:15 +0000 (0:00:00.966)       0:00:06.030 ********
2026-08-18 09:03:19.138374 | aio | changed: [aio]
2026-08-18 09:03:19.138461 | aio |
2026-08-18 09:03:19.139018 | aio | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-18 09:03:19.139089 | aio | Tuesday 18 August 2026  09:03:19 +0000 (0:00:03.266)       0:00:09.296 ********
2026-08-18 09:03:19.176424 | aio | skipping: [aio]
2026-08-18 09:03:19.176486 | aio |
2026-08-18 09:03:19.177013 | aio | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-18 09:03:19.177063 | aio | Tuesday 18 August 2026  09:03:19 +0000 (0:00:00.038)       0:00:09.334 ********
2026-08-18 09:03:19.216474 | aio | skipping: [aio]
2026-08-18 09:03:19.216559 | aio |
2026-08-18 09:03:19.216581 | aio | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-18 09:03:19.216872 | aio | Tuesday 18 August 2026  09:03:19 +0000 (0:00:00.040)       0:00:09.374 ********
2026-08-18 09:03:19.255896 | aio | skipping: [aio]
2026-08-18 09:03:19.255975 | aio |
2026-08-18 09:03:19.255986 | aio | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-18 09:03:19.255995 | aio | Tuesday 18 August 2026  09:03:19 +0000 (0:00:00.039)       0:00:09.413 ********
2026-08-18 09:03:27.312357 | aio | changed: [aio]
2026-08-18 09:03:27.312443 | aio |
2026-08-18 09:03:27.312458 | aio | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-18 09:03:27.312688 | aio | Tuesday 18 August 2026  09:03:27 +0000 (0:00:08.053)       0:00:17.467 ********
2026-08-18 09:03:28.043111 | aio | changed: [aio]
2026-08-18 09:03:28.043515 | aio |
2026-08-18 09:03:28.043841 | aio | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-18 09:03:28.044151 | aio | Tuesday 18 August 2026  09:03:28 +0000 (0:00:00.733)       0:00:18.201 ********
2026-08-18 09:03:29.324228 | aio | changed: [aio] => (item={'path': '/etc/containerd'})
2026-08-18 09:03:29.326304 | aio | changed: [aio] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-18 09:03:29.326336 | aio | changed: [aio] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-18 09:03:29.326348 | aio | changed: [aio] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-18 09:03:29.326361 | aio | changed: [aio] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-18 09:03:29.326373 | aio |
2026-08-18 09:03:29.326385 | aio | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-18 09:03:29.326397 | aio | Tuesday 18 August 2026  09:03:29 +0000 (0:00:01.281)       0:00:19.482 ********
2026-08-18 09:03:30.112374 | aio | changed: [aio]
2026-08-18 09:03:30.112438 | aio |
2026-08-18 09:03:30.112453 | aio | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-18 09:03:30.112466 | aio | Tuesday 18 August 2026  09:03:30 +0000 (0:00:00.779)       0:00:20.261 ********
2026-08-18 09:03:30.112477 | aio |
2026-08-18 09:03:30.112496 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-18 09:03:30.112622 | aio | Tuesday 18 August 2026  09:03:30 +0000 (0:00:00.008)       0:00:20.269 ********
2026-08-18 09:03:31.279332 | aio | ok: [aio]
2026-08-18 09:03:31.279379 | aio |
2026-08-18 09:03:31.279617 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-18 09:03:31.279875 | aio | Tuesday 18 August 2026  09:03:31 +0000 (0:00:01.167)       0:00:21.437 ********
2026-08-18 09:03:31.882080 | aio | changed: [aio]
2026-08-18 09:03:31.882203 | aio |
2026-08-18 09:03:31.882255 | aio | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-18 09:03:31.882431 | aio | Tuesday 18 August 2026  09:03:31 +0000 (0:00:00.603)       0:00:22.040 ********
2026-08-18 09:03:32.619840 | aio | changed: [aio]
2026-08-18 09:03:32.620051 | aio |
2026-08-18 09:03:32.620257 | aio | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-18 09:03:32.620787 | aio | Tuesday 18 August 2026  09:03:32 +0000 (0:00:00.737)       0:00:22.778 ********
2026-08-18 09:03:32.884325 | aio | ok: [aio]
2026-08-18 09:03:32.884571 | aio |
2026-08-18 09:03:32.884842 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 09:03:32.885088 | aio | Tuesday 18 August 2026  09:03:32 +0000 (0:00:00.264)       0:00:23.043 ********
2026-08-18 09:03:32.969869 | aio | ok: [aio] => {
2026-08-18 09:03:32.970198 | aio |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-18 09:03:32.970372 | aio | }
2026-08-18 09:03:32.970511 | aio |
2026-08-18 09:03:32.970677 | aio | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 09:03:32.970827 | aio | Tuesday 18 August 2026  09:03:32 +0000 (0:00:00.085)       0:00:23.128 ********
2026-08-18 09:03:33.968510 | aio | changed: [aio]
2026-08-18 09:03:33.968590 | aio |
2026-08-18 09:03:33.968601 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 09:03:33.968713 | aio | Tuesday 18 August 2026  09:03:33 +0000 (0:00:00.997)       0:00:24.126 ********
2026-08-18 09:03:38.684614 | aio | changed: [aio]
2026-08-18 09:03:38.684834 | aio |
2026-08-18 09:03:38.685116 | aio | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-18 09:03:38.685415 | aio | Tuesday 18 August 2026  09:03:38 +0000 (0:00:04.716)       0:00:28.842 ********
2026-08-18 09:03:39.631701 | aio | ok: [aio]
2026-08-18 09:03:39.631789 | aio |
2026-08-18 09:03:39.631853 | aio | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-18 09:03:39.631968 | aio | Tuesday 18 August 2026  09:03:39 +0000 (0:00:00.947)       0:00:29.790 ********
2026-08-18 09:03:40.020035 | aio | changed: [aio]
2026-08-18 09:03:40.020073 | aio |
2026-08-18 09:03:40.020078 | aio | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-18 09:03:40.020083 | aio | Tuesday 18 August 2026  09:03:40 +0000 (0:00:00.385)       0:00:30.176 ********
2026-08-18 09:03:40.571833 | aio | changed: [aio]
2026-08-18 09:03:40.571900 | aio |
2026-08-18 09:03:40.571990 | aio | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-18 09:03:40.572108 | aio | Tuesday 18 August 2026  09:03:40 +0000 (0:00:00.554)       0:00:30.731 ********
2026-08-18 09:03:41.298488 | aio | changed: [aio] => (item={'path': '/etc/docker'})
2026-08-18 09:03:41.298575 | aio | changed: [aio] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-18 09:03:41.298587 | aio | changed: [aio] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-18 09:03:41.298604 | aio |
2026-08-18 09:03:41.298989 | aio | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-18 09:03:41.299032 | aio | Tuesday 18 August 2026  09:03:41 +0000 (0:00:00.725)       0:00:31.456 ********
2026-08-18 09:03:41.875804 | aio | changed: [aio]
2026-08-18 09:03:41.875910 | aio |
2026-08-18 09:03:41.875921 | aio | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-18 09:03:41.876052 | aio | Tuesday 18 August 2026  09:03:41 +0000 (0:00:00.576)       0:00:32.033 ********
2026-08-18 09:03:42.476254 | aio | changed: [aio]
2026-08-18 09:03:42.476327 | aio |
2026-08-18 09:03:42.476336 | aio | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-18 09:03:42.476341 | aio | Tuesday 18 August 2026  09:03:42 +0000 (0:00:00.593)       0:00:32.626 ********
2026-08-18 09:03:42.476345 | aio |
2026-08-18 09:03:42.476349 | aio | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-18 09:03:42.476352 | aio | Tuesday 18 August 2026  09:03:42 +0000 (0:00:00.008)       0:00:32.634 ********
2026-08-18 09:03:43.439183 | aio | ok: [aio]
2026-08-18 09:03:43.440366 | aio |
2026-08-18 09:03:43.440404 | aio | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-18 09:03:43.440424 | aio | Tuesday 18 August 2026  09:03:43 +0000 (0:00:00.962)       0:00:33.597 ********
2026-08-18 09:03:44.937237 | aio | changed: [aio]
2026-08-18 09:03:44.937339 | aio |
2026-08-18 09:03:44.937360 | aio | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-18 09:03:44.937377 | aio | Tuesday 18 August 2026  09:03:44 +0000 (0:00:01.496)       0:00:35.094 ********
2026-08-18 09:03:45.694142 | aio | changed: [aio]
2026-08-18 09:03:45.694258 | aio |
2026-08-18 09:03:45.694274 | aio | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-18 09:03:45.694318 | aio | Tuesday 18 August 2026  09:03:45 +0000 (0:00:00.757)       0:00:35.851 ********
2026-08-18 09:03:45.740493 | aio | ok: [aio] => {
2026-08-18 09:03:45.740580 | aio |     "msg": "https://download.ceph.com/rpm-20.2.3/el9/noarch/cephadm"
2026-08-18 09:03:45.741550 | aio | }
2026-08-18 09:03:45.741628 | aio |
2026-08-18 09:03:45.741638 | aio | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-18 09:03:45.741649 | aio | Tuesday 18 August 2026  09:03:45 +0000 (0:00:00.047)       0:00:35.898 ********
2026-08-18 09:03:47.028086 | aio | changed: [aio]
2026-08-18 09:03:47.028145 | aio |
2026-08-18 09:03:47.028152 | aio | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-18 09:03:47.028159 | aio | Tuesday 18 August 2026  09:03:47 +0000 (0:00:01.287)       0:00:37.185 ********
2026-08-18 09:03:47.078241 | aio | skipping: [aio]
2026-08-18 09:03:47.078342 | aio |
2026-08-18 09:03:47.078357 | aio | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-18 09:03:47.078367 | aio | Tuesday 18 August 2026  09:03:47 +0000 (0:00:00.050)       0:00:37.236 ********
2026-08-18 09:03:47.136919 | aio | ok: [aio] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/debian.yml)
2026-08-18 09:03:47.137005 | aio |
2026-08-18 09:03:47.137016 | aio | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-18 09:03:47.137025 | aio | Tuesday 18 August 2026  09:03:47 +0000 (0:00:00.058)       0:00:37.294 ********
2026-08-18 09:03:48.151689 | aio | ok: [aio]
2026-08-18 09:03:48.151754 | aio |
2026-08-18 09:03:48.151870 | aio | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-18 09:03:48.151993 | aio | Tuesday 18 August 2026  09:03:48 +0000 (0:00:01.014)       0:00:38.308 ********
2026-08-18 09:03:49.004486 | aio | ok: [aio] => (item=systemd-timesyncd)
2026-08-18 09:03:49.004550 | aio | ok: [aio] => (item=ssh)
2026-08-18 09:03:49.004564 | aio |
2026-08-18 09:03:49.004623 | aio | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-18 09:03:49.004640 | aio | Tuesday 18 August 2026  09:03:49 +0000 (0:00:00.851)       0:00:39.160 ********
2026-08-18 09:03:49.261512 | aio | ok: [aio]
2026-08-18 09:03:49.261602 | aio |
2026-08-18 09:03:49.261620 | aio | TASK [vexxhost.ceph.cephadm : Ensure the cephadm SSH user exists] **************
2026-08-18 09:03:49.261787 | aio | Tuesday 18 August 2026  09:03:49 +0000 (0:00:00.258)       0:00:39.418 ********
2026-08-18 09:03:49.788344 | aio | changed: [aio]
2026-08-18 09:03:49.788386 | aio |
2026-08-18 09:03:49.788391 | aio | TASK [vexxhost.ceph.cephadm : Grant passwordless sudo to the cephadm SSH user] ***
2026-08-18 09:03:49.788534 | aio | Tuesday 18 August 2026  09:03:49 +0000 (0:00:00.525)       0:00:39.944 ********
2026-08-18 09:03:50.361310 | aio | changed: [aio]
2026-08-18 09:03:50.361355 | aio |
2026-08-18 09:03:50.361362 | aio | TASK [vexxhost.ceph.cephadm : Log in to the container registry] ****************
2026-08-18 09:03:50.361368 | aio | Tuesday 18 August 2026  09:03:50 +0000 (0:00:00.574)       0:00:40.519 ********
2026-08-18 09:03:50.402374 | aio | skipping: [aio]
2026-08-18 09:03:50.403316 | aio |
2026-08-18 09:03:50.403345 | aio | TASK [vexxhost.ceph.cephadm : Pre-pull the Ceph image] *************************
2026-08-18 09:03:50.403356 | aio | Tuesday 18 August 2026  09:03:50 +0000 (0:00:00.040)       0:00:40.560 ********
2026-08-18 09:04:30.778787 | aio | changed: [aio]
2026-08-18 09:04:30.778863 | aio |
2026-08-18 09:04:30.778965 | aio | TASK [vexxhost.ceph.cephadm : Pin CEPHADM_IMAGE for interactive login shells] ***
2026-08-18 09:04:30.779077 | aio | Tuesday 18 August 2026  09:04:30 +0000 (0:00:40.376)       0:01:20.936 ********
2026-08-18 09:04:31.353880 | aio | changed: [aio]
2026-08-18 09:04:31.353940 | aio |
2026-08-18 09:04:31.354060 | aio | TASK [vexxhost.ceph.mon : Find this monitor's addresses on the public network] ***
2026-08-18 09:04:31.354173 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.577)       0:01:21.513 ********
2026-08-18 09:04:31.486376 | aio | ok: [aio]
2026-08-18 09:04:31.486434 | aio |
2026-08-18 09:04:31.486986 | aio | TASK [vexxhost.ceph.mon : Assert exactly one address matches the public network] ***
2026-08-18 09:04:31.487040 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.131)       0:01:21.644 ********
2026-08-18 09:04:31.532309 | aio | ok: [aio] => {
2026-08-18 09:04:31.532339 | aio |     "changed": false,
2026-08-18 09:04:31.532349 | aio |     "msg": "All assertions passed"
2026-08-18 09:04:31.532359 | aio | }
2026-08-18 09:04:31.532368 | aio |
2026-08-18 09:04:31.532377 | aio | TASK [vexxhost.ceph.mon : Set this monitor's Ceph public IP] *******************
2026-08-18 09:04:31.532386 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.045)       0:01:21.689 ********
2026-08-18 09:04:31.574551 | aio | ok: [aio]
2026-08-18 09:04:31.574579 | aio |
2026-08-18 09:04:31.574588 | aio | TASK [vexxhost.ceph.mon : Check whether any monitor is already bootstrapped] ***
2026-08-18 09:04:31.574597 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.042)       0:01:21.732 ********
2026-08-18 09:04:31.844003 | aio | ok: [aio] => (item=aio)
2026-08-18 09:04:31.844105 | aio |
2026-08-18 09:04:31.844119 | aio | TASK [vexxhost.ceph.mon : Select the bootstrap node (existing one, else the first monitor)] ***
2026-08-18 09:04:31.844129 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.269)       0:01:22.002 ********
2026-08-18 09:04:31.896479 | aio | ok: [aio]
2026-08-18 09:04:31.896582 | aio |
2026-08-18 09:04:31.896605 | aio | TASK [vexxhost.ceph.mon : Bootstrap the cluster] *******************************
2026-08-18 09:04:31.896882 | aio | Tuesday 18 August 2026  09:04:31 +0000 (0:00:00.052)       0:01:22.054 ********
2026-08-18 09:04:31.956423 | aio | ERROR! couldn't resolve module/action 'community.crypto.openssh_keypair'. This often indicates a misspelling, missing collection, or incorrect module path.
2026-08-18 09:04:31.956492 | aio |
2026-08-18 09:04:31.956503 | aio | The error appears to be in '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap.yml': line 43, column 7, but may
2026-08-18 09:04:31.956512 | aio | be elsewhere in the file depending on the exact syntax problem.
2026-08-18 09:04:31.956522 | aio |
2026-08-18 09:04:31.956530 | aio | The offending line appears to be:
2026-08-18 09:04:31.956539 | aio |
2026-08-18 09:04:31.956548 | aio |
2026-08-18 09:04:31.956556 | aio |     - name: Generate a cephadm SSH keypair when none was provided
2026-08-18 09:04:31.956572 | aio |       ^ here
2026-08-18 09:04:32.059419 | aio | CRITICAL Ansible return code was 4, 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-18 09:04:32.059464 | aio | ERROR    [default > converge] Executed: Failed
2026-08-18 09:04:32.059479 | aio | ERROR    Ansible return code was 4, 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-18 09:04:32.168981 | aio | ERROR
2026-08-18 09:04:32.169124 | aio | {
2026-08-18 09:04:32.169153 | aio |   "delta": "0:04:23.841847",
2026-08-18 09:04:32.169173 | aio |   "end": "2026-08-18 09:04:32.126818",
2026-08-18 09:04:32.169191 | aio |   "msg": "non-zero return code",
2026-08-18 09:04:32.169209 | aio |   "rc": 4,
2026-08-18 09:04:32.169226 | aio |   "start": "2026-08-18 09:00:08.284971"
2026-08-18 09:04:32.169243 | aio | }
failure
2026-08-18 09:04:32.174064 | 
2026-08-18 09:04:32.174113 | PLAY RECAP
2026-08-18 09:04:32.174154 | aio | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-18 09:04:32.174176 | 
2026-08-18 09:04:32.291281 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-18 09:04:32.293099 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-18 09:04:32.892705 | 
2026-08-18 09:04:32.892864 | PLAY [all]
2026-08-18 09:04:32.904511 | 
2026-08-18 09:04:32.904582 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-18 09:04:32.948917 | aio | skipping: Conditional result was False
2026-08-18 09:04:32.959794 | 
2026-08-18 09:04:32.959877 | TASK [fetch-output : Set log path for single node]
2026-08-18 09:04:33.005920 | aio | ok
2026-08-18 09:04:33.012798 | 
2026-08-18 09:04:33.012900 | LOOP [fetch-output : Ensure local output dirs]
2026-08-18 09:04:33.393274 | aio -> localhost | ok: "/var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/logs"
2026-08-18 09:04:33.612321 | aio -> localhost | changed: "/var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/artifacts"
2026-08-18 09:04:33.814641 | aio -> localhost | changed: "/var/lib/zuul/builds/a64e5a49549444b8939a523f2a446551/work/docs"
2026-08-18 09:04:33.832457 | 
2026-08-18 09:04:33.832609 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-18 09:04:34.476115 | aio | ok
2026-08-18 09:04:34.476404 | aio | changed: All items complete
2026-08-18 09:04:34.476438 | 
2026-08-18 09:04:34.939444 | aio | changed: .d..t...... ./
2026-08-18 09:04:35.401169 | aio | changed: .d..t...... ./
2026-08-18 09:04:35.414800 | 
2026-08-18 09:04:35.414937 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-18 09:04:35.819512 | aio -> localhost | ok: Item: artifacts Runtime: 0:00:00.006621
2026-08-18 09:04:36.029699 | aio -> localhost | ok: Item: docs Runtime: 0:00:00.006088
2026-08-18 09:04:36.047113 | 
2026-08-18 09:04:36.047233 | PLAY [all]
2026-08-18 09:04:36.053569 | 
2026-08-18 09:04:36.053637 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-18 09:04:36.502355 | aio | changed
2026-08-18 09:04:36.509982 | 
2026-08-18 09:04:36.510167 | PLAY RECAP
2026-08-18 09:04:36.510240 | aio | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-18 09:04:36.510272 | 
2026-08-18 09:04:36.666444 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-18 09:04:36.670225 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-18 09:04:37.255162 | 
2026-08-18 09:04:37.255281 | PLAY [localhost]
2026-08-18 09:04:37.265809 | 
2026-08-18 09:04:37.265890 | TASK [Generate Zuul manifest]
2026-08-18 09:04:37.286724 | localhost | ok
2026-08-18 09:04:37.301945 | 
2026-08-18 09:04:37.302033 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-18 09:04:37.667591 | localhost | changed
2026-08-18 09:04:37.679457 | 
2026-08-18 09:04:37.679535 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-18 09:04:37.883946 | localhost | ok
2026-08-18 09:04:37.893248 | 
2026-08-18 09:04:37.893338 | TASK [Upload logs]
2026-08-18 09:04:37.915016 | localhost | ok
2026-08-18 09:04:37.975073 | 
2026-08-18 09:04:37.975198 | TASK [Set zuul-log-path fact]
2026-08-18 09:04:37.994577 | localhost | ok
2026-08-18 09:04:38.005532 | 
2026-08-18 09:04:38.005600 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-18 09:04:38.037254 | localhost | ok
2026-08-18 09:04:38.048407 | 
2026-08-18 09:04:38.048507 | TASK [upload-logs : Create log directories]
2026-08-18 09:04:38.454403 | localhost | changed
2026-08-18 09:04:38.460664 | 
2026-08-18 09:04:38.460754 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-18 09:04:38.845304 | localhost -> localhost | ok: Runtime: 0:00:00.005362
2026-08-18 09:04:38.851936 | 
2026-08-18 09:04:38.852024 | TASK [upload-logs : Upload logs to log server]
2026-08-18 09:04:39.297755 | localhost | Output suppressed because no_log was given
2026-08-18 09:04:39.302697 | 
2026-08-18 09:04:39.302783 | LOOP [upload-logs : Compress console log and json output]
2026-08-18 09:04:39.347868 | localhost | skipping: Conditional result was False
2026-08-18 09:04:39.395234 | localhost | skipping: Conditional result was False
2026-08-18 09:04:39.407983 | 
2026-08-18 09:04:39.408095 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-18 09:04:39.451938 | localhost | skipping: Conditional result was False
2026-08-18 09:04:39.452236 | 
2026-08-18 09:04:39.456364 | localhost | skipping: Conditional result was False
2026-08-18 09:04:39.471531 | 
2026-08-18 09:04:39.471699 | LOOP [upload-logs : Upload console log and json output]