2026-05-14 17:32:05.021301 | Job console starting
2026-05-14 17:32:05.050848 | Updating git repos
2026-05-14 17:32:05.087810 | Cloning repos into workspace
2026-05-14 17:32:05.253122 | Restoring repo states
2026-05-14 17:32:05.265236 | Merging changes
2026-05-14 17:32:05.623654 | Checking out repos
2026-05-14 17:32:05.664270 | Preparing playbooks
2026-05-14 17:32:07.005835 | Running Ansible setup
2026-05-14 17:32:12.020257 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-14 17:32:12.620351 | 
2026-05-14 17:32:12.620480 | PLAY [localhost]
2026-05-14 17:32:12.628038 | 
2026-05-14 17:32:12.628109 | TASK [Gathering Facts]
2026-05-14 17:32:13.479139 | localhost | ok
2026-05-14 17:32:13.489776 | 
2026-05-14 17:32:13.489876 | TASK [Setup log path fact]
2026-05-14 17:32:13.510595 | localhost | ok
2026-05-14 17:32:13.525301 | 
2026-05-14 17:32:13.525393 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-14 17:32:13.555773 | localhost | ok
2026-05-14 17:32:13.563592 | 
2026-05-14 17:32:13.563670 | TASK [emit-job-header : Print job information]
2026-05-14 17:32:13.603490 | # Job Information
2026-05-14 17:32:13.603637 | Ansible Version: 2.16.18
2026-05-14 17:32:13.603679 | Job: ansible-collection-ceph-molecule-ha-ubuntu-noble
2026-05-14 17:32:13.603707 | Pipeline: check
2026-05-14 17:32:13.603731 | Executor: 2d72f0692154
2026-05-14 17:32:13.603754 | Triggered by: https://github.com/vexxhost/ansible-collection-ceph/pull/98
2026-05-14 17:32:13.603783 | Event ID: bd3ba4b0-4fba-11f1-8eff-43f4fa45cc81
2026-05-14 17:32:13.608389 | 
2026-05-14 17:32:13.608493 | LOOP [emit-job-header : Print node information]
2026-05-14 17:32:13.712081 | localhost | ok:
2026-05-14 17:32:13.712307 | localhost | # Node Information
2026-05-14 17:32:13.712338 | localhost | Inventory Hostname: mon1
2026-05-14 17:32:13.712361 | localhost | Hostname: np0000174275
2026-05-14 17:32:13.712381 | localhost | Username: zuul
2026-05-14 17:32:13.712409 | localhost | Distro: Ubuntu 24.04
2026-05-14 17:32:13.712431 | localhost | Provider: yul1
2026-05-14 17:32:13.712451 | localhost | Region: ca-ymq-1
2026-05-14 17:32:13.712470 | localhost | Label: ubuntu-noble
2026-05-14 17:32:13.712489 | localhost | Product Name: OpenStack Nova
2026-05-14 17:32:13.712507 | localhost | Interface IP: 199.204.45.49
2026-05-14 17:32:13.763670 | localhost | ok:
2026-05-14 17:32:13.763893 | localhost | # Node Information
2026-05-14 17:32:13.763954 | localhost | Inventory Hostname: osd1
2026-05-14 17:32:13.764002 | localhost | Hostname: np0000174276
2026-05-14 17:32:13.764048 | localhost | Username: zuul
2026-05-14 17:32:13.764093 | localhost | Distro: Ubuntu 24.04
2026-05-14 17:32:13.764137 | localhost | Provider: yul1
2026-05-14 17:32:13.764180 | localhost | Region: ca-ymq-1
2026-05-14 17:32:13.764224 | localhost | Label: ubuntu-noble
2026-05-14 17:32:13.764266 | localhost | Product Name: OpenStack Nova
2026-05-14 17:32:13.764312 | localhost | Interface IP: 199.204.45.38
2026-05-14 17:32:13.774296 | 
2026-05-14 17:32:13.774471 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-14 17:32:14.195587 | localhost -> localhost | changed
2026-05-14 17:32:14.201442 | 
2026-05-14 17:32:14.201807 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-14 17:32:15.059626 | localhost -> localhost | changed
2026-05-14 17:32:15.065944 | 
2026-05-14 17:32:15.066013 | PLAY [all]
2026-05-14 17:32:15.081632 | 
2026-05-14 17:32:15.081747 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-14 17:32:15.329793 | mon1 -> localhost | ok
2026-05-14 17:32:15.342544 | 
2026-05-14 17:32:15.342655 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-14 17:32:15.378166 | mon1 | ok
2026-05-14 17:32:15.384804 | osd1 | ok
2026-05-14 17:32:15.404296 | mon1 | included: /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-14 17:32:15.404381 | osd1 | included: /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-14 17:32:15.423995 | 
2026-05-14 17:32:15.424097 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-14 17:32:16.132520 | mon1 -> localhost | Generating public/private rsa key pair.
2026-05-14 17:32:16.132792 | mon1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/96ac126e401447e8a0494605e69fc080_id_rsa
2026-05-14 17:32:16.132927 | mon1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/96ac126e401447e8a0494605e69fc080_id_rsa.pub
2026-05-14 17:32:16.133021 | mon1 -> localhost | The key fingerprint is:
2026-05-14 17:32:16.133080 | mon1 -> localhost | SHA256:LaVD7eXvdhLVwZN/UE4N6exe15Pw/LK6HujlRgUgHNI zuul-build-sshkey
2026-05-14 17:32:16.133132 | mon1 -> localhost | The key's randomart image is:
2026-05-14 17:32:16.133182 | mon1 -> localhost | +---[RSA 3072]----+
2026-05-14 17:32:16.133231 | mon1 -> localhost | |      .oo...  o+=|
2026-05-14 17:32:16.133282 | mon1 -> localhost | |       .Eo  . oB.|
2026-05-14 17:32:16.133331 | mon1 -> localhost | |        . o .+ .*|
2026-05-14 17:32:16.133361 | mon1 -> localhost | |       . = o .+ =|
2026-05-14 17:32:16.133381 | mon1 -> localhost | |        S o .o+.+|
2026-05-14 17:32:16.133401 | mon1 -> localhost | |         o ...o=+|
2026-05-14 17:32:16.133421 | mon1 -> localhost | |          ..o..o+|
2026-05-14 17:32:16.133440 | mon1 -> localhost | |         . o.o= o|
2026-05-14 17:32:16.133460 | mon1 -> localhost | |          .o=+o= |
2026-05-14 17:32:16.133479 | mon1 -> localhost | +----[SHA256]-----+
2026-05-14 17:32:16.133526 | mon1 -> localhost | ok: Runtime: 0:00:00.267346
2026-05-14 17:32:16.139452 | 
2026-05-14 17:32:16.139525 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-14 17:32:16.182356 | mon1 | ok
2026-05-14 17:32:16.188383 | osd1 | ok
2026-05-14 17:32:16.201894 | mon1 | included: /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-14 17:32:16.201945 | osd1 | included: /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-14 17:32:16.212768 | 
2026-05-14 17:32:16.212829 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-14 17:32:16.238782 | mon1 | skipping: Conditional result was False
2026-05-14 17:32:16.239661 | osd1 | skipping: Conditional result was False
2026-05-14 17:32:16.252119 | 
2026-05-14 17:32:16.252354 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-14 17:32:16.787787 | mon1 | changed
2026-05-14 17:32:16.794230 | osd1 | changed
2026-05-14 17:32:16.799783 | 
2026-05-14 17:32:16.799910 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-14 17:32:17.030079 | osd1 | ok
2026-05-14 17:32:17.047697 | mon1 | ok
2026-05-14 17:32:17.055212 | 
2026-05-14 17:32:17.055297 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-14 17:32:17.616162 | mon1 | changed
2026-05-14 17:32:17.688742 | osd1 | changed
2026-05-14 17:32:17.696708 | 
2026-05-14 17:32:17.696812 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-14 17:32:18.269358 | mon1 | changed
2026-05-14 17:32:18.274459 | osd1 | changed
2026-05-14 17:32:18.279695 | 
2026-05-14 17:32:18.279760 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-14 17:32:18.309584 | mon1 | skipping: Conditional result was False
2026-05-14 17:32:18.330845 | osd1 | skipping: Conditional result was False
2026-05-14 17:32:18.339531 | 
2026-05-14 17:32:18.339626 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-14 17:32:18.655148 | mon1 -> localhost | changed
2026-05-14 17:32:18.676343 | 
2026-05-14 17:32:18.676473 | TASK [add-build-sshkey : Add back temp key]
2026-05-14 17:32:18.943835 | mon1 -> localhost | Identity added: /var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/96ac126e401447e8a0494605e69fc080_id_rsa (zuul-build-sshkey)
2026-05-14 17:32:18.944595 | mon1 -> localhost | ok: Runtime: 0:00:00.013355
2026-05-14 17:32:18.951203 | 
2026-05-14 17:32:18.951269 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-14 17:32:19.264127 | osd1 | ok
2026-05-14 17:32:19.270284 | mon1 | ok
2026-05-14 17:32:19.275225 | 
2026-05-14 17:32:19.275291 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-14 17:32:19.301607 | mon1 | skipping: Conditional result was False
2026-05-14 17:32:19.323585 | osd1 | skipping: Conditional result was False
2026-05-14 17:32:19.343692 | 
2026-05-14 17:32:19.343784 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-14 17:32:19.661162 | osd1 | ok
2026-05-14 17:32:19.665864 | mon1 | ok
2026-05-14 17:32:19.672088 | 
2026-05-14 17:32:19.672164 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-14 17:32:20.468489 | mon1 | Output suppressed because no_log was given
2026-05-14 17:32:20.473379 | osd1 | Output suppressed because no_log was given
2026-05-14 17:32:20.498389 | 
2026-05-14 17:32:20.498540 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-14 17:32:20.713964 | mon1 | ok: "logs"
2026-05-14 17:32:20.714241 | mon1 | ok: All items complete
2026-05-14 17:32:20.714273 | 
2026-05-14 17:32:20.730221 | osd1 | ok: "logs"
2026-05-14 17:32:20.909772 | mon1 | ok: "artifacts"
2026-05-14 17:32:20.936617 | osd1 | ok: "artifacts"
2026-05-14 17:32:21.123405 | mon1 | ok: "docs"
2026-05-14 17:32:21.130533 | osd1 | ok: "docs"
2026-05-14 17:32:21.149843 | 
2026-05-14 17:32:21.150033 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-14 17:32:21.389158 | osd1 | changed: "logs"
2026-05-14 17:32:21.389484 | osd1 | ok: All items complete
2026-05-14 17:32:21.389607 | 
2026-05-14 17:32:21.399919 | mon1 | changed: "logs"
2026-05-14 17:32:21.575305 | osd1 | changed: "artifacts"
2026-05-14 17:32:21.596719 | mon1 | changed: "artifacts"
2026-05-14 17:32:21.768660 | osd1 | changed: "docs"
2026-05-14 17:32:21.812476 | mon1 | changed: "docs"
2026-05-14 17:32:21.838333 | 
2026-05-14 17:32:21.838482 | PLAY RECAP
2026-05-14 17:32:21.838536 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 17:32:21.838567 | mon1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-14 17:32:21.838592 | osd1 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-14 17:32:21.838612 | 
2026-05-14 17:32:22.002435 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-14 17:32:22.005114 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-14 17:32:22.598436 | 
2026-05-14 17:32:22.598587 | PLAY [all]
2026-05-14 17:32:22.611095 | 
2026-05-14 17:32:22.611207 | TASK [setup-uv : Extract archive]
2026-05-14 17:32:24.993135 | osd1 | changed
2026-05-14 17:32:24.999542 | mon1 | changed
2026-05-14 17:32:25.006671 | 
2026-05-14 17:32:25.006782 | TASK [setup-uv : Print version]
2026-05-14 17:32:25.538988 | mon1 | uv 0.8.13
2026-05-14 17:32:24.788065 | osd1 | uv 0.8.13
2026-05-14 17:32:25.589556 | osd1 | ok: Runtime: 0:00:00.015093
2026-05-14 17:32:25.601111 | mon1 | ok: Runtime: 0:00:00.015639
2026-05-14 17:32:25.615678 | 
2026-05-14 17:32:25.615732 | PLAY RECAP
2026-05-14 17:32:25.615777 | mon1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 17:32:25.615805 | osd1 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-14 17:32:25.615825 | 
2026-05-14 17:32:25.735675 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-14 17:32:25.740858 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-14 17:32:26.350563 | 
2026-05-14 17:32:26.350712 | PLAY [all]
2026-05-14 17:32:26.362464 | 
2026-05-14 17:32:26.362544 | TASK [Copy inventory file for Zuul]
2026-05-14 17:32:27.348362 | mon1 | changed
2026-05-14 17:32:27.357798 | 
2026-05-14 17:32:27.357906 | TASK [Switch "ansible_host" to private IP]
2026-05-14 17:32:27.716374 | mon1 | changed: 2 replacements made
2026-05-14 17:32:27.722305 | 
2026-05-14 17:32:27.722375 | TASK [Run Molecule scenario]
2026-05-14 17:32:28.284803 | mon1 | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-05-14 17:32:28.284971 | mon1 | Creating virtual environment at: .venv
2026-05-14 17:32:28.693584 | mon1 | Downloading netaddr (2.2MiB)
2026-05-14 17:32:28.697863 | mon1 | Downloading pygments (1.2MiB)
2026-05-14 17:32:28.698178 | mon1 | Downloading cryptography (4.3MiB)
2026-05-14 17:32:28.724315 | mon1 | Downloading ansible-core (2.1MiB)
2026-05-14 17:32:28.890020 | mon1 |  Downloading netaddr
2026-05-14 17:32:28.901977 | mon1 |  Downloading cryptography
2026-05-14 17:32:28.972858 | mon1 |  Downloading pygments
2026-05-14 17:32:29.150211 | mon1 |  Downloading ansible-core
2026-05-14 17:32:29.198123 | mon1 | Installed 37 packages in 47ms
2026-05-14 17:32:29.981031 | mon1 | INFO     Collection 'vexxhost.ceph' detected.
2026-05-14 17:32:29.981134 | mon1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-14 17:32:30.640744 | mon1 | INFO     [default > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-14 17:32:30.640855 | mon1 | INFO     [default > prerun] Performing prerun with role_name_check=0...
2026-05-14 17:32:43.742361 | mon1 | INFO     [default > dependency] Executing
2026-05-14 17:32:43.742447 | mon1 | WARNING  [default > dependency] Missing roles requirements file: requirements.yml
2026-05-14 17:32:43.743011 | mon1 | WARNING  [default > dependency] Missing collections requirements file: collections.yml
2026-05-14 17:32:43.743315 | mon1 | WARNING  [default > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-05-14 17:32:43.755022 | mon1 | INFO     [default > cleanup] Executing
2026-05-14 17:32:43.755470 | mon1 | WARNING  [default > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-14 17:32:43.761263 | mon1 | INFO     [default > destroy] Executing
2026-05-14 17:32:43.761298 | mon1 | WARNING  [default > destroy] Skipping, '--destroy=never' requested.
2026-05-14 17:32:43.761384 | mon1 | INFO     [default > destroy] Executed: Successful
2026-05-14 17:32:43.767169 | mon1 | INFO     [default > syntax] Executing
2026-05-14 17:32:44.920652 | mon1 |
2026-05-14 17:32:44.920992 | mon1 | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-ceph/extensions/molecule/default/converge.yml
2026-05-14 17:32:45.024500 | mon1 | INFO     [default > syntax] Executed: Successful
2026-05-14 17:32:45.036546 | mon1 | INFO     [default > create] Executing
2026-05-14 17:32:45.038180 | mon1 | WARNING  [default > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-14 17:32:45.044151 | mon1 | INFO     [default > prepare] Executing
2026-05-14 17:32:45.879816 | mon1 |
2026-05-14 17:32:45.880041 | mon1 | PLAY [Prepare] *****************************************************************
2026-05-14 17:32:45.880256 | mon1 |
2026-05-14 17:32:45.880503 | mon1 | TASK [Gathering Facts] *********************************************************
2026-05-14 17:32:45.880786 | mon1 | Thursday 14 May 2026  17:32:45 +0000 (0:00:00.032)       0:00:00.032 **********
2026-05-14 17:32:47.120490 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-05-14 17:32:47.120588 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-14 17:32:47.120840 | mon1 | interpreter could change the meaning of that path. See
2026-05-14 17:32:47.121002 | mon1 | https://docs.ansible.com/ansible-
2026-05-14 17:32:47.121226 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-14 17:32:47.165745 | mon1 | [WARNING]: Platform linux on host osd1 is using the discovered Python
2026-05-14 17:32:47.165859 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-14 17:32:47.166131 | mon1 | interpreter could change the meaning of that path. See
2026-05-14 17:32:47.166377 | mon1 | https://docs.ansible.com/ansible-
2026-05-14 17:32:47.166608 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-14 17:32:47.175551 | mon1 | ok: [mon1]
2026-05-14 17:32:47.175792 | mon1 | ok: [osd1]
2026-05-14 17:32:47.176013 | mon1 |
2026-05-14 17:32:47.176257 | mon1 | TASK [Configure short hostname] ************************************************
2026-05-14 17:32:47.176498 | mon1 | Thursday 14 May 2026  17:32:47 +0000 (0:00:01.296)       0:00:01.329 **********
2026-05-14 17:32:48.005846 | mon1 | changed: [mon1]
2026-05-14 17:32:48.005887 | mon1 | changed: [osd1]
2026-05-14 17:32:48.005892 | mon1 |
2026-05-14 17:32:48.005901 | mon1 | TASK [Ensure hostname inside hosts file] ***************************************
2026-05-14 17:32:48.006153 | mon1 | Thursday 14 May 2026  17:32:48 +0000 (0:00:00.828)       0:00:02.157 **********
2026-05-14 17:32:48.324129 | mon1 | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-05-14 17:32:48.324441 | mon1 | with a mode of 0700, this may cause issues when running as another user. To
2026-05-14 17:32:48.324785 | mon1 | avoid this, create the remote_tmp dir with the correct permissions manually
2026-05-14 17:32:48.336495 | mon1 | changed: [mon1]
2026-05-14 17:32:48.336813 | mon1 | changed: [osd1]
2026-05-14 17:32:48.337074 | mon1 |
2026-05-14 17:32:48.337352 | mon1 | TASK [Update apt cache] ********************************************************
2026-05-14 17:32:48.337633 | mon1 | Thursday 14 May 2026  17:32:48 +0000 (0:00:00.331)       0:00:02.489 **********
2026-05-14 17:33:13.472214 | mon1 | changed: [mon1]
2026-05-14 17:33:13.472328 | mon1 | changed: [osd1]
2026-05-14 17:33:13.472343 | mon1 |
2026-05-14 17:33:13.472358 | mon1 | PLAY [Create devices for Ceph] *************************************************
2026-05-14 17:33:13.472370 | mon1 |
2026-05-14 17:33:13.472382 | mon1 | TASK [Gathering Facts] *********************************************************
2026-05-14 17:33:13.472397 | mon1 | Thursday 14 May 2026  17:33:13 +0000 (0:00:25.134)       0:00:27.624 **********
2026-05-14 17:33:14.333314 | mon1 | ok: [osd1]
2026-05-14 17:33:14.333481 | mon1 |
2026-05-14 17:33:14.333785 | mon1 | TASK [Install depedencies] *****************************************************
2026-05-14 17:33:14.334089 | mon1 | Thursday 14 May 2026  17:33:14 +0000 (0:00:00.862)       0:00:28.486 **********
2026-05-14 17:33:36.282977 | mon1 | changed: [osd1]
2026-05-14 17:33:36.283075 | mon1 |
2026-05-14 17:33:36.283328 | mon1 | TASK [Start up service] ********************************************************
2026-05-14 17:33:36.283590 | mon1 | Thursday 14 May 2026  17:33:36 +0000 (0:00:21.942)       0:00:50.428 **********
2026-05-14 17:33:36.951560 | mon1 | ok: [osd1]
2026-05-14 17:33:36.951790 | mon1 |
2026-05-14 17:33:36.952046 | mon1 | TASK [Generate lvm.conf] *******************************************************
2026-05-14 17:33:36.952281 | mon1 | Thursday 14 May 2026  17:33:36 +0000 (0:00:00.676)       0:00:51.104 **********
2026-05-14 17:33:37.334227 | mon1 | ok: [osd1]
2026-05-14 17:33:37.334403 | mon1 |
2026-05-14 17:33:37.334642 | mon1 | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-05-14 17:33:37.334930 | mon1 | Thursday 14 May 2026  17:33:37 +0000 (0:00:00.382)       0:00:51.487 **********
2026-05-14 17:33:38.100940 | mon1 | changed: [osd1]
2026-05-14 17:33:38.101151 | mon1 |
2026-05-14 17:33:38.101379 | mon1 | TASK [Get list of all loopback devices] ****************************************
2026-05-14 17:33:38.101624 | mon1 | Thursday 14 May 2026  17:33:38 +0000 (0:00:00.766)       0:00:52.254 **********
2026-05-14 17:33:38.379185 | mon1 | ok: [osd1]
2026-05-14 17:33:38.379251 | mon1 |
2026-05-14 17:33:38.379484 | mon1 | TASK [Fail if there is any existing loopback devices] **************************
2026-05-14 17:33:38.379626 | mon1 | Thursday 14 May 2026  17:33:38 +0000 (0:00:00.277)       0:00:52.532 **********
2026-05-14 17:33:38.410582 | mon1 | skipping: [osd1]
2026-05-14 17:33:38.410915 | mon1 |
2026-05-14 17:33:38.411018 | mon1 | TASK [Create devices for Ceph] *************************************************
2026-05-14 17:33:38.411201 | mon1 | Thursday 14 May 2026  17:33:38 +0000 (0:00:00.031)       0:00:52.563 **********
2026-05-14 17:33:39.099838 | mon1 | changed: [osd1] => (item=osd0)
2026-05-14 17:33:39.099918 | mon1 | changed: [osd1] => (item=osd1)
2026-05-14 17:33:39.099973 | mon1 | changed: [osd1] => (item=osd2)
2026-05-14 17:33:39.100093 | mon1 |
2026-05-14 17:33:39.100207 | mon1 | TASK [Set permissions on loopback devices] *************************************
2026-05-14 17:33:39.100343 | mon1 | Thursday 14 May 2026  17:33:39 +0000 (0:00:00.689)       0:00:53.252 **********
2026-05-14 17:33:39.877826 | mon1 | changed: [osd1] => (item=osd0)
2026-05-14 17:33:39.878055 | mon1 | changed: [osd1] => (item=osd1)
2026-05-14 17:33:39.878297 | mon1 | changed: [osd1] => (item=osd2)
2026-05-14 17:33:39.878528 | mon1 |
2026-05-14 17:33:39.878804 | mon1 | TASK [Start loop devices] ******************************************************
2026-05-14 17:33:39.879051 | mon1 | Thursday 14 May 2026  17:33:39 +0000 (0:00:00.778)       0:00:54.030 **********
2026-05-14 17:33:40.733794 | mon1 | changed: [osd1] => (item=osd0)
2026-05-14 17:33:40.734022 | mon1 | changed: [osd1] => (item=osd1)
2026-05-14 17:33:40.734264 | mon1 | changed: [osd1] => (item=osd2)
2026-05-14 17:33:40.734486 | mon1 |
2026-05-14 17:33:40.734766 | mon1 | TASK [Create a volume group for each loop device] ******************************
2026-05-14 17:33:40.735167 | mon1 | Thursday 14 May 2026  17:33:40 +0000 (0:00:00.855)       0:00:54.886 **********
2026-05-14 17:33:42.253220 | mon1 | changed: [osd1] => (item=osd0)
2026-05-14 17:33:42.253308 | mon1 | changed: [osd1] => (item=osd1)
2026-05-14 17:33:42.253541 | mon1 | changed: [osd1] => (item=osd2)
2026-05-14 17:33:42.253845 | mon1 |
2026-05-14 17:33:42.254192 | mon1 | TASK [Create a logical volume for each loop device] ****************************
2026-05-14 17:33:42.254521 | mon1 | Thursday 14 May 2026  17:33:42 +0000 (0:00:01.519)       0:00:56.406 **********
2026-05-14 17:33:44.604554 | mon1 | changed: [osd1] => (item=ceph-osd1-osd0)
2026-05-14 17:33:44.604887 | mon1 | changed: [osd1] => (item=ceph-osd1-osd1)
2026-05-14 17:33:44.605063 | mon1 | changed: [osd1] => (item=ceph-osd1-osd2)
2026-05-14 17:33:44.605285 | mon1 |
2026-05-14 17:33:44.605526 | mon1 | PLAY RECAP *********************************************************************
2026-05-14 17:33:44.605819 | mon1 | mon1                       : ok=4    changed=3    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-14 17:33:44.606078 | mon1 | osd1                       : ok=15   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-14 17:33:44.606296 | mon1 |
2026-05-14 17:33:44.606514 | mon1 |
2026-05-14 17:33:44.606850 | mon1 | TASKS RECAP ********************************************************************
2026-05-14 17:33:44.607097 | mon1 | Thursday 14 May 2026  17:33:44 +0000 (0:00:02.351)       0:00:58.758 **********
2026-05-14 17:33:44.607294 | mon1 | ===============================================================================
2026-05-14 17:33:44.607447 | mon1 | Update apt cache ------------------------------------------------------- 25.13s
2026-05-14 17:33:44.607605 | mon1 | Install depedencies ---------------------------------------------------- 21.94s
2026-05-14 17:33:44.607792 | mon1 | Create a logical volume for each loop device ---------------------------- 2.35s
2026-05-14 17:33:44.607953 | mon1 | Create a volume group for each loop device ------------------------------ 1.52s
2026-05-14 17:33:44.608109 | mon1 | Gathering Facts --------------------------------------------------------- 1.30s
2026-05-14 17:33:44.608267 | mon1 | Gathering Facts --------------------------------------------------------- 0.86s
2026-05-14 17:33:44.608427 | mon1 | Start loop devices ------------------------------------------------------ 0.86s
2026-05-14 17:33:44.608584 | mon1 | Configure short hostname ------------------------------------------------ 0.83s
2026-05-14 17:33:44.608766 | mon1 | Set permissions on loopback devices ------------------------------------- 0.78s
2026-05-14 17:33:44.608923 | mon1 | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.77s
2026-05-14 17:33:44.609081 | mon1 | Create devices for Ceph ------------------------------------------------- 0.69s
2026-05-14 17:33:44.609236 | mon1 | Start up service -------------------------------------------------------- 0.68s
2026-05-14 17:33:44.609393 | mon1 | Generate lvm.conf ------------------------------------------------------- 0.38s
2026-05-14 17:33:44.609550 | mon1 | Ensure hostname inside hosts file --------------------------------------- 0.33s
2026-05-14 17:33:44.609735 | mon1 | Get list of all loopback devices ---------------------------------------- 0.28s
2026-05-14 17:33:44.609888 | mon1 | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-05-14 17:33:44.685947 | mon1 | INFO     [default > prepare] Executed: Successful
2026-05-14 17:33:44.699464 | mon1 | INFO     [default > converge] Executing
2026-05-14 17:33:45.651067 | mon1 |
2026-05-14 17:33:45.651275 | mon1 | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-05-14 17:33:45.651491 | mon1 |
2026-05-14 17:33:45.651761 | mon1 | TASK [Gathering Facts] *********************************************************
2026-05-14 17:33:45.652039 | mon1 | Thursday 14 May 2026  17:33:45 +0000 (0:00:00.052)       0:00:00.052 **********
2026-05-14 17:33:46.737834 | mon1 | [WARNING]: Platform linux on host mon1 is using the discovered Python
2026-05-14 17:33:46.737898 | mon1 | interpreter at /usr/bin/python3.12, but future installation of another Python
2026-05-14 17:33:46.737933 | mon1 | interpreter could change the meaning of that path. See
2026-05-14 17:33:46.737948 | mon1 | https://docs.ansible.com/ansible-
2026-05-14 17:33:46.738173 | mon1 | core/2.18/reference_appendices/interpreter_discovery.html for more information.
2026-05-14 17:33:46.751830 | mon1 | ok: [mon1]
2026-05-14 17:33:46.751889 | mon1 |
2026-05-14 17:33:46.751900 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-14 17:33:46.751999 | mon1 | Thursday 14 May 2026  17:33:46 +0000 (0:00:01.099)       0:00:01.151 **********
2026-05-14 17:33:47.103268 | mon1 | ok: [mon1]
2026-05-14 17:33:47.103324 | mon1 |
2026-05-14 17:33:47.103335 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-14 17:33:47.103344 | mon1 | Thursday 14 May 2026  17:33:47 +0000 (0:00:00.351)       0:00:01.503 **********
2026-05-14 17:33:47.149238 | mon1 | skipping: [mon1]
2026-05-14 17:33:47.149286 | mon1 |
2026-05-14 17:33:47.149297 | mon1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-14 17:33:47.149308 | mon1 | Thursday 14 May 2026  17:33:47 +0000 (0:00:00.045)       0:00:01.548 **********
2026-05-14 17:33:47.507780 | mon1 | changed: [mon1]
2026-05-14 17:33:47.507837 | mon1 |
2026-05-14 17:33:47.508304 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-14 17:33:47.508340 | mon1 | Thursday 14 May 2026  17:33:47 +0000 (0:00:00.359)       0:00:01.908 **********
2026-05-14 17:33:47.615981 | mon1 | ok: [mon1] => {
2026-05-14 17:33:47.616067 | mon1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-05-14 17:33:47.616183 | mon1 | }
2026-05-14 17:33:47.616281 | mon1 |
2026-05-14 17:33:47.616574 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-14 17:33:47.616600 | mon1 | Thursday 14 May 2026  17:33:47 +0000 (0:00:00.108)       0:00:02.016 **********
2026-05-14 17:33:48.483345 | mon1 | changed: [mon1]
2026-05-14 17:33:48.483424 | mon1 |
2026-05-14 17:33:48.483436 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-14 17:33:48.483583 | mon1 | Thursday 14 May 2026  17:33:48 +0000 (0:00:00.867)       0:00:02.884 **********
2026-05-14 17:33:48.534287 | mon1 | skipping: [mon1]
2026-05-14 17:33:48.534378 | mon1 |
2026-05-14 17:33:48.534389 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-14 17:33:48.534399 | mon1 | Thursday 14 May 2026  17:33:48 +0000 (0:00:00.050)       0:00:02.934 **********
2026-05-14 17:33:48.583606 | mon1 | skipping: [mon1]
2026-05-14 17:33:48.583663 | mon1 |
2026-05-14 17:33:48.583709 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-14 17:33:48.583725 | mon1 | Thursday 14 May 2026  17:33:48 +0000 (0:00:00.049)       0:00:02.983 **********
2026-05-14 17:33:48.845801 | mon1 | ok: [mon1]
2026-05-14 17:33:48.845986 | mon1 |
2026-05-14 17:33:48.846349 | mon1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-14 17:33:48.846862 | mon1 | Thursday 14 May 2026  17:33:48 +0000 (0:00:00.262)       0:00:03.246 **********
2026-05-14 17:33:49.960832 | mon1 | ok: [mon1]
2026-05-14 17:33:49.960944 | mon1 |
2026-05-14 17:33:49.961108 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-14 17:33:49.961266 | mon1 | Thursday 14 May 2026  17:33:49 +0000 (0:00:01.115)       0:00:04.362 **********
2026-05-14 17:33:50.176292 | mon1 | ok: [mon1] => {
2026-05-14 17:33:50.176534 | mon1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz"
2026-05-14 17:33:50.176864 | mon1 | }
2026-05-14 17:33:50.177121 | mon1 |
2026-05-14 17:33:50.177384 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-14 17:33:50.177640 | mon1 | Thursday 14 May 2026  17:33:50 +0000 (0:00:00.214)       0:00:04.576 **********
2026-05-14 17:33:51.181794 | mon1 | changed: [mon1]
2026-05-14 17:33:51.181853 | mon1 |
2026-05-14 17:33:51.181864 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-14 17:33:51.182141 | mon1 | Thursday 14 May 2026  17:33:51 +0000 (0:00:01.005)       0:00:05.582 **********
2026-05-14 17:33:54.448130 | mon1 | changed: [mon1]
2026-05-14 17:33:54.448187 | mon1 |
2026-05-14 17:33:54.448201 | mon1 | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-05-14 17:33:54.448214 | mon1 | Thursday 14 May 2026  17:33:54 +0000 (0:00:03.265)       0:00:08.848 **********
2026-05-14 17:33:54.485208 | mon1 | skipping: [mon1]
2026-05-14 17:33:54.485257 | mon1 |
2026-05-14 17:33:54.485269 | mon1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-05-14 17:33:54.485279 | mon1 | Thursday 14 May 2026  17:33:54 +0000 (0:00:00.036)       0:00:08.884 **********
2026-05-14 17:33:54.520649 | mon1 | skipping: [mon1]
2026-05-14 17:33:54.520706 | mon1 |
2026-05-14 17:33:54.520716 | mon1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-05-14 17:33:54.520724 | mon1 | Thursday 14 May 2026  17:33:54 +0000 (0:00:00.036)       0:00:08.920 **********
2026-05-14 17:33:54.556297 | mon1 | skipping: [mon1]
2026-05-14 17:33:54.556357 | mon1 |
2026-05-14 17:33:54.556371 | mon1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-05-14 17:33:54.556384 | mon1 | Thursday 14 May 2026  17:33:54 +0000 (0:00:00.035)       0:00:08.956 **********
2026-05-14 17:34:06.347852 | mon1 | changed: [mon1]
2026-05-14 17:34:06.347917 | mon1 |
2026-05-14 17:34:06.348361 | mon1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-05-14 17:34:06.348421 | mon1 | Thursday 14 May 2026  17:34:06 +0000 (0:00:11.791)       0:00:20.748 **********
2026-05-14 17:34:07.028926 | mon1 | changed: [mon1]
2026-05-14 17:34:07.029031 | mon1 |
2026-05-14 17:34:07.029056 | mon1 | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-05-14 17:34:07.029337 | mon1 | Thursday 14 May 2026  17:34:07 +0000 (0:00:00.681)       0:00:21.429 **********
2026-05-14 17:34:08.173446 | mon1 | changed: [mon1] => (item={'path': '/etc/containerd'})
2026-05-14 17:34:08.173549 | mon1 | changed: [mon1] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-05-14 17:34:08.173564 | mon1 | changed: [mon1] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-05-14 17:34:08.173576 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-05-14 17:34:08.173588 | mon1 | changed: [mon1] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-05-14 17:34:08.173600 | mon1 |
2026-05-14 17:34:08.173613 | mon1 | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-05-14 17:34:08.173624 | mon1 | Thursday 14 May 2026  17:34:08 +0000 (0:00:01.142)       0:00:22.571 **********
2026-05-14 17:34:08.932770 | mon1 | changed: [mon1]
2026-05-14 17:34:08.932845 | mon1 |
2026-05-14 17:34:08.932859 | mon1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-05-14 17:34:08.932910 | mon1 | Thursday 14 May 2026  17:34:08 +0000 (0:00:00.755)       0:00:23.326 **********
2026-05-14 17:34:08.933412 | mon1 |
2026-05-14 17:34:08.933435 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-05-14 17:34:08.933444 | mon1 | Thursday 14 May 2026  17:34:08 +0000 (0:00:00.007)       0:00:23.333 **********
2026-05-14 17:34:10.088856 | mon1 | ok: [mon1]
2026-05-14 17:34:10.088919 | mon1 |
2026-05-14 17:34:10.089381 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-05-14 17:34:10.089415 | mon1 | Thursday 14 May 2026  17:34:10 +0000 (0:00:01.155)       0:00:24.488 **********
2026-05-14 17:34:10.645444 | mon1 | changed: [mon1]
2026-05-14 17:34:10.645535 | mon1 |
2026-05-14 17:34:10.645546 | mon1 | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-05-14 17:34:10.645556 | mon1 | Thursday 14 May 2026  17:34:10 +0000 (0:00:00.556)       0:00:25.045 **********
2026-05-14 17:34:11.365763 | mon1 | changed: [mon1]
2026-05-14 17:34:11.365813 | mon1 |
2026-05-14 17:34:11.366106 | mon1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-14 17:34:11.366422 | mon1 | Thursday 14 May 2026  17:34:11 +0000 (0:00:00.721)       0:00:25.766 **********
2026-05-14 17:34:11.618348 | mon1 | ok: [mon1]
2026-05-14 17:34:11.618729 | mon1 |
2026-05-14 17:34:11.619334 | mon1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-14 17:34:11.619357 | mon1 | Thursday 14 May 2026  17:34:11 +0000 (0:00:00.253)       0:00:26.019 **********
2026-05-14 17:34:11.701846 | mon1 | ok: [mon1] => {
2026-05-14 17:34:11.701923 | mon1 |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-05-14 17:34:11.701938 | mon1 | }
2026-05-14 17:34:11.701957 | mon1 |
2026-05-14 17:34:11.702170 | mon1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-14 17:34:11.702408 | mon1 | Thursday 14 May 2026  17:34:11 +0000 (0:00:00.083)       0:00:26.102 **********
2026-05-14 17:34:12.646784 | mon1 | changed: [mon1]
2026-05-14 17:34:12.646983 | mon1 |
2026-05-14 17:34:12.647248 | mon1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-14 17:34:12.647497 | mon1 | Thursday 14 May 2026  17:34:12 +0000 (0:00:00.945)       0:00:27.048 **********
2026-05-14 17:34:17.281596 | mon1 | changed: [mon1]
2026-05-14 17:34:17.281652 | mon1 |
2026-05-14 17:34:17.281666 | mon1 | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-05-14 17:34:17.281712 | mon1 | Thursday 14 May 2026  17:34:17 +0000 (0:00:04.633)       0:00:31.681 **********
2026-05-14 17:34:18.289900 | mon1 | ok: [mon1]
2026-05-14 17:34:18.289937 | mon1 |
2026-05-14 17:34:18.289946 | mon1 | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-05-14 17:34:18.289954 | mon1 | Thursday 14 May 2026  17:34:18 +0000 (0:00:01.007)       0:00:32.689 **********
2026-05-14 17:34:18.687243 | mon1 | changed: [mon1]
2026-05-14 17:34:18.687296 | mon1 |
2026-05-14 17:34:18.687310 | mon1 | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-05-14 17:34:18.687322 | mon1 | Thursday 14 May 2026  17:34:18 +0000 (0:00:00.397)       0:00:33.087 **********
2026-05-14 17:34:19.251804 | mon1 | changed: [mon1]
2026-05-14 17:34:19.251854 | mon1 |
2026-05-14 17:34:19.251863 | mon1 | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-05-14 17:34:19.251871 | mon1 | Thursday 14 May 2026  17:34:19 +0000 (0:00:00.565)       0:00:33.652 **********
2026-05-14 17:34:19.954739 | mon1 | changed: [mon1] => (item={'path': '/etc/docker'})
2026-05-14 17:34:19.954776 | mon1 | changed: [mon1] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-05-14 17:34:19.954783 | mon1 | changed: [mon1] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-05-14 17:34:19.954788 | mon1 |
2026-05-14 17:34:19.954794 | mon1 | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-05-14 17:34:19.954802 | mon1 | Thursday 14 May 2026  17:34:19 +0000 (0:00:00.701)       0:00:34.353 **********
2026-05-14 17:34:20.502616 | mon1 | changed: [mon1]
2026-05-14 17:34:20.503506 | mon1 |
2026-05-14 17:34:20.503555 | mon1 | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-05-14 17:34:20.503569 | mon1 | Thursday 14 May 2026  17:34:20 +0000 (0:00:00.550)       0:00:34.903 **********
2026-05-14 17:34:21.070943 | mon1 | changed: [mon1]
2026-05-14 17:34:21.071001 | mon1 |
2026-05-14 17:34:21.071015 | mon1 | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-05-14 17:34:21.071029 | mon1 | Thursday 14 May 2026  17:34:21 +0000 (0:00:00.559)       0:00:35.463 **********
2026-05-14 17:34:21.071046 | mon1 |
2026-05-14 17:34:21.071388 | mon1 | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-05-14 17:34:21.071595 | mon1 | Thursday 14 May 2026  17:34:21 +0000 (0:00:00.008)       0:00:35.471 **********
2026-05-14 17:34:21.927183 | mon1 | ok: [mon1]
2026-05-14 17:34:21.927334 | mon1 |
2026-05-14 17:34:21.927615 | mon1 | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-05-14 17:34:21.927946 | mon1 | Thursday 14 May 2026  17:34:21 +0000 (0:00:00.856)       0:00:36.328 **********
2026-05-14 17:34:22.873867 | mon1 | changed: [mon1]
2026-05-14 17:34:22.873950 | mon1 |
2026-05-14 17:34:22.873965 | mon1 | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-05-14 17:34:22.873979 | mon1 | Thursday 14 May 2026  17:34:22 +0000 (0:00:00.946)       0:00:37.274 **********
2026-05-14 17:34:23.560135 | mon1 | changed: [mon1]
2026-05-14 17:34:23.560201 | mon1 |
2026-05-14 17:34:23.560296 | mon1 | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-05-14 17:34:23.560412 | mon1 | Thursday 14 May 2026  17:34:23 +0000 (0:00:00.686)       0:00:37.960 **********
2026-05-14 17:34:23.620483 | mon1 | ok: [mon1] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/debian.yml)
2026-05-14 17:34:23.620602 | mon1 |
2026-05-14 17:34:23.620814 | mon1 | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-05-14 17:34:23.620969 | mon1 | Thursday 14 May 2026  17:34:23 +0000 (0:00:00.061)       0:00:38.021 **********
2026-05-14 17:34:42.176975 | mon1 | changed: [mon1]
2026-05-14 17:34:42.177100 | mon1 |
2026-05-14 17:34:42.177367 | mon1 | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-05-14 17:34:42.177612 | mon1 | Thursday 14 May 2026  17:34:42 +0000 (0:00:18.556)       0:00:56.577 **********
2026-05-14 17:34:42.999801 | mon1 | ok: [mon1] => (item=systemd-timesyncd)
2026-05-14 17:34:42.999859 | mon1 | ok: [mon1] => (item=ssh)
2026-05-14 17:34:42.999873 | mon1 |
2026-05-14 17:34:42.999886 | mon1 | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-05-14 17:34:42.999898 | mon1 | Thursday 14 May 2026  17:34:42 +0000 (0:00:00.822)       0:00:57.400 **********
2026-05-14 17:34:43.503144 | mon1 | fatal: [mon1]: FAILED! => {"changed": false, "dest": "/usr/bin/cephadm", "elapsed": 0, "msg": "Request failed", "response": "HTTP Error 404: Not Found", "status_code": 404, "url": "https://download.ceph.com/rpm-21.0.0/el9/noarch/cephadm"}
2026-05-14 17:34:43.505171 | mon1 |
2026-05-14 17:34:43.505329 | mon1 | PLAY RECAP *********************************************************************
2026-05-14 17:34:43.505503 | mon1 | mon1                       : ok=33   changed=20   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-05-14 17:34:43.507120 | mon1 |
2026-05-14 17:34:43.507163 | mon1 |
2026-05-14 17:34:43.507177 | mon1 | TASKS RECAP ********************************************************************
2026-05-14 17:34:43.507206 | mon1 | Thursday 14 May 2026  17:34:43 +0000 (0:00:00.506)       0:00:57.907 **********
2026-05-14 17:34:43.507220 | mon1 | ===============================================================================
2026-05-14 17:34:43.507232 | mon1 | vexxhost.ceph.cephadm : Install packages ------------------------------- 18.56s
2026-05-14 17:34:43.507244 | mon1 | vexxhost.containers.containerd : Install AppArmor packages ------------- 11.79s
2026-05-14 17:34:43.507257 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 4.63s
2026-05-14 17:34:43.507269 | mon1 | vexxhost.containers.download_artifact : Extract archive ----------------- 3.27s
2026-05-14 17:34:43.507281 | mon1 | vexxhost.containers.containerd : Reload systemd ------------------------- 2.01s
2026-05-14 17:34:43.507299 | mon1 | vexxhost.containers.containerd : Create folders for configuration ------- 1.14s
2026-05-14 17:34:43.507312 | mon1 | vexxhost.containers.package : Update state for tar ---------------------- 1.12s
2026-05-14 17:34:43.507450 | mon1 | Gathering Facts --------------------------------------------------------- 1.10s
2026-05-14 17:34:43.507595 | mon1 | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.01s
2026-05-14 17:34:43.507780 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 1.01s
2026-05-14 17:34:43.507925 | mon1 | vexxhost.containers.docker : Restart docker ----------------------------- 0.95s
2026-05-14 17:34:43.508108 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.95s
2026-05-14 17:34:43.508261 | mon1 | vexxhost.containers.download_artifact : Download item ------------------- 0.87s
2026-05-14 17:34:43.508410 | mon1 | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.82s
2026-05-14 17:34:43.508569 | mon1 | vexxhost.containers.containerd : Create containerd config file ---------- 0.76s
2026-05-14 17:34:43.508743 | mon1 | vexxhost.containers.containerd : Enable and start service --------------- 0.72s
2026-05-14 17:34:43.508898 | mon1 | vexxhost.containers.docker : Create folders for configuration ----------- 0.70s
2026-05-14 17:34:43.509049 | mon1 | vexxhost.containers.docker : Enable and start service ------------------- 0.69s
2026-05-14 17:34:43.509208 | mon1 | vexxhost.containers.containerd : Create systemd service file for containerd --- 0.68s
2026-05-14 17:34:43.509359 | mon1 | vexxhost.containers.docker : Create systemd service file for docker ----- 0.57s
2026-05-14 17:34:43.590892 | 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-05-14 17:34:43.590963 | mon1 | ERROR    [default > converge] Executed: Failed
2026-05-14 17:34:43.591128 | 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-05-14 17:34:53.976004 | mon1 | ERROR
2026-05-14 17:34:53.976201 | mon1 | {
2026-05-14 17:34:53.976231 | mon1 |   "delta": "0:02:15.453193",
2026-05-14 17:34:53.976252 | mon1 |   "end": "2026-05-14 17:34:43.661792",
2026-05-14 17:34:53.976271 | mon1 |   "msg": "non-zero return code",
2026-05-14 17:34:53.976289 | mon1 |   "rc": 2,
2026-05-14 17:34:53.976309 | mon1 |   "start": "2026-05-14 17:32:28.208599"
2026-05-14 17:34:53.976327 | mon1 | }
failure
2026-05-14 17:34:53.980565 | 
2026-05-14 17:34:53.980613 | PLAY RECAP
2026-05-14 17:34:53.980655 | mon1 | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-05-14 17:34:53.980676 | 
2026-05-14 17:34:54.154063 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-14 17:34:54.160422 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-14 17:34:54.793005 | 
2026-05-14 17:34:54.793249 | PLAY [all]
2026-05-14 17:34:54.805598 | 
2026-05-14 17:34:54.805677 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-14 17:34:54.861240 | mon1 | ok
2026-05-14 17:34:54.869516 | osd1 | ok
2026-05-14 17:34:54.875896 | 
2026-05-14 17:34:54.875995 | TASK [fetch-output : Set log path for single node]
2026-05-14 17:34:54.901974 | mon1 | skipping: Conditional result was False
2026-05-14 17:34:54.913298 | osd1 | skipping: Conditional result was False
2026-05-14 17:34:54.924874 | 
2026-05-14 17:34:54.934559 | LOOP [fetch-output : Ensure local output dirs]
2026-05-14 17:34:55.312991 | mon1 -> localhost | changed: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/logs/mon1"
2026-05-14 17:34:55.316781 | osd1 -> localhost | changed: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/logs/osd1"
2026-05-14 17:34:55.514284 | mon1 -> localhost | changed: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/artifacts"
2026-05-14 17:34:55.570806 | osd1 -> localhost | ok: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/artifacts"
2026-05-14 17:34:55.722476 | mon1 -> localhost | changed: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/docs"
2026-05-14 17:34:55.784238 | osd1 -> localhost | ok: "/var/lib/zuul/builds/96ac126e401447e8a0494605e69fc080/work/docs"
2026-05-14 17:34:55.784407 | osd1 -> localhost | changed: All items complete
2026-05-14 17:34:55.784455 | 
2026-05-14 17:34:55.807632 | 
2026-05-14 17:34:55.807776 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-14 17:34:56.464607 | osd1 | changed: .d..t...... ./
2026-05-14 17:34:56.500648 | mon1 | changed: .d..t...... ./
2026-05-14 17:34:56.967952 | osd1 | changed: .d..t...... ./
2026-05-14 17:34:56.987864 | mon1 | changed: .d..t...... ./
2026-05-14 17:34:57.439166 | osd1 | changed: .d..t...... ./
2026-05-14 17:34:57.465354 | mon1 | ok
2026-05-14 17:34:57.465488 | mon1 | changed: All items complete
2026-05-14 17:34:57.465551 | 
2026-05-14 17:34:57.488842 | 
2026-05-14 17:34:57.489003 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-14 17:34:57.924691 | mon1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008557
2026-05-14 17:34:58.154187 | mon1 -> localhost | ok: Item: docs Runtime: 0:00:00.008953
2026-05-14 17:34:58.179826 | 
2026-05-14 17:34:58.179956 | PLAY [all]
2026-05-14 17:34:58.186527 | 
2026-05-14 17:34:58.186591 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-14 17:34:58.668545 | mon1 | changed
2026-05-14 17:34:58.845236 | osd1 | changed
2026-05-14 17:34:58.855309 | 
2026-05-14 17:34:58.855360 | PLAY RECAP
2026-05-14 17:34:58.855403 | mon1 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-14 17:34:58.855432 | osd1 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-14 17:34:58.855452 | 
2026-05-14 17:34:58.988106 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-14 17:34:58.991727 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-14 17:34:59.624370 | 
2026-05-14 17:34:59.624679 | PLAY [localhost]
2026-05-14 17:34:59.634934 | 
2026-05-14 17:34:59.635008 | TASK [Generate Zuul manifest]
2026-05-14 17:34:59.656488 | localhost | ok
2026-05-14 17:34:59.672439 | 
2026-05-14 17:34:59.672554 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-14 17:35:00.049059 | localhost | changed
2026-05-14 17:35:00.062832 | 
2026-05-14 17:35:00.062914 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-14 17:35:00.093506 | localhost | ok
2026-05-14 17:35:00.102758 | 
2026-05-14 17:35:00.102852 | TASK [Upload logs]
2026-05-14 17:35:00.124221 | localhost | ok
2026-05-14 17:35:00.183309 | 
2026-05-14 17:35:00.183437 | TASK [Set zuul-log-path fact]
2026-05-14 17:35:00.203731 | localhost | ok
2026-05-14 17:35:00.218270 | 
2026-05-14 17:35:00.218337 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-14 17:35:00.249892 | localhost | ok
2026-05-14 17:35:00.260031 | 
2026-05-14 17:35:00.260173 | TASK [upload-logs : Create log directories]
2026-05-14 17:35:00.667543 | localhost | changed
2026-05-14 17:35:00.674049 | 
2026-05-14 17:35:00.674138 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-14 17:35:01.071706 | localhost -> localhost | ok: Runtime: 0:00:00.005740
2026-05-14 17:35:01.079356 | 
2026-05-14 17:35:01.079498 | TASK [upload-logs : Upload logs to log server]
2026-05-14 17:35:01.533213 | localhost | Output suppressed because no_log was given
2026-05-14 17:35:01.537010 | 
2026-05-14 17:35:01.537078 | LOOP [upload-logs : Compress console log and json output]
2026-05-14 17:35:01.644990 | localhost | skipping: Conditional result was False
2026-05-14 17:35:01.653159 | localhost | skipping: Conditional result was False
2026-05-14 17:35:01.664147 | 
2026-05-14 17:35:01.664299 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-14 17:35:01.742248 | localhost | skipping: Conditional result was False
2026-05-14 17:35:01.742565 | 
2026-05-14 17:35:01.746416 | localhost | skipping: Conditional result was False
2026-05-14 17:35:01.793598 | 
2026-05-14 17:35:01.793766 | LOOP [upload-logs : Upload console log and json output]