2026-04-18 17:28:42.930603 | Job console starting 2026-04-18 17:28:42.947593 | Updating git repos 2026-04-18 17:28:43.026008 | Cloning repos into workspace 2026-04-18 17:28:45.721003 | Restoring repo states 2026-04-18 17:28:45.728093 | Merging changes 2026-04-18 17:28:46.830272 | Checking out repos 2026-04-18 17:28:46.892987 | Preparing playbooks 2026-04-18 17:28:57.161836 | Running Ansible setup 2026-04-18 17:29:02.581906 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:29:03.215359 | 2026-04-18 17:29:03.215518 | PLAY [localhost] 2026-04-18 17:29:03.223795 | 2026-04-18 17:29:03.223869 | TASK [Gathering Facts] 2026-04-18 17:29:04.321388 | localhost | ok 2026-04-18 17:29:04.328017 | 2026-04-18 17:29:04.328105 | TASK [Setup log path fact] 2026-04-18 17:29:04.348905 | localhost | ok 2026-04-18 17:29:04.361639 | 2026-04-18 17:29:04.361716 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:29:04.391802 | localhost | ok 2026-04-18 17:29:04.399345 | 2026-04-18 17:29:04.399408 | TASK [emit-job-header : Print job information] 2026-04-18 17:29:04.440037 | # Job Information 2026-04-18 17:29:04.440374 | Ansible Version: 2.16.16 2026-04-18 17:29:04.440439 | Job: ansible-collection-ceph-molecule-ha-ubuntu-jammy 2026-04-18 17:29:04.440488 | Pipeline: check 2026-04-18 17:29:04.440519 | Executor: 0a8996d2b663 2026-04-18 17:29:04.440547 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/104 2026-04-18 17:29:04.440579 | Event ID: 2f372d80-3b4a-11f1-8301-3470debd7c83 2026-04-18 17:29:04.444723 | 2026-04-18 17:29:04.444818 | LOOP [emit-job-header : Print node information] 2026-04-18 17:29:04.566816 | localhost | ok: 2026-04-18 17:29:04.567114 | localhost | # Node Information 2026-04-18 17:29:04.567163 | localhost | Inventory Hostname: mon1 2026-04-18 17:29:04.567195 | localhost | Hostname: np0000167505 2026-04-18 17:29:04.567224 | localhost | Username: zuul 2026-04-18 17:29:04.567255 | localhost | Distro: Ubuntu 22.04 2026-04-18 17:29:04.567283 | localhost | Provider: yul1 2026-04-18 17:29:04.567311 | localhost | Region: ca-ymq-1 2026-04-18 17:29:04.567337 | localhost | Label: ubuntu-jammy 2026-04-18 17:29:04.567363 | localhost | Product Name: OpenStack Nova 2026-04-18 17:29:04.567389 | localhost | Interface IP: 199.19.213.191 2026-04-18 17:29:04.813189 | localhost | ok: 2026-04-18 17:29:04.813387 | localhost | # Node Information 2026-04-18 17:29:04.813447 | localhost | Inventory Hostname: osd1 2026-04-18 17:29:04.813494 | localhost | Hostname: np0000167506 2026-04-18 17:29:04.813539 | localhost | Username: zuul 2026-04-18 17:29:04.813581 | localhost | Distro: Ubuntu 22.04 2026-04-18 17:29:04.813623 | localhost | Provider: yul1 2026-04-18 17:29:04.813665 | localhost | Region: ca-ymq-1 2026-04-18 17:29:04.813706 | localhost | Label: ubuntu-jammy 2026-04-18 17:29:04.813748 | localhost | Product Name: OpenStack Nova 2026-04-18 17:29:04.813792 | localhost | Interface IP: 199.204.45.44 2026-04-18 17:29:04.827828 | 2026-04-18 17:29:04.827981 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 17:29:05.559742 | localhost -> localhost | changed 2026-04-18 17:29:05.564357 | 2026-04-18 17:29:05.564445 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 17:29:07.597984 | localhost -> localhost | changed 2026-04-18 17:29:07.604640 | 2026-04-18 17:29:07.604698 | PLAY [all] 2026-04-18 17:29:07.615774 | 2026-04-18 17:29:07.616195 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 17:29:07.897445 | mon1 -> localhost | ok 2026-04-18 17:29:07.923905 | 2026-04-18 17:29:07.924045 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 17:29:07.982594 | mon1 | ok 2026-04-18 17:29:08.007697 | osd1 | ok 2026-04-18 17:29:08.055341 | mon1 | included: /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 17:29:08.055463 | osd1 | included: /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 17:29:08.061630 | 2026-04-18 17:29:08.061688 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 17:29:09.660446 | mon1 -> localhost | Generating public/private rsa key pair. 2026-04-18 17:29:09.660698 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/15a578b5f6524a5ea00d31177497f988_id_rsa 2026-04-18 17:29:09.660769 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/15a578b5f6524a5ea00d31177497f988_id_rsa.pub 2026-04-18 17:29:09.660823 | mon1 -> localhost | The key fingerprint is: 2026-04-18 17:29:09.660872 | mon1 -> localhost | SHA256:b8kL0shIx8Apeq6vZH3ynU17WeQcvnoNLn9EBp6hAbY zuul-build-sshkey 2026-04-18 17:29:09.660919 | mon1 -> localhost | The key's randomart image is: 2026-04-18 17:29:09.661134 | mon1 -> localhost | +---[RSA 3072]----+ 2026-04-18 17:29:09.661211 | mon1 -> localhost | | o. | 2026-04-18 17:29:09.661262 | mon1 -> localhost | | . . . .. o | 2026-04-18 17:29:09.661308 | mon1 -> localhost | | . + E + + | 2026-04-18 17:29:09.661354 | mon1 -> localhost | | . . o . = o | 2026-04-18 17:29:09.661446 | mon1 -> localhost | |. . . o S = + | 2026-04-18 17:29:09.661501 | mon1 -> localhost | | o.. + o o . * . | 2026-04-18 17:29:09.661545 | mon1 -> localhost | | o.o..+ o.= + = | 2026-04-18 17:29:09.661588 | mon1 -> localhost | |o. + ..+o.= + o | 2026-04-18 17:29:09.661631 | mon1 -> localhost | |oo. . o oo.=.. | 2026-04-18 17:29:09.661672 | mon1 -> localhost | +----[SHA256]-----+ 2026-04-18 17:29:09.661855 | mon1 -> localhost | ok: Runtime: 0:00:01.196010 2026-04-18 17:29:09.667509 | 2026-04-18 17:29:09.667569 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 17:29:09.699986 | mon1 | ok 2026-04-18 17:29:10.073095 | osd1 | ok 2026-04-18 17:29:10.087922 | mon1 | included: /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 17:29:10.088025 | osd1 | included: /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 17:29:10.099314 | 2026-04-18 17:29:10.099422 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 17:29:10.148284 | mon1 | skipping: Conditional result was False 2026-04-18 17:29:10.149162 | osd1 | skipping: Conditional result was False 2026-04-18 17:29:10.159640 | 2026-04-18 17:29:10.159848 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 17:29:10.652104 | mon1 | changed 2026-04-18 17:29:10.962142 | osd1 | changed 2026-04-18 17:29:10.969731 | 2026-04-18 17:29:10.969823 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 17:29:11.150651 | mon1 | ok 2026-04-18 17:29:11.157476 | osd1 | ok 2026-04-18 17:29:11.165611 | 2026-04-18 17:29:11.165696 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 17:29:11.614960 | mon1 | changed 2026-04-18 17:29:11.835841 | osd1 | changed 2026-04-18 17:29:11.845847 | 2026-04-18 17:29:11.845977 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 17:29:12.297043 | osd1 | changed 2026-04-18 17:29:12.677687 | mon1 | changed 2026-04-18 17:29:12.684727 | 2026-04-18 17:29:12.684863 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 17:29:12.714693 | mon1 | skipping: Conditional result was False 2026-04-18 17:29:12.725873 | osd1 | skipping: Conditional result was False 2026-04-18 17:29:12.767156 | 2026-04-18 17:29:12.767271 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 17:29:13.136109 | mon1 -> localhost | changed 2026-04-18 17:29:13.157038 | 2026-04-18 17:29:13.157266 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 17:29:13.433512 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/15a578b5f6524a5ea00d31177497f988_id_rsa (zuul-build-sshkey) 2026-04-18 17:29:13.433726 | mon1 -> localhost | ok: Runtime: 0:00:00.012561 2026-04-18 17:29:13.439337 | 2026-04-18 17:29:13.439400 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 17:29:13.714417 | osd1 | ok 2026-04-18 17:29:13.870700 | mon1 | ok 2026-04-18 17:29:13.875426 | 2026-04-18 17:29:13.875551 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 17:29:13.899010 | mon1 | skipping: Conditional result was False 2026-04-18 17:29:13.910869 | osd1 | skipping: Conditional result was False 2026-04-18 17:29:13.933532 | 2026-04-18 17:29:13.933671 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 17:29:14.246756 | osd1 | ok 2026-04-18 17:29:14.261031 | mon1 | ok 2026-04-18 17:29:14.266256 | 2026-04-18 17:29:14.266321 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 17:29:14.926516 | mon1 | Output suppressed because no_log was given 2026-04-18 17:29:15.170742 | osd1 | Output suppressed because no_log was given 2026-04-18 17:29:15.188140 | 2026-04-18 17:29:15.188251 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 17:29:15.366831 | mon1 | ok: "logs" 2026-04-18 17:29:15.367172 | mon1 | ok: All items complete 2026-04-18 17:29:15.367227 | 2026-04-18 17:29:15.374884 | osd1 | ok: "logs" 2026-04-18 17:29:15.581023 | osd1 | ok: "artifacts" 2026-04-18 17:29:15.586535 | mon1 | ok: "artifacts" 2026-04-18 17:29:15.692892 | osd1 | ok: "docs" 2026-04-18 17:29:15.707087 | mon1 | ok: "docs" 2026-04-18 17:29:15.717255 | 2026-04-18 17:29:15.717364 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 17:29:15.916927 | mon1 | changed: "logs" 2026-04-18 17:29:15.917171 | mon1 | ok: All items complete 2026-04-18 17:29:15.917207 | 2026-04-18 17:29:15.922367 | osd1 | changed: "logs" 2026-04-18 17:29:16.061340 | osd1 | changed: "artifacts" 2026-04-18 17:29:16.066625 | mon1 | changed: "artifacts" 2026-04-18 17:29:16.206319 | osd1 | changed: "docs" 2026-04-18 17:29:16.441835 | mon1 | changed: "docs" 2026-04-18 17:29:16.456729 | 2026-04-18 17:29:16.456817 | PLAY RECAP 2026-04-18 17:29:16.456863 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:29:16.456893 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 17:29:16.456919 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 17:29:16.456939 | 2026-04-18 17:29:16.616973 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:29:16.624550 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:29:17.146886 | 2026-04-18 17:29:17.201406 | PLAY [all] 2026-04-18 17:29:17.216099 | 2026-04-18 17:29:17.216213 | TASK [setup-uv : Extract archive] 2026-04-18 17:29:19.399063 | osd1 | changed 2026-04-18 17:29:23.860753 | mon1 | changed 2026-04-18 17:29:24.008371 | 2026-04-18 17:29:24.008607 | TASK [setup-uv : Print version] 2026-04-18 17:29:24.369915 | osd1 | uv 0.8.13 2026-04-18 17:29:24.370994 | mon1 | uv 0.8.13 2026-04-18 17:29:24.568619 | osd1 | ok: Runtime: 0:00:00.013153 2026-04-18 17:29:24.578356 | mon1 | ok: Runtime: 0:00:00.014380 2026-04-18 17:29:24.587891 | 2026-04-18 17:29:24.587940 | PLAY RECAP 2026-04-18 17:29:24.587983 | mon1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:29:24.588010 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:29:24.588029 | 2026-04-18 17:29:24.685814 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:29:24.691391 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:29:25.240521 | 2026-04-18 17:29:25.353790 | PLAY [all] 2026-04-18 17:29:25.371812 | 2026-04-18 17:29:25.371888 | TASK [Copy inventory file for Zuul] 2026-04-18 17:29:26.175532 | mon1 | changed 2026-04-18 17:29:26.244473 | 2026-04-18 17:29:26.244615 | TASK [Switch "ansible_host" to private IP] 2026-04-18 17:29:26.541119 | mon1 | changed: 2 replacements made 2026-04-18 17:29:26.605715 | 2026-04-18 17:29:26.605828 | TASK [Run Molecule scenario] 2026-04-18 17:29:34.733442 | mon1 | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-18 17:29:35.483778 | mon1 | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-18 17:29:35.665055 | mon1 | Using CPython 3.13.7 2026-04-18 17:29:35.665142 | mon1 | Creating virtual environment at: .venv 2026-04-18 17:29:35.706515 | mon1 | Downloading netaddr (2.2MiB) 2026-04-18 17:29:35.707073 | mon1 | Downloading pygments (1.2MiB) 2026-04-18 17:29:35.707298 | mon1 | Downloading ansible-core (2.1MiB) 2026-04-18 17:29:35.713492 | mon1 | Downloading cryptography (4.3MiB) 2026-04-18 17:29:35.894642 | mon1 | Downloading netaddr 2026-04-18 17:29:35.904500 | mon1 | Downloading cryptography 2026-04-18 17:29:35.952361 | mon1 | Downloading pygments 2026-04-18 17:29:36.100575 | mon1 | Downloading ansible-core 2026-04-18 17:29:36.128324 | mon1 | Installed 36 packages in 27ms 2026-04-18 17:29:37.219343 | mon1 | INFO Collection 'vexxhost.ceph' detected. 2026-04-18 17:29:37.219423 | mon1 | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 17:29:37.830185 | mon1 | INFO [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 17:29:37.830295 | mon1 | INFO [default > prerun] Performing prerun with role_name_check=0... 2026-04-18 17:29:56.001326 | mon1 | INFO [default > dependency] Executing 2026-04-18 17:29:56.001478 | mon1 | WARNING [default > dependency] Missing roles requirements file: requirements.yml 2026-04-18 17:29:56.001652 | mon1 | WARNING [default > dependency] Missing collections requirements file: collections.yml 2026-04-18 17:29:56.001763 | mon1 | WARNING [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 17:29:56.006908 | mon1 | INFO [default > cleanup] Executing 2026-04-18 17:29:56.007181 | mon1 | WARNING [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:29:56.012120 | mon1 | INFO [default > destroy] Executing 2026-04-18 17:29:56.012237 | mon1 | WARNING [default > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:29:56.012259 | mon1 | INFO [default > destroy] Executed: Successful 2026-04-18 17:29:56.017231 | mon1 | INFO [default > syntax] Executing 2026-04-18 17:29:56.965282 | mon1 | 2026-04-18 17:29:56.965544 | mon1 | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml 2026-04-18 17:29:57.018698 | mon1 | INFO [default > syntax] Executed: Successful 2026-04-18 17:29:57.030057 | mon1 | INFO [default > create] Executing 2026-04-18 17:29:57.031393 | mon1 | WARNING [default > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:29:57.036326 | mon1 | INFO [default > prepare] Executing 2026-04-18 17:29:57.685951 | mon1 | 2026-04-18 17:29:57.686153 | mon1 | PLAY [Prepare] ***************************************************************** 2026-04-18 17:29:57.686347 | mon1 | 2026-04-18 17:29:57.686560 | mon1 | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:29:57.686770 | mon1 | Saturday 18 April 2026 17:29:57 +0000 (0:00:00.029) 0:00:00.029 ******** 2026-04-18 17:29:58.812963 | mon1 | [WARNING]: Platform linux on host osd1 is using the discovered Python 2026-04-18 17:29:58.813109 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-18 17:29:58.813322 | mon1 | interpreter could change the meaning of that path. See 2026-04-18 17:29:58.813527 | mon1 | https://docs.ansible.com/ansible- 2026-04-18 17:29:58.813783 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:29:58.837166 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python 2026-04-18 17:29:58.837339 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-18 17:29:58.837541 | mon1 | interpreter could change the meaning of that path. See 2026-04-18 17:29:58.837825 | mon1 | https://docs.ansible.com/ansible- 2026-04-18 17:29:58.837986 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:29:58.846476 | mon1 | ok: [osd1] 2026-04-18 17:29:58.846616 | mon1 | ok: [mon1] 2026-04-18 17:29:58.846799 | mon1 | 2026-04-18 17:29:58.847002 | mon1 | TASK [Configure short hostname] ************************************************ 2026-04-18 17:29:58.847209 | mon1 | Saturday 18 April 2026 17:29:58 +0000 (0:00:01.160) 0:00:01.190 ******** 2026-04-18 17:29:59.531100 | mon1 | changed: [osd1] 2026-04-18 17:29:59.531274 | mon1 | changed: [mon1] 2026-04-18 17:29:59.531461 | mon1 | 2026-04-18 17:29:59.531716 | mon1 | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-18 17:29:59.532055 | mon1 | Saturday 18 April 2026 17:29:59 +0000 (0:00:00.684) 0:00:01.875 ******** 2026-04-18 17:29:59.798593 | mon1 | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-18 17:29:59.798760 | mon1 | with a mode of 0700, this may cause issues when running as another user. To 2026-04-18 17:29:59.798964 | mon1 | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-18 17:29:59.810657 | mon1 | changed: [mon1] 2026-04-18 17:29:59.810782 | mon1 | changed: [osd1] 2026-04-18 17:29:59.810898 | mon1 | 2026-04-18 17:29:59.811022 | mon1 | TASK [Update apt cache] ******************************************************** 2026-04-18 17:29:59.811149 | mon1 | Saturday 18 April 2026 17:29:59 +0000 (0:00:00.280) 0:00:02.155 ******** 2026-04-18 17:30:07.174426 | mon1 | changed: [osd1] 2026-04-18 17:30:07.174534 | mon1 | changed: [mon1] 2026-04-18 17:30:07.174723 | mon1 | 2026-04-18 17:30:07.174927 | mon1 | PLAY [Create devices for Ceph] ************************************************* 2026-04-18 17:30:07.175108 | mon1 | 2026-04-18 17:30:07.175307 | mon1 | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:30:07.175511 | mon1 | Saturday 18 April 2026 17:30:07 +0000 (0:00:07.363) 0:00:09.518 ******** 2026-04-18 17:30:07.847036 | mon1 | ok: [osd1] 2026-04-18 17:30:07.847122 | mon1 | 2026-04-18 17:30:07.847375 | mon1 | TASK [Install depedencies] ***************************************************** 2026-04-18 17:30:07.847584 | mon1 | Saturday 18 April 2026 17:30:07 +0000 (0:00:00.672) 0:00:10.191 ******** 2026-04-18 17:30:27.013586 | mon1 | changed: [osd1] 2026-04-18 17:30:27.014275 | mon1 | 2026-04-18 17:30:27.014288 | mon1 | TASK [Start up service] ******************************************************** 2026-04-18 17:30:27.014295 | mon1 | Saturday 18 April 2026 17:30:27 +0000 (0:00:19.165) 0:00:29.356 ******** 2026-04-18 17:30:27.567519 | mon1 | ok: [osd1] 2026-04-18 17:30:27.567648 | mon1 | 2026-04-18 17:30:27.567962 | mon1 | TASK [Generate lvm.conf] ******************************************************* 2026-04-18 17:30:27.568126 | mon1 | Saturday 18 April 2026 17:30:27 +0000 (0:00:00.554) 0:00:29.911 ******** 2026-04-18 17:30:27.873786 | mon1 | ok: [osd1] 2026-04-18 17:30:27.873933 | mon1 | 2026-04-18 17:30:27.874189 | mon1 | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-18 17:30:27.874364 | mon1 | Saturday 18 April 2026 17:30:27 +0000 (0:00:00.306) 0:00:30.218 ******** 2026-04-18 17:30:28.526223 | mon1 | changed: [osd1] 2026-04-18 17:30:28.526352 | mon1 | 2026-04-18 17:30:28.526562 | mon1 | TASK [Get list of all loopback devices] **************************************** 2026-04-18 17:30:28.526767 | mon1 | Saturday 18 April 2026 17:30:28 +0000 (0:00:00.652) 0:00:30.870 ******** 2026-04-18 17:30:28.710820 | mon1 | ok: [osd1] 2026-04-18 17:30:28.710991 | mon1 | 2026-04-18 17:30:28.711196 | mon1 | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-18 17:30:28.711397 | mon1 | Saturday 18 April 2026 17:30:28 +0000 (0:00:00.185) 0:00:31.055 ******** 2026-04-18 17:30:28.731114 | mon1 | skipping: [osd1] 2026-04-18 17:30:28.731269 | mon1 | 2026-04-18 17:30:28.731464 | mon1 | TASK [Create devices for Ceph] ************************************************* 2026-04-18 17:30:28.731660 | mon1 | Saturday 18 April 2026 17:30:28 +0000 (0:00:00.020) 0:00:31.075 ******** 2026-04-18 17:30:29.272772 | mon1 | changed: [osd1] => (item=osd0) 2026-04-18 17:30:29.272936 | mon1 | changed: [osd1] => (item=osd1) 2026-04-18 17:30:29.273138 | mon1 | changed: [osd1] => (item=osd2) 2026-04-18 17:30:29.273330 | mon1 | 2026-04-18 17:30:29.273636 | mon1 | TASK [Set permissions on loopback devices] ************************************* 2026-04-18 17:30:29.273973 | mon1 | Saturday 18 April 2026 17:30:29 +0000 (0:00:00.541) 0:00:31.617 ******** 2026-04-18 17:30:29.883419 | mon1 | changed: [osd1] => (item=osd0) 2026-04-18 17:30:29.883569 | mon1 | changed: [osd1] => (item=osd1) 2026-04-18 17:30:29.883815 | mon1 | changed: [osd1] => (item=osd2) 2026-04-18 17:30:29.884000 | mon1 | 2026-04-18 17:30:29.884199 | mon1 | TASK [Start loop devices] ****************************************************** 2026-04-18 17:30:29.884384 | mon1 | Saturday 18 April 2026 17:30:29 +0000 (0:00:00.610) 0:00:32.227 ******** 2026-04-18 17:30:30.580981 | mon1 | changed: [osd1] => (item=osd0) 2026-04-18 17:30:30.581135 | mon1 | changed: [osd1] => (item=osd1) 2026-04-18 17:30:30.581402 | mon1 | changed: [osd1] => (item=osd2) 2026-04-18 17:30:30.581653 | mon1 | 2026-04-18 17:30:30.581855 | mon1 | TASK [Create a volume group for each loop device] ****************************** 2026-04-18 17:30:30.582059 | mon1 | Saturday 18 April 2026 17:30:30 +0000 (0:00:00.697) 0:00:32.924 ******** 2026-04-18 17:30:33.411322 | mon1 | changed: [osd1] => (item=osd0) 2026-04-18 17:30:33.411420 | mon1 | changed: [osd1] => (item=osd1) 2026-04-18 17:30:33.411640 | mon1 | changed: [osd1] => (item=osd2) 2026-04-18 17:30:33.411874 | mon1 | 2026-04-18 17:30:33.412287 | mon1 | TASK [Create a logical volume for each loop device] **************************** 2026-04-18 17:30:33.412452 | mon1 | Saturday 18 April 2026 17:30:33 +0000 (0:00:02.830) 0:00:35.755 ******** 2026-04-18 17:30:35.221163 | mon1 | changed: [osd1] => (item=ceph-osd1-osd0) 2026-04-18 17:30:35.221328 | mon1 | changed: [osd1] => (item=ceph-osd1-osd1) 2026-04-18 17:30:35.221541 | mon1 | changed: [osd1] => (item=ceph-osd1-osd2) 2026-04-18 17:30:35.221842 | mon1 | 2026-04-18 17:30:35.222066 | mon1 | PLAY RECAP ********************************************************************* 2026-04-18 17:30:35.222223 | mon1 | mon1 : ok=4 changed=3 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 17:30:35.222439 | mon1 | osd1 : ok=15 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-18 17:30:35.222620 | mon1 | 2026-04-18 17:30:35.222799 | mon1 | 2026-04-18 17:30:35.222988 | mon1 | TASKS RECAP ******************************************************************** 2026-04-18 17:30:35.223232 | mon1 | Saturday 18 April 2026 17:30:35 +0000 (0:00:01.810) 0:00:37.565 ******** 2026-04-18 17:30:35.223430 | mon1 | =============================================================================== 2026-04-18 17:30:35.223629 | mon1 | Install depedencies ---------------------------------------------------- 19.17s 2026-04-18 17:30:35.223917 | mon1 | Update apt cache -------------------------------------------------------- 7.36s 2026-04-18 17:30:35.224122 | mon1 | Create a volume group for each loop device ------------------------------ 2.83s 2026-04-18 17:30:35.224309 | mon1 | Create a logical volume for each loop device ---------------------------- 1.81s 2026-04-18 17:30:35.224515 | mon1 | Gathering Facts --------------------------------------------------------- 1.16s 2026-04-18 17:30:35.224698 | mon1 | Start loop devices ------------------------------------------------------ 0.70s 2026-04-18 17:30:35.224897 | mon1 | Configure short hostname ------------------------------------------------ 0.68s 2026-04-18 17:30:35.225092 | mon1 | Gathering Facts --------------------------------------------------------- 0.67s 2026-04-18 17:30:35.225284 | mon1 | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s 2026-04-18 17:30:35.225481 | mon1 | Set permissions on loopback devices ------------------------------------- 0.61s 2026-04-18 17:30:35.225712 | mon1 | Start up service -------------------------------------------------------- 0.55s 2026-04-18 17:30:35.225969 | mon1 | Create devices for Ceph ------------------------------------------------- 0.54s 2026-04-18 17:30:35.226184 | mon1 | Generate lvm.conf ------------------------------------------------------- 0.31s 2026-04-18 17:30:35.226388 | mon1 | Ensure hostname inside hosts file --------------------------------------- 0.28s 2026-04-18 17:30:35.226606 | mon1 | Get list of all loopback devices ---------------------------------------- 0.19s 2026-04-18 17:30:35.226818 | mon1 | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-04-18 17:30:35.289538 | mon1 | INFO [default > prepare] Executed: Successful 2026-04-18 17:30:35.299620 | mon1 | INFO [default > converge] Executing 2026-04-18 17:30:36.091014 | mon1 | 2026-04-18 17:30:36.091070 | mon1 | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-04-18 17:30:36.091262 | mon1 | 2026-04-18 17:30:36.091300 | mon1 | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:30:36.091517 | mon1 | Saturday 18 April 2026 17:30:36 +0000 (0:00:00.044) 0:00:00.044 ******** 2026-04-18 17:30:37.082112 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python 2026-04-18 17:30:37.082296 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-18 17:30:37.082501 | mon1 | interpreter could change the meaning of that path. See 2026-04-18 17:30:37.082704 | mon1 | https://docs.ansible.com/ansible- 2026-04-18 17:30:37.082910 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:30:37.093748 | mon1 | ok: [mon1] 2026-04-18 17:30:37.093990 | mon1 | 2026-04-18 17:30:37.094205 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:30:37.094413 | mon1 | Saturday 18 April 2026 17:30:37 +0000 (0:00:01.002) 0:00:01.047 ******** 2026-04-18 17:30:37.382848 | mon1 | ok: [mon1] 2026-04-18 17:30:37.383020 | mon1 | 2026-04-18 17:30:37.383231 | mon1 | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:30:37.383434 | mon1 | Saturday 18 April 2026 17:30:37 +0000 (0:00:00.288) 0:00:01.336 ******** 2026-04-18 17:30:37.423411 | mon1 | skipping: [mon1] 2026-04-18 17:30:37.423606 | mon1 | 2026-04-18 17:30:37.423853 | mon1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 17:30:37.424059 | mon1 | Saturday 18 April 2026 17:30:37 +0000 (0:00:00.040) 0:00:01.377 ******** 2026-04-18 17:30:37.745721 | mon1 | changed: [mon1] 2026-04-18 17:30:37.745897 | mon1 | 2026-04-18 17:30:37.746150 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:30:37.746382 | mon1 | Saturday 18 April 2026 17:30:37 +0000 (0:00:00.321) 0:00:01.699 ******** 2026-04-18 17:30:37.846789 | mon1 | ok: [mon1] => { 2026-04-18 17:30:37.847001 | mon1 | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-18 17:30:37.847190 | mon1 | } 2026-04-18 17:30:37.847369 | mon1 | 2026-04-18 17:30:37.847573 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:30:37.847802 | mon1 | Saturday 18 April 2026 17:30:37 +0000 (0:00:00.100) 0:00:01.800 ******** 2026-04-18 17:30:38.533270 | mon1 | changed: [mon1] 2026-04-18 17:30:38.533429 | mon1 | 2026-04-18 17:30:38.533642 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:30:38.533846 | mon1 | Saturday 18 April 2026 17:30:38 +0000 (0:00:00.686) 0:00:02.486 ******** 2026-04-18 17:30:38.570924 | mon1 | skipping: [mon1] 2026-04-18 17:30:38.571089 | mon1 | 2026-04-18 17:30:38.571306 | mon1 | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:30:38.571514 | mon1 | Saturday 18 April 2026 17:30:38 +0000 (0:00:00.038) 0:00:02.524 ******** 2026-04-18 17:30:38.607064 | mon1 | skipping: [mon1] 2026-04-18 17:30:38.607226 | mon1 | 2026-04-18 17:30:38.607442 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:30:38.607652 | mon1 | Saturday 18 April 2026 17:30:38 +0000 (0:00:00.036) 0:00:02.560 ******** 2026-04-18 17:30:38.804506 | mon1 | ok: [mon1] 2026-04-18 17:30:38.804652 | mon1 | 2026-04-18 17:30:38.804913 | mon1 | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:30:38.805116 | mon1 | Saturday 18 April 2026 17:30:38 +0000 (0:00:00.197) 0:00:02.757 ******** 2026-04-18 17:30:39.921759 | mon1 | ok: [mon1] 2026-04-18 17:30:39.921923 | mon1 | 2026-04-18 17:30:39.922141 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:30:39.922343 | mon1 | Saturday 18 April 2026 17:30:39 +0000 (0:00:01.117) 0:00:03.875 ******** 2026-04-18 17:30:39.994110 | mon1 | ok: [mon1] => { 2026-04-18 17:30:39.994325 | mon1 | "msg": "https://github.com/containerd/containerd/releases/download/v2.2.2/containerd-2.2.2-linux-amd64.tar.gz" 2026-04-18 17:30:40.000755 | mon1 | } 2026-04-18 17:30:40.001599 | mon1 | 2026-04-18 17:30:40.001605 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:30:40.001610 | mon1 | Saturday 18 April 2026 17:30:39 +0000 (0:00:00.072) 0:00:03.948 ******** 2026-04-18 17:30:40.746877 | mon1 | changed: [mon1] 2026-04-18 17:30:40.746978 | mon1 | 2026-04-18 17:30:40.746991 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:30:40.747001 | mon1 | Saturday 18 April 2026 17:30:40 +0000 (0:00:00.750) 0:00:04.698 ******** 2026-04-18 17:30:44.719646 | mon1 | changed: [mon1] 2026-04-18 17:30:44.719753 | mon1 | 2026-04-18 17:30:44.719771 | mon1 | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-18 17:30:44.719990 | mon1 | Saturday 18 April 2026 17:30:44 +0000 (0:00:03.974) 0:00:08.673 ******** 2026-04-18 17:30:44.748481 | mon1 | skipping: [mon1] 2026-04-18 17:30:44.748821 | mon1 | 2026-04-18 17:30:44.748881 | mon1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-18 17:30:44.748888 | mon1 | Saturday 18 April 2026 17:30:44 +0000 (0:00:00.028) 0:00:08.701 ******** 2026-04-18 17:30:44.773914 | mon1 | skipping: [mon1] 2026-04-18 17:30:44.774057 | mon1 | 2026-04-18 17:30:44.774341 | mon1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-18 17:30:44.774369 | mon1 | Saturday 18 April 2026 17:30:44 +0000 (0:00:00.025) 0:00:08.727 ******** 2026-04-18 17:30:44.804483 | mon1 | skipping: [mon1] 2026-04-18 17:30:44.804578 | mon1 | 2026-04-18 17:30:44.804795 | mon1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-18 17:30:44.804837 | mon1 | Saturday 18 April 2026 17:30:44 +0000 (0:00:00.030) 0:00:08.758 ******** 2026-04-18 17:30:51.166648 | mon1 | changed: [mon1] 2026-04-18 17:30:51.166727 | mon1 | 2026-04-18 17:30:51.166774 | mon1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-18 17:30:51.166890 | mon1 | Saturday 18 April 2026 17:30:51 +0000 (0:00:06.351) 0:00:15.109 ******** 2026-04-18 17:30:51.731269 | mon1 | changed: [mon1] 2026-04-18 17:30:51.731431 | mon1 | 2026-04-18 17:30:51.731443 | mon1 | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-18 17:30:51.731496 | mon1 | Saturday 18 April 2026 17:30:51 +0000 (0:00:00.575) 0:00:15.685 ******** 2026-04-18 17:30:52.665938 | mon1 | changed: [mon1] => (item={'path': '/etc/containerd'}) 2026-04-18 17:30:52.666015 | mon1 | changed: [mon1] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-18 17:30:52.666095 | mon1 | changed: [mon1] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-18 17:30:52.666191 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-18 17:30:52.666286 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-18 17:30:52.666370 | mon1 | 2026-04-18 17:30:52.666462 | mon1 | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-18 17:30:52.666553 | mon1 | Saturday 18 April 2026 17:30:52 +0000 (0:00:00.934) 0:00:16.619 ******** 2026-04-18 17:30:53.255043 | mon1 | changed: [mon1] 2026-04-18 17:30:53.255185 | mon1 | 2026-04-18 17:30:53.255432 | mon1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-18 17:30:53.255635 | mon1 | Saturday 18 April 2026 17:30:53 +0000 (0:00:00.581) 0:00:17.201 ******** 2026-04-18 17:30:53.255864 | mon1 | 2026-04-18 17:30:53.256089 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-04-18 17:30:53.256296 | mon1 | Saturday 18 April 2026 17:30:53 +0000 (0:00:00.007) 0:00:17.208 ******** 2026-04-18 17:30:54.145410 | mon1 | ok: [mon1] 2026-04-18 17:30:54.145469 | mon1 | 2026-04-18 17:30:54.145475 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-04-18 17:30:54.145480 | mon1 | Saturday 18 April 2026 17:30:54 +0000 (0:00:00.890) 0:00:18.098 ******** 2026-04-18 17:30:54.595292 | mon1 | changed: [mon1] 2026-04-18 17:30:54.595382 | mon1 | 2026-04-18 17:30:54.595419 | mon1 | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-18 17:30:54.595561 | mon1 | Saturday 18 April 2026 17:30:54 +0000 (0:00:00.450) 0:00:18.549 ******** 2026-04-18 17:30:55.154472 | mon1 | changed: [mon1] 2026-04-18 17:30:55.154553 | mon1 | 2026-04-18 17:30:55.154568 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:30:55.154726 | mon1 | Saturday 18 April 2026 17:30:55 +0000 (0:00:00.559) 0:00:19.108 ******** 2026-04-18 17:30:55.361378 | mon1 | ok: [mon1] 2026-04-18 17:30:55.361432 | mon1 | 2026-04-18 17:30:55.361645 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:30:55.361680 | mon1 | Saturday 18 April 2026 17:30:55 +0000 (0:00:00.206) 0:00:19.315 ******** 2026-04-18 17:30:55.435598 | mon1 | ok: [mon1] => { 2026-04-18 17:30:55.435750 | mon1 | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-04-18 17:30:55.436285 | mon1 | } 2026-04-18 17:30:55.436322 | mon1 | 2026-04-18 17:30:55.436329 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:30:55.436336 | mon1 | Saturday 18 April 2026 17:30:55 +0000 (0:00:00.074) 0:00:19.389 ******** 2026-04-18 17:30:56.335031 | mon1 | changed: [mon1] 2026-04-18 17:30:56.335111 | mon1 | 2026-04-18 17:30:56.335174 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:30:56.335312 | mon1 | Saturday 18 April 2026 17:30:56 +0000 (0:00:00.899) 0:00:20.288 ******** 2026-04-18 17:31:00.814826 | mon1 | changed: [mon1] 2026-04-18 17:31:00.814876 | mon1 | 2026-04-18 17:31:00.814882 | mon1 | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-04-18 17:31:00.814887 | mon1 | Saturday 18 April 2026 17:31:00 +0000 (0:00:04.479) 0:00:24.768 ******** 2026-04-18 17:31:01.970217 | mon1 | ok: [mon1] 2026-04-18 17:31:01.970295 | mon1 | 2026-04-18 17:31:01.970489 | mon1 | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-04-18 17:31:01.970535 | mon1 | Saturday 18 April 2026 17:31:01 +0000 (0:00:01.155) 0:00:25.924 ******** 2026-04-18 17:31:02.320151 | mon1 | changed: [mon1] 2026-04-18 17:31:02.320221 | mon1 | 2026-04-18 17:31:02.320286 | mon1 | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-04-18 17:31:02.320403 | mon1 | Saturday 18 April 2026 17:31:02 +0000 (0:00:00.349) 0:00:26.273 ******** 2026-04-18 17:31:02.805437 | mon1 | changed: [mon1] 2026-04-18 17:31:02.805493 | mon1 | 2026-04-18 17:31:02.805501 | mon1 | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-04-18 17:31:02.805507 | mon1 | Saturday 18 April 2026 17:31:02 +0000 (0:00:00.484) 0:00:26.758 ******** 2026-04-18 17:31:03.371629 | mon1 | changed: [mon1] => (item={'path': '/etc/docker'}) 2026-04-18 17:31:03.371859 | mon1 | changed: [mon1] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-04-18 17:31:03.371868 | mon1 | changed: [mon1] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-04-18 17:31:03.371872 | mon1 | 2026-04-18 17:31:03.371877 | mon1 | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-04-18 17:31:03.371881 | mon1 | Saturday 18 April 2026 17:31:03 +0000 (0:00:00.565) 0:00:27.324 ******** 2026-04-18 17:31:03.806263 | mon1 | changed: [mon1] 2026-04-18 17:31:03.806347 | mon1 | 2026-04-18 17:31:03.806409 | mon1 | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-04-18 17:31:03.806535 | mon1 | Saturday 18 April 2026 17:31:03 +0000 (0:00:00.435) 0:00:27.760 ******** 2026-04-18 17:31:04.253690 | mon1 | changed: [mon1] 2026-04-18 17:31:04.253771 | mon1 | 2026-04-18 17:31:04.253832 | mon1 | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-04-18 17:31:04.254209 | mon1 | Saturday 18 April 2026 17:31:04 +0000 (0:00:00.440) 0:00:28.200 ******** 2026-04-18 17:31:04.254262 | mon1 | 2026-04-18 17:31:04.254268 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-04-18 17:31:04.254287 | mon1 | Saturday 18 April 2026 17:31:04 +0000 (0:00:00.007) 0:00:28.207 ******** 2026-04-18 17:31:04.904261 | mon1 | ok: [mon1] 2026-04-18 17:31:04.904320 | mon1 | 2026-04-18 17:31:04.904328 | mon1 | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-04-18 17:31:04.904336 | mon1 | Saturday 18 April 2026 17:31:04 +0000 (0:00:00.649) 0:00:28.857 ******** 2026-04-18 17:31:05.650253 | mon1 | changed: [mon1] 2026-04-18 17:31:05.650317 | mon1 | 2026-04-18 17:31:05.650323 | mon1 | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-04-18 17:31:05.650328 | mon1 | Saturday 18 April 2026 17:31:05 +0000 (0:00:00.746) 0:00:29.603 ******** 2026-04-18 17:31:06.160669 | mon1 | changed: [mon1] 2026-04-18 17:31:06.160752 | mon1 | 2026-04-18 17:31:06.160819 | mon1 | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-04-18 17:31:06.160976 | mon1 | Saturday 18 April 2026 17:31:06 +0000 (0:00:00.510) 0:00:30.113 ******** 2026-04-18 17:31:06.200996 | mon1 | ok: [mon1] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-04-18 17:31:06.201096 | mon1 | 2026-04-18 17:31:06.201111 | mon1 | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-04-18 17:31:06.201292 | mon1 | Saturday 18 April 2026 17:31:06 +0000 (0:00:00.040) 0:00:30.154 ******** 2026-04-18 17:31:31.946393 | mon1 | changed: [mon1] 2026-04-18 17:31:31.946446 | mon1 | 2026-04-18 17:31:31.946452 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-04-18 17:31:31.946457 | mon1 | Saturday 18 April 2026 17:31:31 +0000 (0:00:25.745) 0:00:55.899 ******** 2026-04-18 17:31:32.578416 | mon1 | ok: [mon1] => (item=chronyd) 2026-04-18 17:31:32.578535 | mon1 | ok: [mon1] => (item=sshd) 2026-04-18 17:31:32.578967 | mon1 | 2026-04-18 17:31:32.579022 | mon1 | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-04-18 17:31:32.579030 | mon1 | Saturday 18 April 2026 17:31:32 +0000 (0:00:00.632) 0:00:56.532 ******** 2026-04-18 17:31:32.873785 | mon1 | changed: [mon1] 2026-04-18 17:31:32.873866 | mon1 | 2026-04-18 17:31:32.873924 | mon1 | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-04-18 17:31:32.874047 | mon1 | Saturday 18 April 2026 17:31:32 +0000 (0:00:00.295) 0:00:56.827 ******** 2026-04-18 17:31:33.064634 | mon1 | ok: [mon1] 2026-04-18 17:31:33.064691 | mon1 | 2026-04-18 17:31:33.064751 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-04-18 17:31:33.064870 | mon1 | Saturday 18 April 2026 17:31:33 +0000 (0:00:00.190) 0:00:57.018 ******** 2026-04-18 17:31:33.521007 | mon1 | changed: [mon1] 2026-04-18 17:31:33.521082 | mon1 | 2026-04-18 17:31:33.521277 | mon1 | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-04-18 17:31:33.521320 | mon1 | Saturday 18 April 2026 17:31:33 +0000 (0:00:00.456) 0:00:57.474 ******** 2026-04-18 17:31:33.838528 | mon1 | changed: [mon1] 2026-04-18 17:31:33.838597 | mon1 | 2026-04-18 17:31:33.838786 | mon1 | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-04-18 17:31:33.838824 | mon1 | Saturday 18 April 2026 17:31:33 +0000 (0:00:00.317) 0:00:57.792 ******** 2026-04-18 17:31:33.946968 | mon1 | ok: [mon1] 2026-04-18 17:31:33.947355 | mon1 | 2026-04-18 17:31:33.947404 | mon1 | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-04-18 17:31:33.947412 | mon1 | Saturday 18 April 2026 17:31:33 +0000 (0:00:00.108) 0:00:57.900 ******** 2026-04-18 17:31:34.147631 | mon1 | ok: [mon1] => (item=mon1) 2026-04-18 17:31:34.147730 | mon1 | 2026-04-18 17:31:34.147847 | mon1 | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-04-18 17:31:34.148093 | mon1 | Saturday 18 April 2026 17:31:34 +0000 (0:00:00.200) 0:00:58.101 ******** 2026-04-18 17:31:34.192073 | mon1 | ok: [mon1] 2026-04-18 17:31:34.192148 | mon1 | 2026-04-18 17:31:34.192162 | mon1 | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-04-18 17:31:34.192257 | mon1 | Saturday 18 April 2026 17:31:34 +0000 (0:00:00.044) 0:00:58.145 ******** 2026-04-18 17:31:34.295223 | mon1 | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for mon1 2026-04-18 17:31:34.295288 | mon1 | 2026-04-18 17:31:34.295347 | mon1 | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-04-18 17:31:34.295434 | mon1 | Saturday 18 April 2026 17:31:34 +0000 (0:00:00.103) 0:00:58.249 ******** 2026-04-18 17:31:34.586884 | mon1 | changed: [mon1] 2026-04-18 17:31:34.586985 | mon1 | 2026-04-18 17:31:34.587003 | mon1 | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-04-18 17:31:34.587062 | mon1 | Saturday 18 April 2026 17:31:34 +0000 (0:00:00.291) 0:00:58.540 ******** 2026-04-18 17:31:35.215578 | mon1 | changed: [mon1] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-04-18 17:31:35.215636 | mon1 | changed: [mon1] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-04-18 17:31:35.216086 | mon1 | changed: [mon1] => (item={'option': 'mon data avail warn', 'section': 'mon', 'value': 10}) 2026-04-18 17:31:35.216133 | mon1 | 2026-04-18 17:31:35.216139 | mon1 | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-04-18 17:31:35.216144 | mon1 | Saturday 18 April 2026 17:31:35 +0000 (0:00:00.628) 0:00:59.169 ******** 2026-04-18 17:33:02.557001 | mon1 | ok: [mon1] 2026-04-18 17:33:02.557124 | mon1 | 2026-04-18 17:33:02.557138 | mon1 | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-04-18 17:33:02.557150 | mon1 | Saturday 18 April 2026 17:33:02 +0000 (0:01:27.340) 0:02:26.510 ******** 2026-04-18 17:33:02.752131 | mon1 | changed: [mon1] 2026-04-18 17:33:02.752248 | mon1 | 2026-04-18 17:33:02.752261 | mon1 | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-04-18 17:33:02.752274 | mon1 | Saturday 18 April 2026 17:33:02 +0000 (0:00:00.195) 0:02:26.705 ******** 2026-04-18 17:33:02.790281 | mon1 | ok: [mon1] 2026-04-18 17:33:02.790322 | mon1 | 2026-04-18 17:33:02.790419 | mon1 | TASK [Install Ceph host] ******************************************************* 2026-04-18 17:33:02.790508 | mon1 | Saturday 18 April 2026 17:33:02 +0000 (0:00:00.038) 0:02:26.744 ******** 2026-04-18 17:33:02.856569 | mon1 | included: vexxhost.ceph.cephadm_host for mon1 2026-04-18 17:33:02.856637 | mon1 | 2026-04-18 17:33:02.856657 | mon1 | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-04-18 17:33:02.856793 | mon1 | Saturday 18 April 2026 17:33:02 +0000 (0:00:00.066) 0:02:26.810 ******** 2026-04-18 17:33:07.993304 | mon1 | ok: [mon1] 2026-04-18 17:33:07.993381 | mon1 | 2026-04-18 17:33:07.993639 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-04-18 17:33:07.993685 | mon1 | Saturday 18 April 2026 17:33:07 +0000 (0:00:05.136) 0:02:31.947 ******** 2026-04-18 17:33:08.037695 | mon1 | ok: [mon1] => (item=mon1) 2026-04-18 17:33:08.037760 | mon1 | 2026-04-18 17:33:08.038038 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-04-18 17:33:08.038083 | mon1 | Saturday 18 April 2026 17:33:08 +0000 (0:00:00.044) 0:02:31.991 ******** 2026-04-18 17:33:08.383374 | mon1 | ok: [mon1] 2026-04-18 17:33:08.383492 | mon1 | 2026-04-18 17:33:08.383506 | mon1 | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-04-18 17:33:08.383623 | mon1 | Saturday 18 April 2026 17:33:08 +0000 (0:00:00.345) 0:02:32.337 ******** 2026-04-18 17:33:15.735846 | mon1 | ok: [mon1] 2026-04-18 17:33:15.735919 | mon1 | 2026-04-18 17:33:15.736113 | mon1 | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-04-18 17:33:15.736151 | mon1 | Saturday 18 April 2026 17:33:15 +0000 (0:00:07.352) 0:02:39.689 ******** 2026-04-18 17:34:03.522464 | mon1 | changed: [mon1] 2026-04-18 17:34:03.522545 | mon1 | 2026-04-18 17:34:03.522557 | mon1 | TASK [vexxhost.ceph.mon : Validate monitor exist] ****************************** 2026-04-18 17:34:03.522660 | mon1 | Saturday 18 April 2026 17:34:03 +0000 (0:00:47.785) 0:03:27.475 ******** 2026-04-18 17:34:17.553039 | mon1 | ok: [mon1] 2026-04-18 17:34:17.553112 | mon1 | 2026-04-18 17:34:17.553143 | mon1 | TASK [Install Ceph host] ******************************************************* 2026-04-18 17:34:17.553264 | mon1 | Saturday 18 April 2026 17:34:17 +0000 (0:00:14.031) 0:03:41.506 ******** 2026-04-18 17:34:17.610974 | mon1 | included: vexxhost.ceph.cephadm_host for mon1 2026-04-18 17:34:17.611019 | mon1 | 2026-04-18 17:34:17.611253 | mon1 | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-04-18 17:34:17.611301 | mon1 | Saturday 18 April 2026 17:34:17 +0000 (0:00:00.057) 0:03:41.564 ******** 2026-04-18 17:34:17.652146 | mon1 | skipping: [mon1] 2026-04-18 17:34:17.652227 | mon1 | 2026-04-18 17:34:17.652339 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-04-18 17:34:17.652467 | mon1 | Saturday 18 April 2026 17:34:17 +0000 (0:00:00.041) 0:03:41.606 ******** 2026-04-18 17:34:17.693672 | mon1 | skipping: [mon1] => (item=mon1) 2026-04-18 17:34:17.693747 | mon1 | skipping: [mon1] 2026-04-18 17:34:17.693760 | mon1 | 2026-04-18 17:34:17.693976 | mon1 | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-04-18 17:34:17.694025 | mon1 | Saturday 18 April 2026 17:34:17 +0000 (0:00:00.041) 0:03:41.647 ******** 2026-04-18 17:34:17.940368 | mon1 | ok: [mon1] 2026-04-18 17:34:17.940441 | mon1 | 2026-04-18 17:34:17.940723 | mon1 | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-04-18 17:34:17.940775 | mon1 | Saturday 18 April 2026 17:34:17 +0000 (0:00:00.246) 0:03:41.894 ******** 2026-04-18 17:34:24.259797 | mon1 | ok: [mon1] 2026-04-18 17:34:24.259917 | mon1 | 2026-04-18 17:34:24.259931 | mon1 | TASK [vexxhost.ceph.mgr : Configure "mgr" label for managers] ****************** 2026-04-18 17:34:24.259994 | mon1 | Saturday 18 April 2026 17:34:24 +0000 (0:00:06.319) 0:03:48.213 ******** 2026-04-18 17:34:36.344961 | mon1 | changed: [mon1] 2026-04-18 17:34:36.345183 | mon1 | 2026-04-18 17:34:36.345591 | mon1 | TASK [vexxhost.ceph.mgr : Validate manager exist] ****************************** 2026-04-18 17:34:36.345901 | mon1 | Saturday 18 April 2026 17:34:36 +0000 (0:00:12.084) 0:04:00.298 ******** 2026-04-18 17:34:42.373700 | mon1 | ok: [mon1] 2026-04-18 17:34:42.373773 | mon1 | 2026-04-18 17:34:42.373786 | mon1 | TASK [vexxhost.ceph.mgr : Configure manager modules] *************************** 2026-04-18 17:34:42.373797 | mon1 | Saturday 18 April 2026 17:34:42 +0000 (0:00:06.028) 0:04:06.326 ******** 2026-04-18 17:34:50.387352 | mon1 | changed: [mon1] => (item={'name': 'diskprediction_local'}) 2026-04-18 17:34:50.387438 | mon1 | ok: [mon1] => (item={'name': 'dashboard'}) 2026-04-18 17:34:50.387577 | mon1 | changed: [mon1] => (item={'name': 'prometheus'}) 2026-04-18 17:34:50.387708 | mon1 | ok: [mon1] => (item={'name': 'iostat'}) 2026-04-18 17:34:50.387908 | mon1 | 2026-04-18 17:34:50.388052 | mon1 | PLAY [Deploy Ceph OSDs] ******************************************************** 2026-04-18 17:34:50.388170 | mon1 | 2026-04-18 17:34:50.388299 | mon1 | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:34:50.388442 | mon1 | Saturday 18 April 2026 17:34:50 +0000 (0:00:08.014) 0:04:14.341 ******** 2026-04-18 17:34:51.460799 | mon1 | [WARNING]: Platform linux on host osd1 is using the discovered Python 2026-04-18 17:34:51.461004 | mon1 | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-18 17:34:51.461222 | mon1 | interpreter could change the meaning of that path. See 2026-04-18 17:34:51.461439 | mon1 | https://docs.ansible.com/ansible- 2026-04-18 17:34:51.461650 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:34:51.472761 | mon1 | ok: [osd1] 2026-04-18 17:34:51.472888 | mon1 | 2026-04-18 17:34:51.472896 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:34:51.472904 | mon1 | Saturday 18 April 2026 17:34:51 +0000 (0:00:01.085) 0:04:15.426 ******** 2026-04-18 17:34:51.667114 | mon1 | ok: [osd1] 2026-04-18 17:34:51.667208 | mon1 | 2026-04-18 17:34:51.667216 | mon1 | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:34:51.667296 | mon1 | Saturday 18 April 2026 17:34:51 +0000 (0:00:00.194) 0:04:15.621 ******** 2026-04-18 17:34:51.705600 | mon1 | skipping: [osd1] 2026-04-18 17:34:51.705656 | mon1 | 2026-04-18 17:34:51.705772 | mon1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 17:34:51.705866 | mon1 | Saturday 18 April 2026 17:34:51 +0000 (0:00:00.038) 0:04:15.659 ******** 2026-04-18 17:34:51.912991 | mon1 | changed: [osd1] 2026-04-18 17:34:51.913084 | mon1 | 2026-04-18 17:34:51.913096 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:34:51.913154 | mon1 | Saturday 18 April 2026 17:34:51 +0000 (0:00:00.207) 0:04:15.866 ******** 2026-04-18 17:34:51.978386 | mon1 | ok: [osd1] => { 2026-04-18 17:34:51.978460 | mon1 | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-18 17:34:51.978474 | mon1 | } 2026-04-18 17:34:51.978558 | mon1 | 2026-04-18 17:34:51.978650 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:34:51.978741 | mon1 | Saturday 18 April 2026 17:34:51 +0000 (0:00:00.065) 0:04:15.932 ******** 2026-04-18 17:35:23.400487 | mon1 | fatal: [osd1]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false} 2026-04-18 17:35:23.407818 | mon1 | FAILED - RETRYING: [osd1]: Download item (4 retries left). 2026-04-18 17:35:23.407920 | mon1 | FAILED - RETRYING: [osd1]: Download item (3 retries left). 2026-04-18 17:35:23.407932 | mon1 | FAILED - RETRYING: [osd1]: Download item (2 retries left). 2026-04-18 17:35:23.407941 | mon1 | FAILED - RETRYING: [osd1]: Download item (1 retries left). 2026-04-18 17:35:23.407950 | mon1 | 2026-04-18 17:35:23.407970 | mon1 | PLAY RECAP ********************************************************************* 2026-04-18 17:35:23.407980 | mon1 | mon1 : ok=59 changed=29 unreachable=0 failed=0 skipped=8 rescued=0 ignored=0 2026-04-18 17:35:23.407990 | mon1 | osd1 : ok=4 changed=1 unreachable=0 failed=1 skipped=1 rescued=0 ignored=0 2026-04-18 17:35:23.407998 | mon1 | 2026-04-18 17:35:23.408007 | mon1 | 2026-04-18 17:35:23.408016 | mon1 | TASKS RECAP ******************************************************************** 2026-04-18 17:35:23.408025 | mon1 | Saturday 18 April 2026 17:35:23 +0000 (0:00:31.424) 0:04:47.357 ******** 2026-04-18 17:35:23.408034 | mon1 | =============================================================================== 2026-04-18 17:35:23.408042 | mon1 | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 87.34s 2026-04-18 17:35:23.408051 | mon1 | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 47.79s 2026-04-18 17:35:23.408059 | mon1 | vexxhost.containers.download_artifact : Download item ------------------ 31.42s 2026-04-18 17:35:23.408068 | mon1 | vexxhost.ceph.cephadm : Install packages ------------------------------- 25.75s 2026-04-18 17:35:23.408076 | mon1 | vexxhost.ceph.mon : Validate monitor exist ----------------------------- 14.03s 2026-04-18 17:35:23.408085 | mon1 | vexxhost.ceph.mgr : Configure "mgr" label for managers ----------------- 12.08s 2026-04-18 17:35:23.408094 | mon1 | vexxhost.ceph.mgr : Configure manager modules --------------------------- 8.01s 2026-04-18 17:35:23.408102 | mon1 | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 7.35s 2026-04-18 17:35:23.408111 | mon1 | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.35s 2026-04-18 17:35:23.408119 | mon1 | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 6.32s 2026-04-18 17:35:23.408128 | mon1 | vexxhost.ceph.mgr : Validate manager exist ------------------------------ 6.03s 2026-04-18 17:35:23.408136 | mon1 | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 5.14s 2026-04-18 17:35:23.408154 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 4.48s 2026-04-18 17:35:23.408163 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 3.97s 2026-04-18 17:35:23.408358 | mon1 | vexxhost.containers.containerd : Reload systemd ------------------------- 1.54s 2026-04-18 17:35:23.408636 | mon1 | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.16s 2026-04-18 17:35:23.408894 | mon1 | vexxhost.containers.package : Update state for tar ---------------------- 1.12s 2026-04-18 17:35:23.409057 | mon1 | Gathering Facts --------------------------------------------------------- 1.09s 2026-04-18 17:35:23.409215 | mon1 | Gathering Facts --------------------------------------------------------- 1.00s 2026-04-18 17:35:23.409376 | mon1 | vexxhost.containers.containerd : Create folders for configuration ------- 0.93s 2026-04-18 17:35:23.485660 | 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-04-18 17:35:23.485892 | mon1 | ERROR [default > converge] Executed: Failed 2026-04-18 17:35:23.486062 | 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-04-18 17:35:35.080176 | mon1 | ERROR 2026-04-18 17:35:35.080411 | mon1 | { 2026-04-18 17:35:35.080454 | mon1 | "delta": "0:05:56.607979", 2026-04-18 17:35:35.080485 | mon1 | "end": "2026-04-18 17:35:23.565472", 2026-04-18 17:35:35.080512 | mon1 | "msg": "non-zero return code", 2026-04-18 17:35:35.080539 | mon1 | "rc": 2, 2026-04-18 17:35:35.080568 | mon1 | "start": "2026-04-18 17:29:26.957493" 2026-04-18 17:35:35.080595 | mon1 | } failure 2026-04-18 17:35:35.089464 | 2026-04-18 17:35:35.089519 | PLAY RECAP 2026-04-18 17:35:35.089564 | mon1 | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:35:35.089585 | 2026-04-18 17:35:36.314908 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:35:36.317924 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:35:40.973995 | 2026-04-18 17:35:40.974115 | PLAY [all] 2026-04-18 17:35:40.985945 | 2026-04-18 17:35:40.986020 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 17:35:41.029833 | mon1 | ok 2026-04-18 17:35:41.047582 | osd1 | ok 2026-04-18 17:35:41.053610 | 2026-04-18 17:35:41.053713 | TASK [fetch-output : Set log path for single node] 2026-04-18 17:35:41.079792 | mon1 | skipping: Conditional result was False 2026-04-18 17:35:41.091126 | osd1 | skipping: Conditional result was False 2026-04-18 17:35:41.101820 | 2026-04-18 17:35:41.101973 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 17:35:42.087591 | mon1 -> localhost | changed: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/logs/mon1" 2026-04-18 17:35:42.101959 | osd1 -> localhost | changed: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/logs/osd1" 2026-04-18 17:35:42.343632 | mon1 -> localhost | changed: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/artifacts" 2026-04-18 17:35:42.355393 | osd1 -> localhost | ok: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/artifacts" 2026-04-18 17:35:42.555734 | mon1 -> localhost | changed: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/docs" 2026-04-18 17:35:42.557003 | osd1 -> localhost | ok: "/var/lib/zuul/builds/15a578b5f6524a5ea00d31177497f988/work/docs" 2026-04-18 17:35:42.577522 | 2026-04-18 17:35:42.578305 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 17:35:43.210486 | osd1 | changed: .d..t...... ./ 2026-04-18 17:35:43.210767 | osd1 | changed: All items complete 2026-04-18 17:35:43.210816 | 2026-04-18 17:35:43.219061 | mon1 | changed: .d..t...... ./ 2026-04-18 17:35:43.669827 | osd1 | ok 2026-04-18 17:35:44.070525 | mon1 | changed: .d..t...... ./ 2026-04-18 17:35:44.114114 | osd1 | changed: .d..t...... ./ 2026-04-18 17:35:44.513633 | mon1 | ok 2026-04-18 17:35:44.531133 | 2026-04-18 17:35:44.531283 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 17:35:44.967379 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008575 2026-04-18 17:35:44.967730 | mon1 -> localhost | changed: All items complete 2026-04-18 17:35:44.967770 | 2026-04-18 17:35:45.219003 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.008920 2026-04-18 17:35:45.239350 | 2026-04-18 17:35:45.239490 | PLAY [all] 2026-04-18 17:35:45.245748 | 2026-04-18 17:35:45.245819 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 17:35:45.643684 | mon1 | changed 2026-04-18 17:35:45.818987 | osd1 | changed 2026-04-18 17:35:45.829991 | 2026-04-18 17:35:45.830078 | PLAY RECAP 2026-04-18 17:35:45.830128 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:35:45.830157 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:35:45.830177 | 2026-04-18 17:35:45.949491 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:35:45.954911 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 17:35:47.182394 | 2026-04-18 17:35:47.182513 | PLAY [localhost] 2026-04-18 17:35:47.192307 | 2026-04-18 17:35:47.192382 | TASK [Generate Zuul manifest] 2026-04-18 17:35:47.215076 | localhost | ok 2026-04-18 17:35:47.889074 | 2026-04-18 17:35:47.889271 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 17:35:49.895717 | localhost | changed 2026-04-18 17:35:49.910845 | 2026-04-18 17:35:49.911020 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 17:35:50.489733 | localhost | ok 2026-04-18 17:35:50.499690 | 2026-04-18 17:35:50.499808 | TASK [Upload logs] 2026-04-18 17:35:50.522370 | localhost | ok 2026-04-18 17:35:51.549528 | 2026-04-18 17:35:51.549655 | TASK [Set zuul-log-path fact] 2026-04-18 17:35:51.569269 | localhost | ok 2026-04-18 17:35:51.581984 | 2026-04-18 17:35:51.582051 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:35:51.608980 | localhost | ok 2026-04-18 17:35:51.616305 | 2026-04-18 17:35:51.616393 | TASK [upload-logs : Create log directories] 2026-04-18 17:35:52.006441 | localhost | changed 2026-04-18 17:35:52.012948 | 2026-04-18 17:35:52.013080 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 17:35:52.418286 | localhost -> localhost | ok: Runtime: 0:00:00.004432 2026-04-18 17:35:52.424697 | 2026-04-18 17:35:52.424788 | TASK [upload-logs : Upload logs to log server] 2026-04-18 17:35:54.556671 | localhost | Output suppressed because no_log was given 2026-04-18 17:35:54.561643 | 2026-04-18 17:35:54.561732 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 17:35:54.608520 | localhost | skipping: Conditional result was False 2026-04-18 17:35:54.615600 | localhost | skipping: Conditional result was False 2026-04-18 17:35:54.627607 | 2026-04-18 17:35:54.627742 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 17:35:54.670832 | localhost | skipping: Conditional result was False 2026-04-18 17:35:54.671213 | 2026-04-18 17:35:54.674897 | localhost | skipping: Conditional result was False 2026-04-18 17:35:54.690138 | 2026-04-18 17:35:54.690277 | LOOP [upload-logs : Upload console log and json output]