2026-09-11 17:19:09.106484 | Job console starting
2026-09-11 17:19:09.119710 | Updating git repos
2026-09-11 17:19:15.107827 | Cloning repos into workspace
2026-09-11 17:19:33.769497 | Restoring repo states
2026-09-11 17:19:47.693887 | Merging changes
2026-09-11 17:19:49.170434 | Checking out repos
2026-09-11 17:19:50.916388 | Preparing playbooks
2026-09-11 17:19:53.263893 | Running Ansible setup
2026-09-11 17:19:57.166891 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:19:57.753144 | 
2026-09-11 17:19:57.753256 | PLAY [localhost]
2026-09-11 17:19:57.759874 | 
2026-09-11 17:19:57.759939 | TASK [Gathering Facts]
2026-09-11 17:19:58.699074 | localhost | ok
2026-09-11 17:19:58.710744 | 
2026-09-11 17:19:58.710931 | TASK [Setup log path fact]
2026-09-11 17:19:58.729550 | localhost | ok
2026-09-11 17:19:58.742401 | 
2026-09-11 17:19:58.742494 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:19:58.771808 | localhost | ok
2026-09-11 17:19:58.778793 | 
2026-09-11 17:19:58.778879 | TASK [emit-job-header : Print job information]
2026-09-11 17:19:58.818243 | # Job Information
2026-09-11 17:19:58.818444 | Ansible Version: 2.16.18
2026-09-11 17:19:58.818507 | Job: atmosphere-molecule-csi-rbd
2026-09-11 17:19:58.818549 | Pipeline: check
2026-09-11 17:19:58.818588 | Executor: 2d72f0692154
2026-09-11 17:19:58.818626 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4091
2026-09-11 17:19:58.818671 | Event ID: 63a18cf0-ae04-11f1-832b-0db9b421a0bf
2026-09-11 17:19:58.823794 | 
2026-09-11 17:19:58.823913 | LOOP [emit-job-header : Print node information]
2026-09-11 17:19:59.044302 | localhost | ok:
2026-09-11 17:19:59.044659 | localhost | # Node Information
2026-09-11 17:19:59.044717 | localhost | Inventory Hostname: instance
2026-09-11 17:19:59.044783 | localhost | Hostname: np0000192602
2026-09-11 17:19:59.044831 | localhost | Username: zuul
2026-09-11 17:19:59.044874 | localhost | Distro: Ubuntu 22.04
2026-09-11 17:19:59.044917 | localhost | Provider: yul1
2026-09-11 17:19:59.044950 | localhost | Region: ca-ymq-1
2026-09-11 17:19:59.044980 | localhost | Label: ubuntu-jammy
2026-09-11 17:19:59.045010 | localhost | Product Name: OpenStack Nova
2026-09-11 17:19:59.045041 | localhost | Interface IP: 162.253.55.144
2026-09-11 17:19:59.058264 | 
2026-09-11 17:19:59.058478 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-11 17:19:59.457614 | localhost -> localhost | changed
2026-09-11 17:19:59.461621 | 
2026-09-11 17:19:59.461681 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-11 17:20:00.385015 | localhost -> localhost | changed
2026-09-11 17:20:00.390161 | 
2026-09-11 17:20:00.390211 | PLAY [all]
2026-09-11 17:20:00.397075 | 
2026-09-11 17:20:00.397133 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-11 17:20:00.633880 | instance -> localhost | ok
2026-09-11 17:20:00.639588 | 
2026-09-11 17:20:00.639658 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-11 17:20:00.667635 | instance | ok
2026-09-11 17:20:00.701809 | instance | included: /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-11 17:20:00.707566 | 
2026-09-11 17:20:00.707622 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-11 17:20:01.594247 | instance -> localhost | Generating public/private rsa key pair.
2026-09-11 17:20:01.594404 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/99449bf673624a46aa74b44b612488ee_id_rsa
2026-09-11 17:20:01.594431 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/99449bf673624a46aa74b44b612488ee_id_rsa.pub
2026-09-11 17:20:01.594452 | instance -> localhost | The key fingerprint is:
2026-09-11 17:20:01.594471 | instance -> localhost | SHA256:/PX0QEbesR7vHS0U1jHXnDV+sBR+jTMgkpE7nNBqXoM zuul-build-sshkey
2026-09-11 17:20:01.594502 | instance -> localhost | The key's randomart image is:
2026-09-11 17:20:01.594521 | instance -> localhost | +---[RSA 3072]----+
2026-09-11 17:20:01.594544 | instance -> localhost | |       .o+. . BOB|
2026-09-11 17:20:01.594563 | instance -> localhost | |      . +. . B.B@|
2026-09-11 17:20:01.594581 | instance -> localhost | |       = o    @+=|
2026-09-11 17:20:01.594599 | instance -> localhost | |      E.B    +.+=|
2026-09-11 17:20:01.594617 | instance -> localhost | |     o .So  . +oo|
2026-09-11 17:20:01.594640 | instance -> localhost | |      .  . . o =o|
2026-09-11 17:20:01.594666 | instance -> localhost | |          .   . +|
2026-09-11 17:20:01.594689 | instance -> localhost | |                 |
2026-09-11 17:20:01.594709 | instance -> localhost | |                 |
2026-09-11 17:20:01.594727 | instance -> localhost | +----[SHA256]-----+
2026-09-11 17:20:01.594783 | instance -> localhost | ok: Runtime: 0:00:00.513861
2026-09-11 17:20:01.600197 | 
2026-09-11 17:20:01.600269 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-11 17:20:01.627147 | instance | ok
2026-09-11 17:20:01.634727 | instance | included: /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-11 17:20:01.640811 | 
2026-09-11 17:20:01.640865 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-11 17:20:01.664162 | instance | skipping: Conditional result was False
2026-09-11 17:20:01.669278 | 
2026-09-11 17:20:01.669338 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-11 17:20:02.153792 | instance | changed
2026-09-11 17:20:02.164480 | 
2026-09-11 17:20:02.164633 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-11 17:20:02.382117 | instance | ok
2026-09-11 17:20:02.391500 | 
2026-09-11 17:20:02.391620 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-11 17:20:02.893629 | instance | changed
2026-09-11 17:20:02.900085 | 
2026-09-11 17:20:02.900162 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-11 17:20:03.412326 | instance | changed
2026-09-11 17:20:03.423632 | 
2026-09-11 17:20:03.423740 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-11 17:20:03.447745 | instance | skipping: Conditional result was False
2026-09-11 17:20:03.455122 | 
2026-09-11 17:20:03.455218 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-11 17:20:03.827577 | instance -> localhost | changed
2026-09-11 17:20:03.840104 | 
2026-09-11 17:20:03.840196 | TASK [add-build-sshkey : Add back temp key]
2026-09-11 17:20:04.095734 | instance -> localhost | Identity added: /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/99449bf673624a46aa74b44b612488ee_id_rsa (zuul-build-sshkey)
2026-09-11 17:20:04.096023 | instance -> localhost | ok: Runtime: 0:00:00.015352
2026-09-11 17:20:04.101995 | 
2026-09-11 17:20:04.102071 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-11 17:20:04.416482 | instance | ok
2026-09-11 17:20:04.422539 | 
2026-09-11 17:20:04.422647 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-11 17:20:04.456953 | instance | skipping: Conditional result was False
2026-09-11 17:20:04.469182 | 
2026-09-11 17:20:04.469318 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-11 17:20:04.810977 | instance | ok
2026-09-11 17:20:04.815922 | 
2026-09-11 17:20:04.815981 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-11 17:20:08.767563 | instance | Output suppressed because no_log was given
2026-09-11 17:20:08.784660 | 
2026-09-11 17:20:08.784744 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-11 17:20:08.993420 | instance | ok: "logs"
2026-09-11 17:20:08.993945 | instance | ok: All items complete
2026-09-11 17:20:08.994011 | 
2026-09-11 17:20:09.171310 | instance | ok: "artifacts"
2026-09-11 17:20:09.361475 | instance | ok: "docs"
2026-09-11 17:20:09.374851 | 
2026-09-11 17:20:09.375072 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-11 17:20:09.602684 | instance | changed: "logs"
2026-09-11 17:20:09.766471 | instance | changed: "artifacts"
2026-09-11 17:20:09.956835 | instance | changed: "docs"
2026-09-11 17:20:09.989622 | 
2026-09-11 17:20:09.989819 | PLAY RECAP
2026-09-11 17:20:09.989938 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-11 17:20:09.990000 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:20:09.990044 | 
2026-09-11 17:20:10.156242 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:20:10.160811 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:20:10.808520 | 
2026-09-11 17:20:10.809154 | PLAY [all]
2026-09-11 17:20:10.823160 | 
2026-09-11 17:20:10.823384 | TASK [setup-uv : Extract archive]
2026-09-11 17:20:13.024839 | instance | changed
2026-09-11 17:20:13.030534 | 
2026-09-11 17:20:13.030607 | TASK [setup-uv : Print version]
2026-09-11 17:20:13.412990 | instance | uv 0.8.13
2026-09-11 17:20:13.567670 | instance | ok: Runtime: 0:00:00.011206
2026-09-11 17:20:13.585661 | 
2026-09-11 17:20:13.585912 | TASK [Install Ansible collection siblings]
2026-09-11 17:20:23.348696 | instance | changed:
2026-09-11 17:20:23.348940 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-11 17:20:23.348998 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-11 17:20:23.349041 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-11 17:20:23.349080 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-11 17:20:23.349118 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-11 17:20:23.349164 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-11 17:20:23.349205 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-11 17:20:23.349247 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-11 17:20:23.349288 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-11 17:20:23.349326 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-11 17:20:23.349362 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-11 17:20:23.349398 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-11 17:20:23.349432 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-11 17:20:23.349468 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-11 17:20:23.349502 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-11 17:20:23.349538 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-11 17:20:23.349573 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-11 17:20:23.349608 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-11 17:20:23.349642 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-11 17:20:23.349675 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-11 17:20:23.349709 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-11 17:20:23.349743 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-11 17:20:23.349804 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:20:23.349855 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-11 17:20:23.349891 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-11 17:20:23.349926 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:20:23.349961 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:20:23.349995 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:20:23.350029 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-11 17:20:23.350062 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-11 17:20:23.350096 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:20:23.350131 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:20:23.350166 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-11 17:20:23.350201 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-11 17:20:23.350246 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.350283 | instance | Process install dependency map
2026-09-11 17:20:23.350318 | instance | Starting collection install process
2026-09-11 17:20:23.350352 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-11 17:20:23.350386 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-11 17:20:23.350419 | instance | ansible.netcommon:* was installed successfully
2026-09-11 17:20:23.350453 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-11 17:20:23.350487 | instance | Creating virtual environment at: .venv
2026-09-11 17:20:23.350521 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:20:23.350555 | instance | Downloading cryptography (4.2MiB)
2026-09-11 17:20:23.350589 | instance | Downloading kubernetes (1.9MiB)
2026-09-11 17:20:23.350746 | instance | Downloading ansible-core (2.1MiB)
2026-09-11 17:20:23.350827 | instance | Downloading rjsonnet (1.2MiB)
2026-09-11 17:20:23.350869 | instance | Downloading netaddr (2.2MiB)
2026-09-11 17:20:23.350907 | instance | Downloading openstacksdk (1.7MiB)
2026-09-11 17:20:23.350943 | instance | Downloading pygments (1.2MiB)
2026-09-11 17:20:23.350978 | instance | Downloading setuptools (1.1MiB)
2026-09-11 17:20:23.351013 | instance |  Downloading rjsonnet
2026-09-11 17:20:23.351048 | instance |    Building pyperclip==1.9.0
2026-09-11 17:20:23.351086 | instance |  Downloading netaddr
2026-09-11 17:20:23.351122 | instance |  Downloading pygments
2026-09-11 17:20:23.351156 | instance |  Downloading cryptography
2026-09-11 17:20:23.351190 | instance |  Downloading setuptools
2026-09-11 17:20:23.351223 | instance |  Downloading kubernetes
2026-09-11 17:20:23.351256 | instance |  Downloading ansible-core
2026-09-11 17:20:23.351290 | instance |  Downloading openstacksdk
2026-09-11 17:20:23.351323 | instance |       Built pyperclip==1.9.0
2026-09-11 17:20:23.351358 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:20:23.351392 | instance | Installed 79 packages in 138ms
2026-09-11 17:20:23.351427 | instance | Checked out ansible.posix to 1.6.0
2026-09-11 17:20:23.351462 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-11 17:20:23.351497 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.351531 | instance | Process install dependency map
2026-09-11 17:20:23.351565 | instance | Starting collection install process
2026-09-11 17:20:23.351598 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-11 17:20:23.351642 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-11 17:20:23.351839 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-11 17:20:23.351908 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.351949 | instance | 2.17.12
2026-09-11 17:20:23.351987 | instance | Checked out ansible.utils to v6.1.0
2026-09-11 17:20:23.352023 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-11 17:20:23.352058 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.352092 | instance | Process install dependency map
2026-09-11 17:20:23.352126 | instance | Starting collection install process
2026-09-11 17:20:23.352159 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-11 17:20:23.352193 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-11 17:20:23.352227 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-11 17:20:23.352262 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.352297 | instance | 2.17.12
2026-09-11 17:20:23.352331 | instance | Checked out atmosphere.common to v0.7.0
2026-09-11 17:20:23.352364 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-11 17:20:23.352397 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.352431 | instance | Process install dependency map
2026-09-11 17:20:23.352463 | instance | Starting collection install process
2026-09-11 17:20:23.352522 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-11 17:20:23.352560 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-11 17:20:23.352595 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-11 17:20:23.352629 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.352663 | instance | 2.17.12
2026-09-11 17:20:23.352696 | instance | Checked out community.crypto to 2.2.3
2026-09-11 17:20:23.352730 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-11 17:20:23.352764 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.352817 | instance | Process install dependency map
2026-09-11 17:20:23.352850 | instance | Starting collection install process
2026-09-11 17:20:23.352884 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-11 17:20:23.352917 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-11 17:20:23.352950 | instance | community.crypto:2.2.3 was installed successfully
2026-09-11 17:20:23.352984 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.353017 | instance | 2.17.12
2026-09-11 17:20:23.353051 | instance | Checked out community.general to 7.3.0
2026-09-11 17:20:23.353085 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-11 17:20:23.353119 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.353163 | instance | Process install dependency map
2026-09-11 17:20:23.353199 | instance | Starting collection install process
2026-09-11 17:20:23.353233 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-11 17:20:23.353267 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-11 17:20:23.353302 | instance | community.general:7.3.0 was installed successfully
2026-09-11 17:20:23.353338 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.353371 | instance | 2.17.12
2026-09-11 17:20:23.353406 | instance | Checked out community.mysql to 3.6.0
2026-09-11 17:20:23.353441 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-11 17:20:23.353476 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.353514 | instance | Process install dependency map
2026-09-11 17:20:23.353549 | instance | Starting collection install process
2026-09-11 17:20:23.353583 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-11 17:20:23.353618 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-11 17:20:23.353652 | instance | community.mysql:3.6.0 was installed successfully
2026-09-11 17:20:23.353685 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.353719 | instance | 2.17.12
2026-09-11 17:20:23.353752 | instance | Checked out kubernetes.core to 2.4.0
2026-09-11 17:20:23.353804 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-11 17:20:23.353839 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.353873 | instance | Process install dependency map
2026-09-11 17:20:23.353906 | instance | Starting collection install process
2026-09-11 17:20:23.353940 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-11 17:20:23.353975 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-11 17:20:23.354008 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-11 17:20:23.354041 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.354075 | instance | 2.17.12
2026-09-11 17:20:23.354108 | instance | Checked out openstack.cloud to 2.6.0
2026-09-11 17:20:23.354141 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-11 17:20:23.354175 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.354208 | instance | Process install dependency map
2026-09-11 17:20:23.354241 | instance | Starting collection install process
2026-09-11 17:20:23.354275 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-11 17:20:23.354308 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-11 17:20:23.354340 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-11 17:20:23.354373 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.354406 | instance | 2.17.12
2026-09-11 17:20:23.354439 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-11 17:20:23.354472 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-11 17:20:23.354514 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.354548 | instance | Process install dependency map
2026-09-11 17:20:23.354582 | instance | Starting collection install process
2026-09-11 17:20:23.354615 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-11 17:20:23.354648 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-11 17:20:23.354681 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-11 17:20:23.354714 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.354747 | instance | 2.17.12
2026-09-11 17:20:23.354796 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-11 17:20:23.354830 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-11 17:20:23.354864 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.354897 | instance | Process install dependency map
2026-09-11 17:20:23.354931 | instance | Starting collection install process
2026-09-11 17:20:23.354965 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-11 17:20:23.354999 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-11 17:20:23.355032 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-11 17:20:23.355065 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.355098 | instance | 2.17.12
2026-09-11 17:20:23.355131 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-11 17:20:23.355166 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-11 17:20:23.355199 | instance | Starting galaxy collection install process
2026-09-11 17:20:23.355232 | instance | Process install dependency map
2026-09-11 17:20:23.355265 | instance | Starting collection install process
2026-09-11 17:20:23.355298 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-11 17:20:23.355331 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-11 17:20:23.355364 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-11 17:20:23.355397 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:20:23.355429 | instance | 2.17.12
2026-09-11 17:20:23.366302 | 
2026-09-11 17:20:23.366385 | PLAY RECAP
2026-09-11 17:20:23.366472 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:20:23.366534 | 
2026-09-11 17:20:23.494709 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:20:23.498364 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:20:24.056967 | 
2026-09-11 17:20:24.057081 | PLAY [all]
2026-09-11 17:20:24.067096 | 
2026-09-11 17:20:24.067174 | TASK [Install "jq" for log collection]
2026-09-11 17:20:33.441842 | instance | changed
2026-09-11 17:20:33.445193 | 
2026-09-11 17:20:33.445312 | PLAY RECAP
2026-09-11 17:20:33.445411 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:20:33.445510 | 
2026-09-11 17:20:33.650913 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:20:33.657379 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:20:34.302214 | 
2026-09-11 17:20:34.302393 | PLAY [all]
2026-09-11 17:20:34.313921 | 
2026-09-11 17:20:34.314045 | LOOP [Check inventory directories]
2026-09-11 17:20:34.668040 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-11 17:20:34.852558 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-11 17:20:35.027082 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-11 17:20:35.046642 | 
2026-09-11 17:20:35.046963 | LOOP [Copy inventory file for Zuul]
2026-09-11 17:20:35.936991 | instance | changed:
2026-09-11 17:20:35.937302 | instance | {
2026-09-11 17:20:35.937386 | instance |   "ansible_loop_var": "item",
2026-09-11 17:20:35.937459 | instance |   "changed": false,
2026-09-11 17:20:35.937522 | instance |   "failed": false,
2026-09-11 17:20:35.937596 | instance |   "invocation": {
2026-09-11 17:20:35.937658 | instance |     "module_args": {
2026-09-11 17:20:35.937725 | instance |       "checksum_algorithm": "sha1",
2026-09-11 17:20:35.937818 | instance |       "follow": true,
2026-09-11 17:20:35.937885 | instance |       "get_attributes": true,
2026-09-11 17:20:35.937934 | instance |       "get_checksum": true,
2026-09-11 17:20:35.937972 | instance |       "get_mime": true,
2026-09-11 17:20:35.938010 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-11 17:20:35.938047 | instance |     }
2026-09-11 17:20:35.938083 | instance |   },
2026-09-11 17:20:35.938120 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:20:35.938156 | instance |   "stat": {
2026-09-11 17:20:35.938192 | instance |     "atime": 1789147215.83205,
2026-09-11 17:20:35.938229 | instance |     "attr_flags": "e",
2026-09-11 17:20:35.938265 | instance |     "attributes": [
2026-09-11 17:20:35.938302 | instance |       "extents"
2026-09-11 17:20:35.938338 | instance |     ],
2026-09-11 17:20:35.938373 | instance |     "block_size": 4096,
2026-09-11 17:20:35.938409 | instance |     "blocks": 8,
2026-09-11 17:20:35.938445 | instance |     "charset": "unknown",
2026-09-11 17:20:35.938484 | instance |     "ctime": 1789147214.4759645,
2026-09-11 17:20:35.938520 | instance |     "dev": 64513,
2026-09-11 17:20:35.938556 | instance |     "device_type": 0,
2026-09-11 17:20:35.938624 | instance |     "executable": true,
2026-09-11 17:20:35.938666 | instance |     "exists": true,
2026-09-11 17:20:35.938706 | instance |     "gid": 1000,
2026-09-11 17:20:35.938761 | instance |     "gr_name": "zuul",
2026-09-11 17:20:35.938856 | instance |     "inode": 1048196,
2026-09-11 17:20:35.938916 | instance |     "isblk": false,
2026-09-11 17:20:35.938956 | instance |     "ischr": false,
2026-09-11 17:20:35.938994 | instance |     "isdir": true,
2026-09-11 17:20:35.939030 | instance |     "isfifo": false,
2026-09-11 17:20:35.939068 | instance |     "isgid": false,
2026-09-11 17:20:35.939104 | instance |     "islnk": false,
2026-09-11 17:20:35.939141 | instance |     "isreg": false,
2026-09-11 17:20:35.939178 | instance |     "issock": false,
2026-09-11 17:20:35.939215 | instance |     "isuid": false,
2026-09-11 17:20:35.939250 | instance |     "mimetype": "unknown",
2026-09-11 17:20:35.939287 | instance |     "mode": "0755",
2026-09-11 17:20:35.939324 | instance |     "mtime": 1789147214.4759645,
2026-09-11 17:20:35.939361 | instance |     "nlink": 21,
2026-09-11 17:20:35.939396 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:20:35.939434 | instance |     "pw_name": "zuul",
2026-09-11 17:20:35.939471 | instance |     "readable": true,
2026-09-11 17:20:35.939507 | instance |     "rgrp": true,
2026-09-11 17:20:35.939544 | instance |     "roth": true,
2026-09-11 17:20:35.939580 | instance |     "rusr": true,
2026-09-11 17:20:35.939618 | instance |     "size": 4096,
2026-09-11 17:20:35.939654 | instance |     "uid": 1000,
2026-09-11 17:20:35.939711 | instance |     "version": "1141325388",
2026-09-11 17:20:35.939751 | instance |     "wgrp": false,
2026-09-11 17:20:35.939825 | instance |     "woth": false,
2026-09-11 17:20:35.939866 | instance |     "writeable": true,
2026-09-11 17:20:35.939903 | instance |     "wusr": true,
2026-09-11 17:20:35.939940 | instance |     "xgrp": true,
2026-09-11 17:20:35.939976 | instance |     "xoth": true,
2026-09-11 17:20:35.940011 | instance |     "xusr": true
2026-09-11 17:20:35.940046 | instance |   }
2026-09-11 17:20:35.940083 | instance | }
2026-09-11 17:20:35.940159 | instance | ok: All items complete
2026-09-11 17:20:35.940206 | 
2026-09-11 17:20:35.955123 | instance | skipping: Conditional result was False
2026-09-11 17:20:35.961441 | instance | skipping: Conditional result was False
2026-09-11 17:20:35.977007 | 
2026-09-11 17:20:35.977250 | LOOP [Switch "ansible_host" to private IP]
2026-09-11 17:20:36.347104 | instance | changed: 1 replacements made
2026-09-11 17:20:36.355106 | instance | skipping: Conditional result was False
2026-09-11 17:20:36.362926 | instance | skipping: Conditional result was False
2026-09-11 17:20:36.382202 | 
2026-09-11 17:20:36.382406 | TASK [Run Molecule scenario]
2026-09-11 17:20:37.308683 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-11 17:20:37.694285 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-11 17:20:37.694377 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-11 17:20:48.668948 | instance | INFO     [csi > dependency] Executing
2026-09-11 17:20:48.669126 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-11 17:20:48.669379 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-11 17:20:48.669526 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-11 17:20:48.684899 | instance | INFO     [csi > cleanup] Executing
2026-09-11 17:20:48.685897 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:20:48.698291 | instance | INFO     [csi > destroy] Executing
2026-09-11 17:20:48.698412 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-11 17:20:48.698530 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-11 17:20:48.708205 | instance | INFO     [csi > syntax] Executing
2026-09-11 17:20:50.371773 | instance |
2026-09-11 17:20:50.372033 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:20:50.478117 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-11 17:20:50.493648 | instance | INFO     [csi > create] Executing
2026-09-11 17:20:50.497059 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:20:50.511242 | instance | INFO     [csi > prepare] Executing
2026-09-11 17:20:51.427488 | instance |
2026-09-11 17:20:51.427815 | instance | PLAY [Prepare] *****************************************************************
2026-09-11 17:20:51.428021 | instance |
2026-09-11 17:20:51.428267 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:51.428527 | instance | Friday 11 September 2026  17:20:51 +0000 (0:00:00.024)       0:00:00.024 ******
2026-09-11 17:20:52.682813 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:20:52.683101 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:20:52.683415 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:20:52.683729 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:20:52.684013 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:20:52.694873 | instance | ok: [instance]
2026-09-11 17:20:52.695137 | instance |
2026-09-11 17:20:52.695426 | instance | TASK [Configure short hostname] ************************************************
2026-09-11 17:20:52.695748 | instance | Friday 11 September 2026  17:20:52 +0000 (0:00:01.267)       0:00:01.292 ******
2026-09-11 17:20:53.444650 | instance | changed: [instance]
2026-09-11 17:20:53.444917 | instance |
2026-09-11 17:20:53.445226 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-11 17:20:53.445520 | instance | Friday 11 September 2026  17:20:53 +0000 (0:00:00.749)       0:00:02.041 ******
2026-09-11 17:20:53.719258 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-11 17:20:53.719491 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-11 17:20:53.719854 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-11 17:20:53.728803 | instance | changed: [instance]
2026-09-11 17:20:53.729041 | instance |
2026-09-11 17:20:53.729291 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-11 17:20:53.729536 | instance | Friday 11 September 2026  17:20:53 +0000 (0:00:00.284)       0:00:02.326 ******
2026-09-11 17:20:54.540148 | instance | ok: [instance]
2026-09-11 17:20:54.540337 | instance |
2026-09-11 17:20:54.540831 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-11 17:20:54.541247 | instance |
2026-09-11 17:20:54.541648 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:54.542038 | instance | Friday 11 September 2026  17:20:54 +0000 (0:00:00.811)       0:00:03.137 ******
2026-09-11 17:20:55.317966 | instance | ok: [instance]
2026-09-11 17:20:55.318147 | instance |
2026-09-11 17:20:55.318459 | instance | TASK [Install depedencies] *****************************************************
2026-09-11 17:20:55.318749 | instance | Friday 11 September 2026  17:20:55 +0000 (0:00:00.777)       0:00:03.915 ******
2026-09-11 17:21:19.707516 | instance | changed: [instance]
2026-09-11 17:21:19.707707 | instance |
2026-09-11 17:21:19.707951 | instance | TASK [Start up service] ********************************************************
2026-09-11 17:21:19.708190 | instance | Friday 11 September 2026  17:21:19 +0000 (0:00:24.388)       0:00:28.303 ******
2026-09-11 17:21:20.317471 | instance | ok: [instance]
2026-09-11 17:21:20.317838 | instance |
2026-09-11 17:21:20.318157 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-11 17:21:20.318478 | instance | Friday 11 September 2026  17:21:20 +0000 (0:00:00.611)       0:00:28.914 ******
2026-09-11 17:21:20.624756 | instance | ok: [instance]
2026-09-11 17:21:20.624967 | instance |
2026-09-11 17:21:20.625282 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-11 17:21:20.625727 | instance | Friday 11 September 2026  17:21:20 +0000 (0:00:00.307)       0:00:29.222 ******
2026-09-11 17:21:21.336016 | instance | changed: [instance]
2026-09-11 17:21:21.336266 | instance |
2026-09-11 17:21:21.336280 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-11 17:21:21.336290 | instance | Friday 11 September 2026  17:21:21 +0000 (0:00:00.709)       0:00:29.932 ******
2026-09-11 17:21:21.556847 | instance | ok: [instance]
2026-09-11 17:21:21.556914 | instance |
2026-09-11 17:21:21.556926 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-11 17:21:21.556939 | instance | Friday 11 September 2026  17:21:21 +0000 (0:00:00.220)       0:00:30.153 ******
2026-09-11 17:21:21.587144 | instance | skipping: [instance]
2026-09-11 17:21:21.587214 | instance |
2026-09-11 17:21:21.587230 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-11 17:21:21.587243 | instance | Friday 11 September 2026  17:21:21 +0000 (0:00:00.030)       0:00:30.183 ******
2026-09-11 17:21:22.190629 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:21:22.191923 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:21:22.191979 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:21:22.191990 | instance |
2026-09-11 17:21:22.192000 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-11 17:21:22.192010 | instance | Friday 11 September 2026  17:21:22 +0000 (0:00:00.604)       0:00:30.787 ******
2026-09-11 17:21:22.850815 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:21:22.851963 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:21:22.852013 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:21:22.852025 | instance |
2026-09-11 17:21:22.852035 | instance | TASK [Start loop devices] ******************************************************
2026-09-11 17:21:22.852045 | instance | Friday 11 September 2026  17:21:22 +0000 (0:00:00.660)       0:00:31.448 ******
2026-09-11 17:21:23.596529 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:21:23.597829 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:21:23.597867 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:21:23.597879 | instance |
2026-09-11 17:21:23.597890 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-11 17:21:23.597904 | instance | Friday 11 September 2026  17:21:23 +0000 (0:00:00.745)       0:00:32.193 ******
2026-09-11 17:21:26.952001 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:21:26.953671 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:21:26.953755 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:21:26.953772 | instance |
2026-09-11 17:21:26.953786 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-11 17:21:26.953799 | instance | Friday 11 September 2026  17:21:26 +0000 (0:00:03.355)       0:00:35.549 ******
2026-09-11 17:21:28.892693 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-11 17:21:28.893801 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-11 17:21:28.893918 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-11 17:21:28.893930 | instance |
2026-09-11 17:21:28.893939 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:21:28.893957 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-11 17:21:28.897868 | instance |
2026-09-11 17:21:28.897978 | instance | Friday 11 September 2026  17:21:28 +0000 (0:00:01.941)       0:00:37.490 ******
2026-09-11 17:21:28.897991 | instance | ===============================================================================
2026-09-11 17:21:28.898000 | instance | Install depedencies ---------------------------------------------------- 24.39s
2026-09-11 17:21:28.898009 | instance | Create a volume group for each loop device ------------------------------ 3.36s
2026-09-11 17:21:28.898018 | instance | Create a logical volume for each loop device ---------------------------- 1.94s
2026-09-11 17:21:28.898029 | instance | Gathering Facts --------------------------------------------------------- 1.27s
2026-09-11 17:21:28.898038 | instance | Purge "snapd" package --------------------------------------------------- 0.81s
2026-09-11 17:21:28.898047 | instance | Gathering Facts --------------------------------------------------------- 0.78s
2026-09-11 17:21:28.898055 | instance | Configure short hostname ------------------------------------------------ 0.75s
2026-09-11 17:21:28.898064 | instance | Start loop devices ------------------------------------------------------ 0.75s
2026-09-11 17:21:28.898072 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.71s
2026-09-11 17:21:28.898081 | instance | Set permissions on loopback devices ------------------------------------- 0.66s
2026-09-11 17:21:28.898089 | instance | Start up service -------------------------------------------------------- 0.61s
2026-09-11 17:21:28.898098 | instance | Create devices for Ceph ------------------------------------------------- 0.60s
2026-09-11 17:21:28.898107 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-09-11 17:21:28.898129 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s
2026-09-11 17:21:28.898139 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-11 17:21:28.898340 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-11 17:21:28.994956 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-11 17:21:29.010379 | instance | INFO     [csi > converge] Executing
2026-09-11 17:21:30.413138 | instance |
2026-09-11 17:21:30.413357 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-11 17:21:30.413550 | instance |
2026-09-11 17:21:30.413801 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:21:30.413990 | instance | Friday 11 September 2026  17:21:30 +0000 (0:00:00.007)       0:00:00.007 ******
2026-09-11 17:21:31.555482 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:21:31.555861 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:21:31.556233 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:21:31.556632 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:21:31.556952 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:21:31.570759 | instance | ok: [instance]
2026-09-11 17:21:31.571160 | instance |
2026-09-11 17:21:31.571622 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-11 17:21:31.571974 | instance | Friday 11 September 2026  17:21:31 +0000 (0:00:01.156)       0:00:01.164 ******
2026-09-11 17:21:31.641261 | instance | ok: [instance] => {
2026-09-11 17:21:31.641833 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-11 17:21:31.642250 | instance | }
2026-09-11 17:21:31.642669 | instance |
2026-09-11 17:21:31.643073 | instance | PLAY [all] *********************************************************************
2026-09-11 17:21:31.643474 | instance |
2026-09-11 17:21:31.643877 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:21:31.644313 | instance | Friday 11 September 2026  17:21:31 +0000 (0:00:00.070)       0:00:01.234 ******
2026-09-11 17:21:32.676210 | instance | ok: [instance]
2026-09-11 17:21:32.676604 | instance |
2026-09-11 17:21:32.677064 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-11 17:21:32.677562 | instance | Friday 11 September 2026  17:21:32 +0000 (0:00:01.035)       0:00:02.269 ******
2026-09-11 17:21:32.875875 | instance | ok: [instance]
2026-09-11 17:21:32.876080 | instance |
2026-09-11 17:21:32.876259 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-11 17:21:32.876440 | instance |
2026-09-11 17:21:32.876619 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:21:32.876791 | instance | Friday 11 September 2026  17:21:32 +0000 (0:00:00.200)       0:00:02.470 ******
2026-09-11 17:21:33.834706 | instance | ok: [instance]
2026-09-11 17:21:33.835084 | instance |
2026-09-11 17:21:33.835448 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:21:33.835793 | instance | Friday 11 September 2026  17:21:33 +0000 (0:00:00.958)       0:00:03.428 ******
2026-09-11 17:21:34.158163 | instance | ok: [instance]
2026-09-11 17:21:34.158338 | instance |
2026-09-11 17:21:34.158500 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:21:34.158641 | instance | Friday 11 September 2026  17:21:34 +0000 (0:00:00.322)       0:00:03.750 ******
2026-09-11 17:21:34.199207 | instance | skipping: [instance]
2026-09-11 17:21:34.199249 | instance |
2026-09-11 17:21:34.199254 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-11 17:21:34.199260 | instance | Friday 11 September 2026  17:21:34 +0000 (0:00:00.042)       0:00:03.792 ******
2026-09-11 17:21:34.531062 | instance | changed: [instance]
2026-09-11 17:21:34.531106 | instance |
2026-09-11 17:21:34.531113 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:21:34.531120 | instance | Friday 11 September 2026  17:21:34 +0000 (0:00:00.331)       0:00:04.123 ******
2026-09-11 17:21:34.633421 | instance | ok: [instance] => {
2026-09-11 17:21:34.633488 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-11 17:21:34.633503 | instance | }
2026-09-11 17:21:34.633515 | instance |
2026-09-11 17:21:34.633527 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:21:34.633540 | instance | Friday 11 September 2026  17:21:34 +0000 (0:00:00.101)       0:00:04.224 ******
2026-09-11 17:21:35.349770 | instance | changed: [instance]
2026-09-11 17:21:35.349817 | instance |
2026-09-11 17:21:35.349828 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:21:35.349838 | instance | Friday 11 September 2026  17:21:35 +0000 (0:00:00.717)       0:00:04.942 ******
2026-09-11 17:21:35.411948 | instance | skipping: [instance]
2026-09-11 17:21:35.412404 | instance |
2026-09-11 17:21:35.412433 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:21:35.412446 | instance | Friday 11 September 2026  17:21:35 +0000 (0:00:00.063)       0:00:05.005 ******
2026-09-11 17:21:35.482590 | instance | skipping: [instance]
2026-09-11 17:21:35.482641 | instance |
2026-09-11 17:21:35.482650 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:21:35.482658 | instance | Friday 11 September 2026  17:21:35 +0000 (0:00:00.069)       0:00:05.075 ******
2026-09-11 17:21:35.729464 | instance | ok: [instance]
2026-09-11 17:21:35.729657 | instance |
2026-09-11 17:21:35.730037 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:21:35.730345 | instance | Friday 11 September 2026  17:21:35 +0000 (0:00:00.247)       0:00:05.322 ******
2026-09-11 17:21:37.137604 | instance | ok: [instance]
2026-09-11 17:21:37.137794 | instance |
2026-09-11 17:21:37.137868 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:21:37.138053 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:01.408)       0:00:06.731 ******
2026-09-11 17:21:37.233472 | instance | ok: [instance] => {
2026-09-11 17:21:37.233724 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-11 17:21:37.234001 | instance | }
2026-09-11 17:21:37.234192 | instance |
2026-09-11 17:21:37.234428 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:21:37.234686 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:00.095)       0:00:06.827 ******
2026-09-11 17:21:37.859154 | instance | changed: [instance]
2026-09-11 17:21:37.859319 | instance |
2026-09-11 17:21:37.859689 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:21:37.859993 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:00.625)       0:00:07.452 ******
2026-09-11 17:21:40.910488 | instance | changed: [instance]
2026-09-11 17:21:40.910566 | instance |
2026-09-11 17:21:40.910765 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-11 17:21:40.911021 | instance | Friday 11 September 2026  17:21:40 +0000 (0:00:03.049)       0:00:10.502 ******
2026-09-11 17:21:40.957921 | instance | skipping: [instance]
2026-09-11 17:21:40.958346 | instance |
2026-09-11 17:21:40.958684 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-11 17:21:40.959019 | instance | Friday 11 September 2026  17:21:40 +0000 (0:00:00.045)       0:00:10.547 ******
2026-09-11 17:21:40.987742 | instance | skipping: [instance]
2026-09-11 17:21:40.988520 | instance |
2026-09-11 17:21:40.988962 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-11 17:21:40.989407 | instance | Friday 11 September 2026  17:21:40 +0000 (0:00:00.033)       0:00:10.581 ******
2026-09-11 17:21:41.020090 | instance | skipping: [instance]
2026-09-11 17:21:41.020435 | instance |
2026-09-11 17:21:41.020743 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-11 17:21:41.021040 | instance | Friday 11 September 2026  17:21:41 +0000 (0:00:00.032)       0:00:10.613 ******
2026-09-11 17:21:47.077471 | instance | changed: [instance]
2026-09-11 17:21:47.077896 | instance |
2026-09-11 17:21:47.078269 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-11 17:21:47.078593 | instance | Friday 11 September 2026  17:21:47 +0000 (0:00:06.056)       0:00:16.670 ******
2026-09-11 17:21:47.750151 | instance | changed: [instance]
2026-09-11 17:21:47.750206 | instance |
2026-09-11 17:21:47.750242 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-11 17:21:47.750251 | instance | Friday 11 September 2026  17:21:47 +0000 (0:00:00.672)       0:00:17.343 ******
2026-09-11 17:21:48.729757 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-11 17:21:48.731161 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-11 17:21:48.731184 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-11 17:21:48.731193 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-11 17:21:48.731202 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-11 17:21:48.731234 | instance |
2026-09-11 17:21:48.731251 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-11 17:21:48.731260 | instance | Friday 11 September 2026  17:21:48 +0000 (0:00:00.979)       0:00:18.323 ******
2026-09-11 17:21:49.304992 | instance | changed: [instance]
2026-09-11 17:21:49.305033 | instance |
2026-09-11 17:21:49.305039 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-11 17:21:49.305043 | instance | Friday 11 September 2026  17:21:49 +0000 (0:00:00.559)       0:00:18.883 ******
2026-09-11 17:21:49.305047 | instance |
2026-09-11 17:21:49.305099 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:21:49.305368 | instance | Friday 11 September 2026  17:21:49 +0000 (0:00:00.014)       0:00:18.897 ******
2026-09-11 17:21:50.269515 | instance | ok: [instance]
2026-09-11 17:21:50.269797 | instance |
2026-09-11 17:21:50.270107 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-11 17:21:50.270425 | instance | Friday 11 September 2026  17:21:50 +0000 (0:00:00.965)       0:00:19.862 ******
2026-09-11 17:21:50.720703 | instance | changed: [instance]
2026-09-11 17:21:50.720888 | instance |
2026-09-11 17:21:50.721117 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-11 17:21:50.721378 | instance | Friday 11 September 2026  17:21:50 +0000 (0:00:00.451)       0:00:20.314 ******
2026-09-11 17:21:51.345804 | instance | changed: [instance]
2026-09-11 17:21:51.345860 | instance |
2026-09-11 17:21:51.345871 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:21:51.346092 | instance | Friday 11 September 2026  17:21:51 +0000 (0:00:00.624)       0:00:20.938 ******
2026-09-11 17:21:51.584767 | instance | ok: [instance]
2026-09-11 17:21:51.584844 | instance |
2026-09-11 17:21:51.585234 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:21:51.585278 | instance | Friday 11 September 2026  17:21:51 +0000 (0:00:00.240)       0:00:21.178 ******
2026-09-11 17:21:51.665068 | instance | ok: [instance] => {
2026-09-11 17:21:51.665768 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-11 17:21:51.665808 | instance | }
2026-09-11 17:21:51.666546 | instance |
2026-09-11 17:21:51.666606 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:21:51.666621 | instance | Friday 11 September 2026  17:21:51 +0000 (0:00:00.079)       0:00:21.258 ******
2026-09-11 17:21:55.578464 | instance | changed: [instance]
2026-09-11 17:21:55.578625 | instance |
2026-09-11 17:21:55.579311 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:21:55.579385 | instance | Friday 11 September 2026  17:21:55 +0000 (0:00:03.913)       0:00:25.171 ******
2026-09-11 17:22:01.040684 | instance | changed: [instance]
2026-09-11 17:22:01.041521 | instance |
2026-09-11 17:22:01.041580 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-11 17:22:01.041590 | instance | Friday 11 September 2026  17:22:01 +0000 (0:00:05.462)       0:00:30.633 ******
2026-09-11 17:22:02.382776 | instance | ok: [instance]
2026-09-11 17:22:02.383585 | instance |
2026-09-11 17:22:02.383664 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-11 17:22:02.383677 | instance | Friday 11 September 2026  17:22:02 +0000 (0:00:01.341)       0:00:31.975 ******
2026-09-11 17:22:02.774674 | instance | changed: [instance]
2026-09-11 17:22:02.774728 | instance |
2026-09-11 17:22:02.774740 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-11 17:22:02.774751 | instance | Friday 11 September 2026  17:22:02 +0000 (0:00:00.391)       0:00:32.367 ******
2026-09-11 17:22:03.280627 | instance | changed: [instance]
2026-09-11 17:22:03.281268 | instance |
2026-09-11 17:22:03.281293 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-11 17:22:03.281303 | instance | Friday 11 September 2026  17:22:03 +0000 (0:00:00.507)       0:00:32.874 ******
2026-09-11 17:22:03.899982 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-11 17:22:03.901358 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-11 17:22:03.901437 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-11 17:22:03.901450 | instance |
2026-09-11 17:22:03.901461 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-11 17:22:03.901472 | instance | Friday 11 September 2026  17:22:03 +0000 (0:00:00.618)       0:00:33.492 ******
2026-09-11 17:22:04.415061 | instance | changed: [instance]
2026-09-11 17:22:04.415177 | instance |
2026-09-11 17:22:04.415191 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-11 17:22:04.415201 | instance | Friday 11 September 2026  17:22:04 +0000 (0:00:00.514)       0:00:34.006 ******
2026-09-11 17:22:04.946366 | instance | changed: [instance]
2026-09-11 17:22:04.946484 | instance |
2026-09-11 17:22:04.946558 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-11 17:22:04.947205 | instance | Friday 11 September 2026  17:22:04 +0000 (0:00:00.503)       0:00:34.510 ******
2026-09-11 17:22:04.947264 | instance |
2026-09-11 17:22:04.947272 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:22:04.947278 | instance | Friday 11 September 2026  17:22:04 +0000 (0:00:00.029)       0:00:34.540 ******
2026-09-11 17:22:05.736098 | instance | ok: [instance]
2026-09-11 17:22:05.736793 | instance |
2026-09-11 17:22:05.736847 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-11 17:22:05.736869 | instance | Friday 11 September 2026  17:22:05 +0000 (0:00:00.789)       0:00:35.329 ******
2026-09-11 17:22:06.890407 | instance | changed: [instance]
2026-09-11 17:22:06.891208 | instance |
2026-09-11 17:22:06.891583 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-11 17:22:06.891603 | instance | Friday 11 September 2026  17:22:06 +0000 (0:00:01.154)       0:00:36.483 ******
2026-09-11 17:22:07.469317 | instance | changed: [instance]
2026-09-11 17:22:07.469438 | instance |
2026-09-11 17:22:07.469508 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-11 17:22:07.469716 | instance | Friday 11 September 2026  17:22:07 +0000 (0:00:00.579)       0:00:37.063 ******
2026-09-11 17:22:07.547128 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-11 17:22:07.547213 | instance |
2026-09-11 17:22:07.547510 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-11 17:22:07.547578 | instance | Friday 11 September 2026  17:22:07 +0000 (0:00:00.077)       0:00:37.140 ******
2026-09-11 17:22:13.392553 | instance | changed: [instance]
2026-09-11 17:22:13.393352 | instance |
2026-09-11 17:22:13.393408 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-11 17:22:13.393421 | instance | Friday 11 September 2026  17:22:13 +0000 (0:00:05.845)       0:00:42.986 ******
2026-09-11 17:22:14.110815 | instance | ok: [instance] => (item=chronyd)
2026-09-11 17:22:14.110884 | instance | ok: [instance] => (item=sshd)
2026-09-11 17:22:14.111240 | instance |
2026-09-11 17:22:14.111285 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-11 17:22:14.111291 | instance | Friday 11 September 2026  17:22:14 +0000 (0:00:00.718)       0:00:43.704 ******
2026-09-11 17:22:25.001859 | instance | changed: [instance]
2026-09-11 17:22:25.002214 | instance |
2026-09-11 17:22:25.002793 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-11 17:22:25.002845 | instance | Friday 11 September 2026  17:22:24 +0000 (0:00:10.890)       0:00:54.594 ******
2026-09-11 17:22:25.246362 | instance | ok: [instance]
2026-09-11 17:22:25.246426 | instance |
2026-09-11 17:22:25.246434 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-11 17:22:25.246441 | instance | Friday 11 September 2026  17:22:25 +0000 (0:00:00.244)       0:00:54.839 ******
2026-09-11 17:22:25.790302 | instance | changed: [instance]
2026-09-11 17:22:25.790413 | instance |
2026-09-11 17:22:25.790786 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-11 17:22:25.790837 | instance | Friday 11 September 2026  17:22:25 +0000 (0:00:00.544)       0:00:55.383 ******
2026-09-11 17:22:26.182330 | instance | changed: [instance]
2026-09-11 17:22:26.182434 | instance |
2026-09-11 17:22:26.182613 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-11 17:22:26.182833 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.392)       0:00:55.775 ******
2026-09-11 17:22:26.320851 | instance | ok: [instance]
2026-09-11 17:22:26.321180 | instance |
2026-09-11 17:22:26.321523 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-11 17:22:26.322020 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.138)       0:00:55.914 ******
2026-09-11 17:22:26.576808 | instance | ok: [instance] => (item=instance)
2026-09-11 17:22:26.577091 | instance |
2026-09-11 17:22:26.577404 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-11 17:22:26.577776 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.255)       0:00:56.169 ******
2026-09-11 17:22:26.629116 | instance | ok: [instance]
2026-09-11 17:22:26.629509 | instance |
2026-09-11 17:22:26.629921 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-11 17:22:26.630257 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.052)       0:00:56.222 ******
2026-09-11 17:22:26.707309 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-11 17:22:26.707472 | instance |
2026-09-11 17:22:26.707738 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-11 17:22:26.707966 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.078)       0:00:56.300 ******
2026-09-11 17:22:27.025248 | instance | changed: [instance]
2026-09-11 17:22:27.025348 | instance |
2026-09-11 17:22:27.025465 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-11 17:22:27.025579 | instance | Friday 11 September 2026  17:22:27 +0000 (0:00:00.318)       0:00:56.619 ******
2026-09-11 17:22:27.782910 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-11 17:22:27.783010 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-11 17:22:27.783318 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-11 17:22:27.783533 | instance |
2026-09-11 17:22:27.783771 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-11 17:22:27.784006 | instance | Friday 11 September 2026  17:22:27 +0000 (0:00:00.756)       0:00:57.376 ******
2026-09-11 17:23:57.914530 | instance | ok: [instance]
2026-09-11 17:23:57.914611 | instance |
2026-09-11 17:23:57.914746 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-11 17:23:57.914854 | instance | Friday 11 September 2026  17:23:57 +0000 (0:01:30.131)       0:02:27.508 ******
2026-09-11 17:23:58.138288 | instance | changed: [instance]
2026-09-11 17:23:58.138427 | instance |
2026-09-11 17:23:58.138620 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-11 17:23:58.138821 | instance | Friday 11 September 2026  17:23:58 +0000 (0:00:00.224)       0:02:27.732 ******
2026-09-11 17:23:58.167013 | instance | ok: [instance]
2026-09-11 17:23:58.167168 | instance |
2026-09-11 17:23:58.167350 | instance | TASK [Install Ceph host] *******************************************************
2026-09-11 17:23:58.167530 | instance | Friday 11 September 2026  17:23:58 +0000 (0:00:00.028)       0:02:27.761 ******
2026-09-11 17:23:58.233050 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-11 17:23:58.233161 | instance |
2026-09-11 17:23:58.233330 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-11 17:23:58.233502 | instance | Friday 11 September 2026  17:23:58 +0000 (0:00:00.066)       0:02:27.827 ******
2026-09-11 17:24:00.292596 | instance | ok: [instance]
2026-09-11 17:24:00.292665 | instance |
2026-09-11 17:24:00.292695 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-11 17:24:00.292706 | instance | Friday 11 September 2026  17:24:00 +0000 (0:00:02.057)       0:02:29.885 ******
2026-09-11 17:24:00.365358 | instance | ok: [instance] => (item=instance)
2026-09-11 17:24:00.365436 | instance |
2026-09-11 17:24:00.365610 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-11 17:24:00.365822 | instance | Friday 11 September 2026  17:24:00 +0000 (0:00:00.074)       0:02:29.959 ******
2026-09-11 17:24:00.743552 | instance | ok: [instance]
2026-09-11 17:24:00.743587 | instance |
2026-09-11 17:24:00.743593 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-11 17:24:00.743598 | instance | Friday 11 September 2026  17:24:00 +0000 (0:00:00.378)       0:02:30.337 ******
2026-09-11 17:24:03.274255 | instance | ok: [instance]
2026-09-11 17:24:03.274354 | instance |
2026-09-11 17:24:03.274425 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-11 17:24:03.274572 | instance | Friday 11 September 2026  17:24:03 +0000 (0:00:02.530)       0:02:32.867 ******
2026-09-11 17:24:53.083527 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-11 17:24:53.084568 | instance | fatal: [instance]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n  File \"<stdin>\", line 107, in <module>\n  File \"<stdin>\", line 99, in _ansiballz_main\n  File \"<stdin>\", line 47, in invoke_module\n  File \"/usr/lib/python3.10/runpy.py\", line 224, in run_module\n    return _run_module_code(code, init_globals, run_name, mod_spec)\n  File \"/usr/lib/python3.10/runpy.py\", line 96, in _run_module_code\n    _run_code(code, mod_globals, init_globals,\n  File \"/usr/lib/python3.10/runpy.py\", line 86, in _run_code\n    exec(code, run_globals)\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_d1xwlgqv/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in <module>\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_d1xwlgqv/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 198, in main\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_d1xwlgqv/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 177, in run_module\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_d1xwlgqv/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAEOaRq3yVZCyAAkVpjVieJmn7CN/KZGv4KjwTS5NPbhs43r5vYEsbPtGI=: Malformed input [buffer:3]\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAEOaRq3yVZCyAAkVpjVieJmn7CN/KZGv4KjwTS5NPbhs43r5vYEsbPtGI=: Malformed input [buffer:3]\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAEOaRq3yVZCyAAkVpjVieJmn7CN/KZGv4KjwTS5NPbhs43r5vYEsbPtGI=: Malformed input [buffer:3]\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:52.893+0000 7fc63e2c3640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-11 17:24:53.094038 | instance |
2026-09-11 17:24:53.094083 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:24:53.094100 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-11 17:24:53.094113 | instance |
2026-09-11 17:24:53.094125 | instance | Friday 11 September 2026  17:24:53 +0000 (0:00:49.814)       0:03:22.681 ******
2026-09-11 17:24:53.094137 | instance | ===============================================================================
2026-09-11 17:24:53.094148 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 90.13s
2026-09-11 17:24:53.094160 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 49.81s
2026-09-11 17:24:53.094171 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 10.89s
2026-09-11 17:24:53.094180 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.06s
2026-09-11 17:24:53.094188 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.85s
2026-09-11 17:24:53.094196 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 5.46s
2026-09-11 17:24:53.094205 | instance | vexxhost.containers.download_artifact : Download item ------------------- 3.91s
2026-09-11 17:24:53.094213 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.05s
2026-09-11 17:24:53.094264 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.53s
2026-09-11 17:24:53.094276 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 2.06s
2026-09-11 17:24:53.094285 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.75s
2026-09-11 17:24:53.094294 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.41s
2026-09-11 17:24:53.094302 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.34s
2026-09-11 17:24:53.094310 | instance | Gathering Facts --------------------------------------------------------- 1.16s
2026-09-11 17:24:53.094319 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.15s
2026-09-11 17:24:53.094327 | instance | Gathering Facts --------------------------------------------------------- 1.04s
2026-09-11 17:24:53.094335 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.98s
2026-09-11 17:24:53.094343 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-11 17:24:53.094351 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.76s
2026-09-11 17:24:53.094360 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.72s
2026-09-11 17:24:53.194887 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:24:53.195144 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-11 17:24:53.195337 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:24:53.771930 | instance | ERROR
2026-09-11 17:24:53.772128 | instance | {
2026-09-11 17:24:53.772178 | instance |   "delta": "0:04:16.521308",
2026-09-11 17:24:53.772206 | instance |   "end": "2026-09-11 17:24:53.266655",
2026-09-11 17:24:53.772231 | instance |   "msg": "non-zero return code",
2026-09-11 17:24:53.772254 | instance |   "rc": 2,
2026-09-11 17:24:53.772275 | instance |   "start": "2026-09-11 17:20:36.745347"
2026-09-11 17:24:53.772296 | instance | }
failure
2026-09-11 17:24:53.777996 | 
2026-09-11 17:24:53.778078 | PLAY RECAP
2026-09-11 17:24:53.778137 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:24:53.778166 | 
2026-09-11 17:24:53.903765 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:24:53.908307 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:24:54.541407 | 
2026-09-11 17:24:54.541514 | PLAY [all]
2026-09-11 17:24:54.554243 | 
2026-09-11 17:24:54.554319 | TASK [gather-host-logs : creating directory for system status]
2026-09-11 17:24:54.919945 | instance | changed
2026-09-11 17:24:54.929626 | 
2026-09-11 17:24:54.929777 | TASK [gather-host-logs : Get logs for each host]
2026-09-11 17:24:55.330498 | instance | + systemd-cgls --full --all --no-pager
2026-09-11 17:24:55.345509 | instance | + ip addr
2026-09-11 17:24:55.350169 | instance | + ip route
2026-09-11 17:24:55.352460 | instance | + lsblk
2026-09-11 17:24:55.357208 | instance | + mount
2026-09-11 17:24:55.359412 | instance | + docker images
2026-09-11 17:24:55.389868 | instance | + brctl show
2026-09-11 17:24:55.390553 | instance | /bin/bash: line 8: brctl: command not found
2026-09-11 17:24:55.390901 | instance | + ip neigh
2026-09-11 17:24:55.393629 | instance | + bridge fdb show
2026-09-11 17:24:55.397552 | instance | + ps aux --sort=-%mem
2026-09-11 17:24:55.417182 | instance | + dpkg -l
2026-09-11 17:24:55.429069 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-11 17:24:55.429687 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-11 17:24:55.449820 | instance | + '[' '!' -z '' ']'
2026-09-11 17:24:55.500832 | instance | ok: Runtime: 0:00:00.124850
2026-09-11 17:24:55.510904 | 
2026-09-11 17:24:55.511433 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-11 17:24:56.147166 | instance | changed:
2026-09-11 17:24:56.147383 | instance | created directory /var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/logs/instance
2026-09-11 17:24:56.147441 | instance | cd+++++++++ system/
2026-09-11 17:24:56.147484 | instance | >f+++++++++ system/brctl-show.txt
2026-09-11 17:24:56.147525 | instance | >f+++++++++ system/bridge-fdb.txt
2026-09-11 17:24:56.147563 | instance | >f+++++++++ system/docker-images.txt
2026-09-11 17:24:56.147609 | instance | >f+++++++++ system/ip-addr.txt
2026-09-11 17:24:56.147649 | instance | >f+++++++++ system/ip-neigh.txt
2026-09-11 17:24:56.147688 | instance | >f+++++++++ system/ip-route.txt
2026-09-11 17:24:56.147730 | instance | >f+++++++++ system/lsblk.txt
2026-09-11 17:24:56.147768 | instance | >f+++++++++ system/mount.txt
2026-09-11 17:24:56.147826 | instance | >f+++++++++ system/packages.txt
2026-09-11 17:24:56.147866 | instance | >f+++++++++ system/ps.txt
2026-09-11 17:24:56.147903 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-11 17:24:56.165345 | 
2026-09-11 17:24:56.165500 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-11 17:24:56.385582 | instance | changed: "values"
2026-09-11 17:24:56.563105 | instance | changed: "releases"
2026-09-11 17:24:56.579791 | 
2026-09-11 17:24:56.580007 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-11 17:24:56.849889 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-11 17:24:57.136113 | instance | ok: Runtime: 0:00:00.006538
2026-09-11 17:24:57.144968 | 
2026-09-11 17:24:57.145077 | TASK [helm-release-status : Downloads logs to executor]
2026-09-11 17:24:57.624004 | instance | changed:
2026-09-11 17:24:57.624239 | instance | cd+++++++++ helm/
2026-09-11 17:24:57.624293 | instance | cd+++++++++ helm/releases/
2026-09-11 17:24:57.624334 | instance | cd+++++++++ helm/values/
2026-09-11 17:24:57.640681 | 
2026-09-11 17:24:57.640825 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-11 17:24:57.866484 | instance | changed
2026-09-11 17:24:57.876865 | 
2026-09-11 17:24:57.877010 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-11 17:24:58.160131 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:58.160228 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:58.165050 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:58.166528 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:58.167025 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:58.168499 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:58.170167 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:58.171866 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:58.172956 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:58.174543 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:58.176189 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:58.177452 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:58.421998 | instance | ok: Runtime: 0:00:00.026131
2026-09-11 17:24:58.432078 | 
2026-09-11 17:24:58.432209 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-11 17:24:58.633763 | instance | changed
2026-09-11 17:24:58.642651 | 
2026-09-11 17:24:58.642782 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-11 17:24:58.907831 | instance | environment: line 5: kubectl: command not found
2026-09-11 17:24:58.909205 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:58.909335 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:58.909421 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:59.182945 | instance | ok: Runtime: 0:00:00.010955
2026-09-11 17:24:59.192774 | 
2026-09-11 17:24:59.192928 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-11 17:24:59.690620 | instance | changed:
2026-09-11 17:24:59.690857 | instance | cd+++++++++ objects/
2026-09-11 17:24:59.690913 | instance | cd+++++++++ objects/cluster/
2026-09-11 17:24:59.690953 | instance | cd+++++++++ objects/namespaced/
2026-09-11 17:24:59.707137 | 
2026-09-11 17:24:59.707255 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-11 17:24:59.944158 | instance | changed
2026-09-11 17:24:59.953707 | 
2026-09-11 17:24:59.953917 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-11 17:25:00.156317 | instance | changed
2026-09-11 17:25:00.160379 | 
2026-09-11 17:25:00.160452 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-11 17:25:00.391207 | instance | environment: line 3: kubectl: command not found
2026-09-11 17:25:00.688506 | instance | ok: Runtime: 0:00:00.010138
2026-09-11 17:25:00.695269 | 
2026-09-11 17:25:00.695356 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-11 17:25:01.210303 | instance | changed:
2026-09-11 17:25:01.210547 | instance | cd+++++++++ pod-logs/
2026-09-11 17:25:01.210600 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-11 17:25:01.224268 | 
2026-09-11 17:25:01.224399 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-11 17:25:01.448436 | instance | changed
2026-09-11 17:25:01.457763 | 
2026-09-11 17:25:01.457932 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-11 17:25:01.699451 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:25:02.014730 | instance | ok: Runtime: 0:00:00.046918
2026-09-11 17:25:02.025743 | 
2026-09-11 17:25:02.025913 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-11 17:25:02.293396 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:25:02.341778 | instance | ceph-mgr endpoints:
2026-09-11 17:25:02.575011 | instance | ok: Runtime: 0:00:00.054394
2026-09-11 17:25:02.584353 | 
2026-09-11 17:25:02.584485 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-11 17:25:02.840151 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-11 17:25:03.127233 | instance | ok: Runtime: 0:00:00.057364
2026-09-11 17:25:03.136462 | 
2026-09-11 17:25:03.136620 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-11 17:25:03.655239 | instance | changed: cd+++++++++ prometheus/
2026-09-11 17:25:03.673904 | 
2026-09-11 17:25:03.674034 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-11 17:25:03.891613 | instance | changed
2026-09-11 17:25:03.901725 | 
2026-09-11 17:25:03.901884 | TASK [gather-selenium-data : Get selenium data]
2026-09-11 17:25:04.153365 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-11 17:25:04.155038 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-11 17:25:04.445199 | instance | ERROR
2026-09-11 17:25:04.445441 | instance | {
2026-09-11 17:25:04.445504 | instance |   "delta": "0:00:00.006681",
2026-09-11 17:25:04.445545 | instance |   "end": "2026-09-11 17:25:04.155454",
2026-09-11 17:25:04.445582 | instance |   "msg": "non-zero return code",
2026-09-11 17:25:04.445618 | instance |   "rc": 1,
2026-09-11 17:25:04.445659 | instance |   "start": "2026-09-11 17:25:04.148773"
2026-09-11 17:25:04.445695 | instance | }
2026-09-11 17:25:04.445740 | instance | ERROR: Ignoring Errors
2026-09-11 17:25:04.455159 | 
2026-09-11 17:25:04.455288 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-11 17:25:04.960278 | instance | changed: cd+++++++++ selenium/
2026-09-11 17:25:04.966564 | 
2026-09-11 17:25:04.966610 | PLAY RECAP
2026-09-11 17:25:04.966650 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-11 17:25:04.966668 | 
2026-09-11 17:25:05.065917 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:25:05.071376 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:25:05.693122 | 
2026-09-11 17:25:05.693283 | PLAY [all]
2026-09-11 17:25:05.705107 | 
2026-09-11 17:25:05.705222 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-11 17:25:05.759679 | instance | skipping: Conditional result was False
2026-09-11 17:25:05.766980 | 
2026-09-11 17:25:05.767155 | TASK [fetch-output : Set log path for single node]
2026-09-11 17:25:05.795660 | instance | ok
2026-09-11 17:25:05.801125 | 
2026-09-11 17:25:05.801210 | LOOP [fetch-output : Ensure local output dirs]
2026-09-11 17:25:06.144456 | instance -> localhost | ok: "/var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/logs"
2026-09-11 17:25:06.402273 | instance -> localhost | changed: "/var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/artifacts"
2026-09-11 17:25:06.630833 | instance -> localhost | changed: "/var/lib/zuul/builds/99449bf673624a46aa74b44b612488ee/work/docs"
2026-09-11 17:25:06.650691 | 
2026-09-11 17:25:06.650898 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-11 17:25:07.337750 | instance | changed: .d..t...... ./
2026-09-11 17:25:07.338510 | instance | changed: All items complete
2026-09-11 17:25:07.338570 | 
2026-09-11 17:25:07.823089 | instance | changed: .d..t...... ./
2026-09-11 17:25:08.345379 | instance | changed: .d..t...... ./
2026-09-11 17:25:08.377677 | 
2026-09-11 17:25:08.377911 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-11 17:25:08.817665 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007103
2026-09-11 17:25:09.094493 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006301
2026-09-11 17:25:09.104739 | 
2026-09-11 17:25:09.104856 | PLAY [all]
2026-09-11 17:25:09.109903 | 
2026-09-11 17:25:09.109974 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-11 17:25:09.518240 | instance | changed
2026-09-11 17:25:09.532622 | 
2026-09-11 17:25:09.532765 | PLAY RECAP
2026-09-11 17:25:09.532928 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-11 17:25:09.533013 | 
2026-09-11 17:25:09.671559 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:25:09.677202 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-11 17:25:10.225513 | 
2026-09-11 17:25:10.225630 | PLAY [localhost]
2026-09-11 17:25:10.234371 | 
2026-09-11 17:25:10.234439 | TASK [Generate Zuul manifest]
2026-09-11 17:25:10.250439 | localhost | ok
2026-09-11 17:25:10.268527 | 
2026-09-11 17:25:10.268610 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-11 17:25:10.682186 | localhost | changed
2026-09-11 17:25:10.700978 | 
2026-09-11 17:25:10.701124 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-11 17:25:10.742444 | localhost | ok
2026-09-11 17:25:10.755084 | 
2026-09-11 17:25:10.755213 | TASK [Upload logs]
2026-09-11 17:25:10.778147 | localhost | ok
2026-09-11 17:25:10.848321 | 
2026-09-11 17:25:10.848427 | TASK [Set zuul-log-path fact]
2026-09-11 17:25:10.867408 | localhost | ok
2026-09-11 17:25:10.880843 | 
2026-09-11 17:25:10.880909 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:25:10.919260 | localhost | ok
2026-09-11 17:25:10.927352 | 
2026-09-11 17:25:10.927441 | TASK [upload-logs : Create log directories]
2026-09-11 17:25:11.394740 | localhost | changed
2026-09-11 17:25:11.399206 | 
2026-09-11 17:25:11.399275 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-11 17:25:11.803722 | localhost -> localhost | ok: Runtime: 0:00:00.004323
2026-09-11 17:25:11.812654 | 
2026-09-11 17:25:11.812781 | TASK [upload-logs : Upload logs to log server]
2026-09-11 17:25:12.302019 | localhost | Output suppressed because no_log was given
2026-09-11 17:25:12.348790 | 
2026-09-11 17:25:12.348959 | LOOP [upload-logs : Compress console log and json output]
2026-09-11 17:25:12.410918 | localhost | skipping: Conditional result was False
2026-09-11 17:25:12.573260 | localhost | skipping: Conditional result was False
2026-09-11 17:25:12.585028 | 
2026-09-11 17:25:12.585345 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-11 17:25:12.643618 | localhost | skipping: Conditional result was False
2026-09-11 17:25:12.644052 | 
2026-09-11 17:25:12.649184 | localhost | skipping: Conditional result was False
2026-09-11 17:25:12.658016 | 
2026-09-11 17:25:12.658334 | LOOP [upload-logs : Upload console log and json output]