2026-09-07 18:12:03.123802 | Job console starting
2026-09-07 18:12:03.133773 | Updating git repos
2026-09-07 18:12:09.543969 | Cloning repos into workspace
2026-09-07 18:12:25.931877 | Restoring repo states
2026-09-07 18:12:38.431992 | Merging changes
2026-09-07 18:12:39.888983 | Checking out repos
2026-09-07 18:12:41.574509 | Preparing playbooks
2026-09-07 18:12:44.022539 | Running Ansible setup
2026-09-07 18:12:47.478108 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 18:12:48.044335 | 
2026-09-07 18:12:48.044438 | PLAY [localhost]
2026-09-07 18:12:48.050938 | 
2026-09-07 18:12:48.051005 | TASK [Gathering Facts]
2026-09-07 18:12:49.018248 | localhost | ok
2026-09-07 18:12:49.031260 | 
2026-09-07 18:12:49.031467 | TASK [Setup log path fact]
2026-09-07 18:12:49.052540 | localhost | ok
2026-09-07 18:12:49.073120 | 
2026-09-07 18:12:49.073518 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 18:12:49.104310 | localhost | ok
2026-09-07 18:12:49.116764 | 
2026-09-07 18:12:49.116903 | TASK [emit-job-header : Print job information]
2026-09-07 18:12:49.158629 | # Job Information
2026-09-07 18:12:49.158850 | Ansible Version: 2.16.18
2026-09-07 18:12:49.158912 | Job: atmosphere-molecule-csi-rbd
2026-09-07 18:12:49.158953 | Pipeline: check
2026-09-07 18:12:49.158990 | Executor: 2d72f0692154
2026-09-07 18:12:49.159026 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-09-07 18:12:49.159070 | Event ID: 1e635670-aae7-11f1-8f2a-6793cbd169de
2026-09-07 18:12:49.164253 | 
2026-09-07 18:12:49.164384 | LOOP [emit-job-header : Print node information]
2026-09-07 18:12:49.261285 | localhost | ok:
2026-09-07 18:12:49.261756 | localhost | # Node Information
2026-09-07 18:12:49.261813 | localhost | Inventory Hostname: instance
2026-09-07 18:12:49.261856 | localhost | Hostname: np0000192164
2026-09-07 18:12:49.261895 | localhost | Username: zuul
2026-09-07 18:12:49.261939 | localhost | Distro: Ubuntu 22.04
2026-09-07 18:12:49.261977 | localhost | Provider: yul1
2026-09-07 18:12:49.262015 | localhost | Region: ca-ymq-1
2026-09-07 18:12:49.262051 | localhost | Label: ubuntu-jammy
2026-09-07 18:12:49.262087 | localhost | Product Name: OpenStack Nova
2026-09-07 18:12:49.262145 | localhost | Interface IP: 162.253.55.189
2026-09-07 18:12:49.278764 | 
2026-09-07 18:12:49.278874 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-07 18:12:49.637803 | localhost -> localhost | changed
2026-09-07 18:12:49.646771 | 
2026-09-07 18:12:49.646932 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-07 18:12:50.423405 | localhost -> localhost | changed
2026-09-07 18:12:50.434508 | 
2026-09-07 18:12:50.434629 | PLAY [all]
2026-09-07 18:12:50.449288 | 
2026-09-07 18:12:50.449422 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-07 18:12:50.756728 | instance -> localhost | ok
2026-09-07 18:12:50.763324 | 
2026-09-07 18:12:50.763398 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-07 18:12:50.792291 | instance | ok
2026-09-07 18:12:50.808231 | instance | included: /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-07 18:12:50.816285 | 
2026-09-07 18:12:50.816412 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-07 18:12:52.091884 | instance -> localhost | Generating public/private rsa key pair.
2026-09-07 18:12:52.092080 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/6b060e8364874c10a5d4897873dded37_id_rsa
2026-09-07 18:12:52.092134 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/6b060e8364874c10a5d4897873dded37_id_rsa.pub
2026-09-07 18:12:52.092167 | instance -> localhost | The key fingerprint is:
2026-09-07 18:12:52.092196 | instance -> localhost | SHA256:bVZd0iiVtDuY1KQol8JldBVRb6u1J3yM0Fyk0lBQD3Q zuul-build-sshkey
2026-09-07 18:12:52.092239 | instance -> localhost | The key's randomart image is:
2026-09-07 18:12:52.092269 | instance -> localhost | +---[RSA 3072]----+
2026-09-07 18:12:52.092304 | instance -> localhost | |         .+ +O&BE|
2026-09-07 18:12:52.092334 | instance -> localhost | |       . o +.BoXo|
2026-09-07 18:12:52.092362 | instance -> localhost | |        + + =.* =|
2026-09-07 18:12:52.092389 | instance -> localhost | |         = o * +.|
2026-09-07 18:12:52.092416 | instance -> localhost | |        S + + =o |
2026-09-07 18:12:52.092444 | instance -> localhost | |         o   oo+.|
2026-09-07 18:12:52.092474 | instance -> localhost | |             .+.+|
2026-09-07 18:12:52.092828 | instance -> localhost | |               o.|
2026-09-07 18:12:52.092883 | instance -> localhost | |                 |
2026-09-07 18:12:52.092919 | instance -> localhost | +----[SHA256]-----+
2026-09-07 18:12:52.092992 | instance -> localhost | ok: Runtime: 0:00:00.861410
2026-09-07 18:12:52.101053 | 
2026-09-07 18:12:52.101164 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-07 18:12:52.131182 | instance | ok
2026-09-07 18:12:52.141967 | instance | included: /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-07 18:12:52.152117 | 
2026-09-07 18:12:52.197523 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-07 18:12:52.234938 | instance | skipping: Conditional result was False
2026-09-07 18:12:52.241770 | 
2026-09-07 18:12:52.241867 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-07 18:12:52.700525 | instance | changed
2026-09-07 18:12:52.709213 | 
2026-09-07 18:12:52.709346 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-07 18:12:52.901742 | instance | ok
2026-09-07 18:12:52.908763 | 
2026-09-07 18:12:52.908851 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-07 18:12:53.398565 | instance | changed
2026-09-07 18:12:53.408985 | 
2026-09-07 18:12:53.409255 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-07 18:12:53.951405 | instance | changed
2026-09-07 18:12:53.965204 | 
2026-09-07 18:12:53.965382 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-07 18:12:53.990173 | instance | skipping: Conditional result was False
2026-09-07 18:12:53.998003 | 
2026-09-07 18:12:53.998091 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-07 18:12:54.386145 | instance -> localhost | changed
2026-09-07 18:12:54.394859 | 
2026-09-07 18:12:54.394919 | TASK [add-build-sshkey : Add back temp key]
2026-09-07 18:12:54.690861 | instance -> localhost | Identity added: /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/6b060e8364874c10a5d4897873dded37_id_rsa (zuul-build-sshkey)
2026-09-07 18:12:54.691150 | instance -> localhost | ok: Runtime: 0:00:00.014660
2026-09-07 18:12:54.700284 | 
2026-09-07 18:12:54.700406 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-07 18:12:55.018984 | instance | ok
2026-09-07 18:12:55.027902 | 
2026-09-07 18:12:55.028050 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-07 18:12:55.052692 | instance | skipping: Conditional result was False
2026-09-07 18:12:55.070451 | 
2026-09-07 18:12:55.070578 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-07 18:12:55.426731 | instance | ok
2026-09-07 18:12:55.436762 | 
2026-09-07 18:12:55.436841 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-07 18:12:59.005825 | instance | Output suppressed because no_log was given
2026-09-07 18:12:59.022254 | 
2026-09-07 18:12:59.022379 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-07 18:12:59.243377 | instance | ok: "logs"
2026-09-07 18:12:59.243765 | instance | ok: All items complete
2026-09-07 18:12:59.243827 | 
2026-09-07 18:12:59.409050 | instance | ok: "artifacts"
2026-09-07 18:12:59.588175 | instance | ok: "docs"
2026-09-07 18:12:59.607030 | 
2026-09-07 18:12:59.607194 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-07 18:12:59.804186 | instance | changed: "logs"
2026-09-07 18:12:59.988916 | instance | changed: "artifacts"
2026-09-07 18:13:00.162192 | instance | changed: "docs"
2026-09-07 18:13:00.178179 | 
2026-09-07 18:13:00.178319 | PLAY RECAP
2026-09-07 18:13:00.178412 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-07 18:13:00.178482 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 18:13:00.178530 | 
2026-09-07 18:13:00.341974 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 18:13:00.343736 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 18:13:00.924706 | 
2026-09-07 18:13:00.924845 | PLAY [all]
2026-09-07 18:13:00.936651 | 
2026-09-07 18:13:00.936731 | TASK [setup-uv : Extract archive]
2026-09-07 18:13:03.292290 | instance | changed
2026-09-07 18:13:03.304299 | 
2026-09-07 18:13:03.304464 | TASK [setup-uv : Print version]
2026-09-07 18:13:03.661886 | instance | uv 0.8.13
2026-09-07 18:13:03.848566 | instance | ok: Runtime: 0:00:00.013411
2026-09-07 18:13:03.860274 | 
2026-09-07 18:13:03.860373 | TASK [Install Ansible collection siblings]
2026-09-07 18:13:13.387111 | instance | changed:
2026-09-07 18:13:13.387436 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-07 18:13:13.387485 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-07 18:13:13.387515 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-07 18:13:13.387541 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-07 18:13:13.387566 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-07 18:13:13.387594 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-07 18:13:13.387621 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-07 18:13:13.387649 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-07 18:13:13.387675 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-07 18:13:13.387700 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-07 18:13:13.387725 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-07 18:13:13.387749 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-07 18:13:13.387774 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-07 18:13:13.387798 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-07 18:13:13.387822 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-07 18:13:13.387846 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-07 18:13:13.387871 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-07 18:13:13.387895 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-07 18:13:13.387919 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-07 18:13:13.387943 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-07 18:13:13.387966 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-07 18:13:13.387989 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-07 18:13:13.388014 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 18:13:13.388053 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-07 18:13:13.388077 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-07 18:13:13.388100 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 18:13:13.388122 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 18:13:13.388144 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 18:13:13.388166 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-07 18:13:13.388188 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-07 18:13:13.388230 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 18:13:13.388255 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 18:13:13.388278 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-07 18:13:13.388301 | 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-07 18:13:13.388334 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.388357 | instance | Process install dependency map
2026-09-07 18:13:13.388381 | instance | Starting collection install process
2026-09-07 18:13:13.388404 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-07 18:13:13.388427 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-07 18:13:13.388450 | instance | ansible.netcommon:* was installed successfully
2026-09-07 18:13:13.388473 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-07 18:13:13.388525 | instance | Creating virtual environment at: .venv
2026-09-07 18:13:13.388565 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 18:13:13.388590 | instance | Downloading ansible-core (2.1MiB)
2026-09-07 18:13:13.388614 | instance | Downloading kubernetes (1.9MiB)
2026-09-07 18:13:13.388665 | instance | Downloading pygments (1.2MiB)
2026-09-07 18:13:13.388724 | instance | Downloading netaddr (2.2MiB)
2026-09-07 18:13:13.388760 | instance | Downloading setuptools (1.1MiB)
2026-09-07 18:13:13.388793 | instance | Downloading cryptography (4.2MiB)
2026-09-07 18:13:13.388825 | instance | Downloading openstacksdk (1.7MiB)
2026-09-07 18:13:13.388855 | instance | Downloading rjsonnet (1.2MiB)
2026-09-07 18:13:13.388887 | instance |    Building pyperclip==1.9.0
2026-09-07 18:13:13.388919 | instance |  Downloading rjsonnet
2026-09-07 18:13:13.388956 | instance |  Downloading netaddr
2026-09-07 18:13:13.388989 | instance |  Downloading pygments
2026-09-07 18:13:13.389019 | instance |  Downloading cryptography
2026-09-07 18:13:13.389053 | instance |  Downloading setuptools
2026-09-07 18:13:13.389087 | instance |  Downloading kubernetes
2026-09-07 18:13:13.389120 | instance |  Downloading ansible-core
2026-09-07 18:13:13.389153 | instance |  Downloading openstacksdk
2026-09-07 18:13:13.389188 | instance |       Built pyperclip==1.9.0
2026-09-07 18:13:13.389242 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 18:13:13.389281 | instance | Installed 79 packages in 83ms
2026-09-07 18:13:13.389315 | instance | Checked out ansible.posix to 1.6.0
2026-09-07 18:13:13.389350 | 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-07 18:13:13.389383 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.389415 | instance | Process install dependency map
2026-09-07 18:13:13.392893 | instance | Starting collection install process
2026-09-07 18:13:13.392961 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-07 18:13:13.393022 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-07 18:13:13.393065 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-07 18:13:13.393103 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.393140 | instance | 2.17.12
2026-09-07 18:13:13.393177 | instance | Checked out ansible.utils to v6.1.0
2026-09-07 18:13:13.393236 | 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-07 18:13:13.393274 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.393308 | instance | Process install dependency map
2026-09-07 18:13:13.393341 | instance | Starting collection install process
2026-09-07 18:13:13.393375 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-07 18:13:13.393409 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-07 18:13:13.393443 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-07 18:13:13.393479 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.393516 | instance | 2.17.12
2026-09-07 18:13:13.393552 | instance | Checked out atmosphere.common to v0.7.0
2026-09-07 18:13:13.393589 | 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-07 18:13:13.393624 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.393658 | instance | Process install dependency map
2026-09-07 18:13:13.393695 | instance | Starting collection install process
2026-09-07 18:13:13.393733 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-07 18:13:13.393767 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-07 18:13:13.393803 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-07 18:13:13.393838 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.393872 | instance | 2.17.12
2026-09-07 18:13:13.393905 | instance | Checked out community.crypto to 2.2.3
2026-09-07 18:13:13.394106 | 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-07 18:13:13.394141 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.394173 | instance | Process install dependency map
2026-09-07 18:13:13.394223 | instance | Starting collection install process
2026-09-07 18:13:13.394259 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-07 18:13:13.394292 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-07 18:13:13.394323 | instance | community.crypto:2.2.3 was installed successfully
2026-09-07 18:13:13.394354 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.394383 | instance | 2.17.12
2026-09-07 18:13:13.394414 | instance | Checked out community.general to 7.3.0
2026-09-07 18:13:13.394446 | 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-07 18:13:13.394477 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.394521 | instance | Process install dependency map
2026-09-07 18:13:13.394558 | instance | Starting collection install process
2026-09-07 18:13:13.394593 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-07 18:13:13.394629 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-07 18:13:13.394665 | instance | community.general:7.3.0 was installed successfully
2026-09-07 18:13:13.394702 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.394738 | instance | 2.17.12
2026-09-07 18:13:13.394774 | instance | Checked out community.mysql to 3.6.0
2026-09-07 18:13:13.394804 | 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-07 18:13:13.394829 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.394856 | instance | Process install dependency map
2026-09-07 18:13:13.394881 | instance | Starting collection install process
2026-09-07 18:13:13.394905 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-07 18:13:13.394929 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-07 18:13:13.394953 | instance | community.mysql:3.6.0 was installed successfully
2026-09-07 18:13:13.394976 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.395000 | instance | 2.17.12
2026-09-07 18:13:13.395023 | instance | Checked out kubernetes.core to 2.4.0
2026-09-07 18:13:13.395047 | 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-07 18:13:13.395070 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.395094 | instance | Process install dependency map
2026-09-07 18:13:13.395117 | instance | Starting collection install process
2026-09-07 18:13:13.395141 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-07 18:13:13.395164 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-07 18:13:13.395189 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-07 18:13:13.395232 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.395259 | instance | 2.17.12
2026-09-07 18:13:13.395283 | instance | Checked out openstack.cloud to 2.6.0
2026-09-07 18:13:13.395307 | 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-07 18:13:13.395331 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.395355 | instance | Process install dependency map
2026-09-07 18:13:13.397512 | instance | Starting collection install process
2026-09-07 18:13:13.397562 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-07 18:13:13.397590 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-07 18:13:13.397615 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-07 18:13:13.397639 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.397664 | instance | 2.17.12
2026-09-07 18:13:13.397687 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-07 18:13:13.397711 | 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-07 18:13:13.397744 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.397768 | instance | Process install dependency map
2026-09-07 18:13:13.397791 | instance | Starting collection install process
2026-09-07 18:13:13.397815 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-07 18:13:13.397838 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-07 18:13:13.397862 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-07 18:13:13.397885 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.397908 | instance | 2.17.12
2026-09-07 18:13:13.397931 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-07 18:13:13.397954 | 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-07 18:13:13.397978 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.398000 | instance | Process install dependency map
2026-09-07 18:13:13.398023 | instance | Starting collection install process
2026-09-07 18:13:13.398046 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-07 18:13:13.398071 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-07 18:13:13.398095 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-07 18:13:13.398118 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.398141 | instance | 2.17.12
2026-09-07 18:13:13.398164 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-07 18:13:13.398187 | 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-07 18:13:13.398229 | instance | Starting galaxy collection install process
2026-09-07 18:13:13.398254 | instance | Process install dependency map
2026-09-07 18:13:13.398277 | instance | Starting collection install process
2026-09-07 18:13:13.398300 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-07 18:13:13.398324 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-07 18:13:13.398347 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-07 18:13:13.398369 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 18:13:13.398392 | instance | 2.17.12
2026-09-07 18:13:13.405674 | 
2026-09-07 18:13:13.405740 | PLAY RECAP
2026-09-07 18:13:13.405802 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 18:13:13.405829 | 
2026-09-07 18:13:13.643120 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 18:13:13.645111 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 18:13:14.262804 | 
2026-09-07 18:13:14.262919 | PLAY [all]
2026-09-07 18:13:14.272821 | 
2026-09-07 18:13:14.272913 | TASK [Install "jq" for log collection]
2026-09-07 18:13:23.597099 | instance | changed
2026-09-07 18:13:23.600242 | 
2026-09-07 18:13:23.600385 | PLAY RECAP
2026-09-07 18:13:23.600484 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 18:13:23.600618 | 
2026-09-07 18:13:23.704955 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 18:13:23.711702 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 18:13:24.285770 | 
2026-09-07 18:13:24.285922 | PLAY [all]
2026-09-07 18:13:24.296200 | 
2026-09-07 18:13:24.296288 | LOOP [Check inventory directories]
2026-09-07 18:13:24.717397 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-07 18:13:24.888020 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-07 18:13:25.041929 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-07 18:13:25.068916 | 
2026-09-07 18:13:25.069278 | LOOP [Copy inventory file for Zuul]
2026-09-07 18:13:26.008421 | instance | changed:
2026-09-07 18:13:26.009417 | instance | {
2026-09-07 18:13:26.009463 | instance |   "ansible_loop_var": "item",
2026-09-07 18:13:26.009492 | instance |   "changed": false,
2026-09-07 18:13:26.009515 | instance |   "failed": false,
2026-09-07 18:13:26.009542 | instance |   "invocation": {
2026-09-07 18:13:26.009564 | instance |     "module_args": {
2026-09-07 18:13:26.009586 | instance |       "checksum_algorithm": "sha1",
2026-09-07 18:13:26.009606 | instance |       "follow": true,
2026-09-07 18:13:26.009626 | instance |       "get_attributes": true,
2026-09-07 18:13:26.009648 | instance |       "get_checksum": true,
2026-09-07 18:13:26.009669 | instance |       "get_mime": true,
2026-09-07 18:13:26.009689 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-07 18:13:26.009709 | instance |     }
2026-09-07 18:13:26.009729 | instance |   },
2026-09-07 18:13:26.009749 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-07 18:13:26.009770 | instance |   "stat": {
2026-09-07 18:13:26.009790 | instance |     "atime": 1788804786.3927853,
2026-09-07 18:13:26.009810 | instance |     "attr_flags": "e",
2026-09-07 18:13:26.009830 | instance |     "attributes": [
2026-09-07 18:13:26.009850 | instance |       "extents"
2026-09-07 18:13:26.009869 | instance |     ],
2026-09-07 18:13:26.009888 | instance |     "block_size": 4096,
2026-09-07 18:13:26.009907 | instance |     "blocks": 8,
2026-09-07 18:13:26.009927 | instance |     "charset": "unknown",
2026-09-07 18:13:26.009948 | instance |     "ctime": 1788804784.7645564,
2026-09-07 18:13:26.009968 | instance |     "dev": 64513,
2026-09-07 18:13:26.009988 | instance |     "device_type": 0,
2026-09-07 18:13:26.010008 | instance |     "executable": true,
2026-09-07 18:13:26.010028 | instance |     "exists": true,
2026-09-07 18:13:26.010048 | instance |     "gid": 1000,
2026-09-07 18:13:26.010068 | instance |     "gr_name": "zuul",
2026-09-07 18:13:26.010087 | instance |     "inode": 1048803,
2026-09-07 18:13:26.010107 | instance |     "isblk": false,
2026-09-07 18:13:26.010127 | instance |     "ischr": false,
2026-09-07 18:13:26.010147 | instance |     "isdir": true,
2026-09-07 18:13:26.010167 | instance |     "isfifo": false,
2026-09-07 18:13:26.010187 | instance |     "isgid": false,
2026-09-07 18:13:26.010207 | instance |     "islnk": false,
2026-09-07 18:13:26.010226 | instance |     "isreg": false,
2026-09-07 18:13:26.010246 | instance |     "issock": false,
2026-09-07 18:13:26.010279 | instance |     "isuid": false,
2026-09-07 18:13:26.010300 | instance |     "mimetype": "unknown",
2026-09-07 18:13:26.010320 | instance |     "mode": "0755",
2026-09-07 18:13:26.010339 | instance |     "mtime": 1788804784.7645564,
2026-09-07 18:13:26.010359 | instance |     "nlink": 22,
2026-09-07 18:13:26.010378 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-07 18:13:26.010397 | instance |     "pw_name": "zuul",
2026-09-07 18:13:26.010421 | instance |     "readable": true,
2026-09-07 18:13:26.010449 | instance |     "rgrp": true,
2026-09-07 18:13:26.010477 | instance |     "roth": true,
2026-09-07 18:13:26.010498 | instance |     "rusr": true,
2026-09-07 18:13:26.010518 | instance |     "size": 4096,
2026-09-07 18:13:26.010538 | instance |     "uid": 1000,
2026-09-07 18:13:26.010571 | instance |     "version": "2632558819",
2026-09-07 18:13:26.010593 | instance |     "wgrp": false,
2026-09-07 18:13:26.010615 | instance |     "woth": false,
2026-09-07 18:13:26.010638 | instance |     "writeable": true,
2026-09-07 18:13:26.010667 | instance |     "wusr": true,
2026-09-07 18:13:26.010690 | instance |     "xgrp": true,
2026-09-07 18:13:26.010710 | instance |     "xoth": true,
2026-09-07 18:13:26.010730 | instance |     "xusr": true
2026-09-07 18:13:26.010752 | instance |   }
2026-09-07 18:13:26.010773 | instance | }
2026-09-07 18:13:26.010812 | instance | ok: All items complete
2026-09-07 18:13:26.010845 | 
2026-09-07 18:13:26.012385 | instance | skipping: Conditional result was False
2026-09-07 18:13:26.013160 | instance | skipping: Conditional result was False
2026-09-07 18:13:26.025052 | 
2026-09-07 18:13:26.025289 | LOOP [Switch "ansible_host" to private IP]
2026-09-07 18:13:26.395664 | instance | changed: 1 replacements made
2026-09-07 18:13:26.398250 | instance | skipping: Conditional result was False
2026-09-07 18:13:26.405594 | instance | skipping: Conditional result was False
2026-09-07 18:13:26.421724 | 
2026-09-07 18:13:26.421947 | TASK [Run Molecule scenario]
2026-09-07 18:13:27.379006 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-07 18:13:27.794349 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-07 18:13:27.794420 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-07 18:13:38.561323 | instance | INFO     [csi > dependency] Executing
2026-09-07 18:13:38.561473 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-07 18:13:38.561616 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-07 18:13:38.561733 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-07 18:13:38.571063 | instance | INFO     [csi > cleanup] Executing
2026-09-07 18:13:38.571492 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 18:13:38.581234 | instance | INFO     [csi > destroy] Executing
2026-09-07 18:13:38.581333 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-07 18:13:38.581464 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-07 18:13:38.589058 | instance | INFO     [csi > syntax] Executing
2026-09-07 18:13:40.035976 | instance |
2026-09-07 18:13:40.036145 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-07 18:13:40.096221 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-07 18:13:40.111612 | instance | INFO     [csi > create] Executing
2026-09-07 18:13:40.115213 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 18:13:40.129257 | instance | INFO     [csi > prepare] Executing
2026-09-07 18:13:40.878984 | instance |
2026-09-07 18:13:40.879228 | instance | PLAY [Prepare] *****************************************************************
2026-09-07 18:13:40.879407 | instance |
2026-09-07 18:13:40.879653 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 18:13:40.879883 | instance | Monday 07 September 2026  18:13:40 +0000 (0:00:00.023)       0:00:00.023 ******
2026-09-07 18:13:42.152462 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 18:13:42.153547 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 18:13:42.153606 | instance | interpreter could change the meaning of that path. See
2026-09-07 18:13:42.153618 | instance | https://docs.ansible.com/ansible-
2026-09-07 18:13:42.153628 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 18:13:42.163368 | instance | ok: [instance]
2026-09-07 18:13:42.163419 | instance |
2026-09-07 18:13:42.163431 | instance | TASK [Configure short hostname] ************************************************
2026-09-07 18:13:42.163440 | instance | Monday 07 September 2026  18:13:42 +0000 (0:00:01.284)       0:00:01.307 ******
2026-09-07 18:13:42.906582 | instance | changed: [instance]
2026-09-07 18:13:42.906640 | instance |
2026-09-07 18:13:42.906651 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-07 18:13:42.906662 | instance | Monday 07 September 2026  18:13:42 +0000 (0:00:00.742)       0:00:02.049 ******
2026-09-07 18:13:43.193937 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-07 18:13:43.194131 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-07 18:13:43.194271 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-07 18:13:43.204400 | instance | changed: [instance]
2026-09-07 18:13:43.204578 | instance |
2026-09-07 18:13:43.204725 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-07 18:13:43.204899 | instance | Monday 07 September 2026  18:13:43 +0000 (0:00:00.299)       0:00:02.348 ******
2026-09-07 18:13:44.008811 | instance | ok: [instance]
2026-09-07 18:13:44.009165 | instance |
2026-09-07 18:13:44.009524 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-07 18:13:44.009810 | instance |
2026-09-07 18:13:44.010098 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 18:13:44.010499 | instance | Monday 07 September 2026  18:13:44 +0000 (0:00:00.804)       0:00:03.153 ******
2026-09-07 18:13:44.717880 | instance | ok: [instance]
2026-09-07 18:13:44.718249 | instance |
2026-09-07 18:13:44.718616 | instance | TASK [Install depedencies] *****************************************************
2026-09-07 18:13:44.718982 | instance | Monday 07 September 2026  18:13:44 +0000 (0:00:00.708)       0:00:03.862 ******
2026-09-07 18:14:09.318137 | instance | changed: [instance]
2026-09-07 18:14:09.318274 | instance |
2026-09-07 18:14:09.318282 | instance | TASK [Start up service] ********************************************************
2026-09-07 18:14:09.318289 | instance | Monday 07 September 2026  18:14:09 +0000 (0:00:24.599)       0:00:28.461 ******
2026-09-07 18:14:09.916439 | instance | ok: [instance]
2026-09-07 18:14:09.916523 | instance |
2026-09-07 18:14:09.916535 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-07 18:14:09.916573 | instance | Monday 07 September 2026  18:14:09 +0000 (0:00:00.598)       0:00:29.059 ******
2026-09-07 18:14:10.262200 | instance | ok: [instance]
2026-09-07 18:14:10.262280 | instance |
2026-09-07 18:14:10.262292 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-07 18:14:10.262303 | instance | Monday 07 September 2026  18:14:10 +0000 (0:00:00.345)       0:00:29.405 ******
2026-09-07 18:14:11.010538 | instance | changed: [instance]
2026-09-07 18:14:11.010600 | instance |
2026-09-07 18:14:11.010613 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-07 18:14:11.010623 | instance | Monday 07 September 2026  18:14:11 +0000 (0:00:00.748)       0:00:30.154 ******
2026-09-07 18:14:11.221890 | instance | ok: [instance]
2026-09-07 18:14:11.222623 | instance |
2026-09-07 18:14:11.222655 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-07 18:14:11.222667 | instance | Monday 07 September 2026  18:14:11 +0000 (0:00:00.212)       0:00:30.366 ******
2026-09-07 18:14:11.247753 | instance | skipping: [instance]
2026-09-07 18:14:11.248662 | instance |
2026-09-07 18:14:11.248732 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-07 18:14:11.248888 | instance | Monday 07 September 2026  18:14:11 +0000 (0:00:00.026)       0:00:30.392 ******
2026-09-07 18:14:11.842205 | instance | changed: [instance] => (item=osd0)
2026-09-07 18:14:11.842301 | instance | changed: [instance] => (item=osd1)
2026-09-07 18:14:11.842880 | instance | changed: [instance] => (item=osd2)
2026-09-07 18:14:11.843152 | instance |
2026-09-07 18:14:11.843179 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-07 18:14:11.843187 | instance | Monday 07 September 2026  18:14:11 +0000 (0:00:00.593)       0:00:30.986 ******
2026-09-07 18:14:12.521288 | instance | changed: [instance] => (item=osd0)
2026-09-07 18:14:12.522453 | instance | changed: [instance] => (item=osd1)
2026-09-07 18:14:12.522522 | instance | changed: [instance] => (item=osd2)
2026-09-07 18:14:12.522533 | instance |
2026-09-07 18:14:12.522543 | instance | TASK [Start loop devices] ******************************************************
2026-09-07 18:14:12.522553 | instance | Monday 07 September 2026  18:14:12 +0000 (0:00:00.679)       0:00:31.665 ******
2026-09-07 18:14:13.338875 | instance | changed: [instance] => (item=osd0)
2026-09-07 18:14:13.340142 | instance | changed: [instance] => (item=osd1)
2026-09-07 18:14:13.340218 | instance | changed: [instance] => (item=osd2)
2026-09-07 18:14:13.340231 | instance |
2026-09-07 18:14:13.340241 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-07 18:14:13.340251 | instance | Monday 07 September 2026  18:14:13 +0000 (0:00:00.817)       0:00:32.482 ******
2026-09-07 18:14:16.668540 | instance | changed: [instance] => (item=osd0)
2026-09-07 18:14:16.668837 | instance | changed: [instance] => (item=osd1)
2026-09-07 18:14:16.669195 | instance | changed: [instance] => (item=osd2)
2026-09-07 18:14:16.669494 | instance |
2026-09-07 18:14:16.669786 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-07 18:14:16.670118 | instance | Monday 07 September 2026  18:14:16 +0000 (0:00:03.329)       0:00:35.812 ******
2026-09-07 18:14:18.635952 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-07 18:14:18.636162 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-07 18:14:18.636864 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-07 18:14:18.637163 | instance |
2026-09-07 18:14:18.637492 | instance | PLAY RECAP *********************************************************************
2026-09-07 18:14:18.637814 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-07 18:14:18.638094 | instance |
2026-09-07 18:14:18.638413 | instance | Monday 07 September 2026  18:14:18 +0000 (0:00:01.968)       0:00:37.780 ******
2026-09-07 18:14:18.638745 | instance | ===============================================================================
2026-09-07 18:14:18.639043 | instance | Install depedencies ---------------------------------------------------- 24.60s
2026-09-07 18:14:18.639352 | instance | Create a volume group for each loop device ------------------------------ 3.33s
2026-09-07 18:14:18.639668 | instance | Create a logical volume for each loop device ---------------------------- 1.97s
2026-09-07 18:14:18.639961 | instance | Gathering Facts --------------------------------------------------------- 1.28s
2026-09-07 18:14:18.640250 | instance | Start loop devices ------------------------------------------------------ 0.82s
2026-09-07 18:14:18.640656 | instance | Purge "snapd" package --------------------------------------------------- 0.80s
2026-09-07 18:14:18.640962 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.75s
2026-09-07 18:14:18.641279 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-07 18:14:18.641602 | instance | Gathering Facts --------------------------------------------------------- 0.71s
2026-09-07 18:14:18.641892 | instance | Set permissions on loopback devices ------------------------------------- 0.68s
2026-09-07 18:14:18.642178 | instance | Start up service -------------------------------------------------------- 0.60s
2026-09-07 18:14:18.642489 | instance | Create devices for Ceph ------------------------------------------------- 0.59s
2026-09-07 18:14:18.642776 | instance | Generate lvm.conf ------------------------------------------------------- 0.35s
2026-09-07 18:14:18.643061 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-07 18:14:18.643367 | instance | Get list of all loopback devices ---------------------------------------- 0.21s
2026-09-07 18:14:18.643658 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-07 18:14:18.744012 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-07 18:14:18.759775 | instance | INFO     [csi > converge] Executing
2026-09-07 18:14:20.142198 | instance |
2026-09-07 18:14:20.142695 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-07 18:14:20.143031 | instance |
2026-09-07 18:14:20.143380 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 18:14:20.143708 | instance | Monday 07 September 2026  18:14:20 +0000 (0:00:00.007)       0:00:00.007 ******
2026-09-07 18:14:21.212491 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 18:14:21.212786 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 18:14:21.212990 | instance | interpreter could change the meaning of that path. See
2026-09-07 18:14:21.213195 | instance | https://docs.ansible.com/ansible-
2026-09-07 18:14:21.213417 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 18:14:21.226214 | instance | ok: [instance]
2026-09-07 18:14:21.226427 | instance |
2026-09-07 18:14:21.226624 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-07 18:14:21.226810 | instance | Monday 07 September 2026  18:14:21 +0000 (0:00:01.084)       0:00:01.092 ******
2026-09-07 18:14:21.294368 | instance | ok: [instance] => {
2026-09-07 18:14:21.294761 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-07 18:14:21.295044 | instance | }
2026-09-07 18:14:21.295311 | instance |
2026-09-07 18:14:21.295615 | instance | PLAY [all] *********************************************************************
2026-09-07 18:14:21.295881 | instance |
2026-09-07 18:14:21.296159 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 18:14:21.296505 | instance | Monday 07 September 2026  18:14:21 +0000 (0:00:00.067)       0:00:01.159 ******
2026-09-07 18:14:22.266216 | instance | ok: [instance]
2026-09-07 18:14:22.266613 | instance |
2026-09-07 18:14:22.266924 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-07 18:14:22.267221 | instance | Monday 07 September 2026  18:14:22 +0000 (0:00:00.971)       0:00:02.131 ******
2026-09-07 18:14:22.489178 | instance | ok: [instance]
2026-09-07 18:14:22.489411 | instance |
2026-09-07 18:14:22.489631 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-07 18:14:22.489808 | instance |
2026-09-07 18:14:22.489991 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 18:14:22.490174 | instance | Monday 07 September 2026  18:14:22 +0000 (0:00:00.221)       0:00:02.353 ******
2026-09-07 18:14:23.489413 | instance | ok: [instance]
2026-09-07 18:14:23.489783 | instance |
2026-09-07 18:14:23.490992 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 18:14:23.491028 | instance | Monday 07 September 2026  18:14:23 +0000 (0:00:00.998)       0:00:03.351 ******
2026-09-07 18:14:23.817282 | instance | ok: [instance]
2026-09-07 18:14:23.817515 | instance |
2026-09-07 18:14:23.817874 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 18:14:23.818181 | instance | Monday 07 September 2026  18:14:23 +0000 (0:00:00.330)       0:00:03.682 ******
2026-09-07 18:14:23.880492 | instance | skipping: [instance]
2026-09-07 18:14:23.880861 | instance |
2026-09-07 18:14:23.881138 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-07 18:14:23.881409 | instance | Monday 07 September 2026  18:14:23 +0000 (0:00:00.061)       0:00:03.743 ******
2026-09-07 18:14:24.258196 | instance | changed: [instance]
2026-09-07 18:14:24.258622 | instance |
2026-09-07 18:14:24.258958 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 18:14:24.259286 | instance | Monday 07 September 2026  18:14:24 +0000 (0:00:00.379)       0:00:04.123 ******
2026-09-07 18:14:24.359952 | instance | ok: [instance] => {
2026-09-07 18:14:24.360365 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-07 18:14:24.360743 | instance | }
2026-09-07 18:14:24.361050 | instance |
2026-09-07 18:14:24.361373 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 18:14:24.361718 | instance | Monday 07 September 2026  18:14:24 +0000 (0:00:00.101)       0:00:04.225 ******
2026-09-07 18:14:25.080130 | instance | changed: [instance]
2026-09-07 18:14:25.080195 | instance |
2026-09-07 18:14:25.080207 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 18:14:25.080217 | instance | Monday 07 September 2026  18:14:25 +0000 (0:00:00.719)       0:00:04.945 ******
2026-09-07 18:14:25.123954 | instance | skipping: [instance]
2026-09-07 18:14:25.124019 | instance |
2026-09-07 18:14:25.124031 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 18:14:25.124041 | instance | Monday 07 September 2026  18:14:25 +0000 (0:00:00.043)       0:00:04.989 ******
2026-09-07 18:14:25.161698 | instance | skipping: [instance]
2026-09-07 18:14:25.161755 | instance |
2026-09-07 18:14:25.161766 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 18:14:25.161776 | instance | Monday 07 September 2026  18:14:25 +0000 (0:00:00.037)       0:00:05.026 ******
2026-09-07 18:14:25.429492 | instance | ok: [instance]
2026-09-07 18:14:25.429722 | instance |
2026-09-07 18:14:25.429879 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 18:14:25.430025 | instance | Monday 07 September 2026  18:14:25 +0000 (0:00:00.267)       0:00:05.294 ******
2026-09-07 18:14:26.887071 | instance | ok: [instance]
2026-09-07 18:14:26.887415 | instance |
2026-09-07 18:14:26.887763 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 18:14:26.888070 | instance | Monday 07 September 2026  18:14:26 +0000 (0:00:01.457)       0:00:06.752 ******
2026-09-07 18:14:26.980894 | instance | ok: [instance] => {
2026-09-07 18:14:26.981296 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-07 18:14:26.981654 | instance | }
2026-09-07 18:14:26.981978 | instance |
2026-09-07 18:14:26.982295 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 18:14:26.982627 | instance | Monday 07 September 2026  18:14:26 +0000 (0:00:00.093)       0:00:06.846 ******
2026-09-07 18:14:27.757078 | instance | changed: [instance]
2026-09-07 18:14:27.757263 | instance |
2026-09-07 18:14:27.757413 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 18:14:27.757558 | instance | Monday 07 September 2026  18:14:27 +0000 (0:00:00.773)       0:00:07.620 ******
2026-09-07 18:14:30.669582 | instance | changed: [instance]
2026-09-07 18:14:30.670209 | instance |
2026-09-07 18:14:30.670262 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-07 18:14:30.670271 | instance | Monday 07 September 2026  18:14:30 +0000 (0:00:02.914)       0:00:10.534 ******
2026-09-07 18:14:30.713567 | instance | skipping: [instance]
2026-09-07 18:14:30.713676 | instance |
2026-09-07 18:14:30.713989 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-07 18:14:30.714035 | instance | Monday 07 September 2026  18:14:30 +0000 (0:00:00.044)       0:00:10.579 ******
2026-09-07 18:14:30.758085 | instance | skipping: [instance]
2026-09-07 18:14:30.758153 | instance |
2026-09-07 18:14:30.758161 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-07 18:14:30.758168 | instance | Monday 07 September 2026  18:14:30 +0000 (0:00:00.042)       0:00:10.621 ******
2026-09-07 18:14:30.798265 | instance | skipping: [instance]
2026-09-07 18:14:30.798516 | instance |
2026-09-07 18:14:30.798913 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-07 18:14:30.799219 | instance | Monday 07 September 2026  18:14:30 +0000 (0:00:00.041)       0:00:10.663 ******
2026-09-07 18:14:36.986743 | instance | changed: [instance]
2026-09-07 18:14:36.987711 | instance |
2026-09-07 18:14:36.987745 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-07 18:14:36.987760 | instance | Monday 07 September 2026  18:14:36 +0000 (0:00:06.188)       0:00:16.852 ******
2026-09-07 18:14:37.670557 | instance | changed: [instance]
2026-09-07 18:14:37.670720 | instance |
2026-09-07 18:14:37.671274 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-07 18:14:37.671347 | instance | Monday 07 September 2026  18:14:37 +0000 (0:00:00.683)       0:00:17.535 ******
2026-09-07 18:14:38.660133 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-07 18:14:38.660695 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-07 18:14:38.660808 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-07 18:14:38.661900 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-07 18:14:38.661949 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-07 18:14:38.661961 | instance |
2026-09-07 18:14:38.661977 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-07 18:14:38.661987 | instance | Monday 07 September 2026  18:14:38 +0000 (0:00:00.989)       0:00:18.525 ******
2026-09-07 18:14:39.310169 | instance | changed: [instance]
2026-09-07 18:14:39.310209 | instance |
2026-09-07 18:14:39.310217 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-07 18:14:39.310224 | instance | Monday 07 September 2026  18:14:39 +0000 (0:00:00.621)       0:00:19.147 ******
2026-09-07 18:14:39.310229 | instance |
2026-09-07 18:14:39.310235 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 18:14:39.310240 | instance | Monday 07 September 2026  18:14:39 +0000 (0:00:00.028)       0:00:19.175 ******
2026-09-07 18:14:40.268275 | instance | ok: [instance]
2026-09-07 18:14:40.268666 | instance |
2026-09-07 18:14:40.269302 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-07 18:14:40.269360 | instance | Monday 07 September 2026  18:14:40 +0000 (0:00:00.958)       0:00:20.133 ******
2026-09-07 18:14:40.788751 | instance | changed: [instance]
2026-09-07 18:14:40.789581 | instance |
2026-09-07 18:14:40.789616 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-07 18:14:40.789628 | instance | Monday 07 September 2026  18:14:40 +0000 (0:00:00.520)       0:00:20.653 ******
2026-09-07 18:14:41.455895 | instance | changed: [instance]
2026-09-07 18:14:41.455990 | instance |
2026-09-07 18:14:41.456308 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 18:14:41.456355 | instance | Monday 07 September 2026  18:14:41 +0000 (0:00:00.667)       0:00:21.321 ******
2026-09-07 18:14:41.714249 | instance | ok: [instance]
2026-09-07 18:14:41.714779 | instance |
2026-09-07 18:14:41.714846 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 18:14:41.714855 | instance | Monday 07 September 2026  18:14:41 +0000 (0:00:00.257)       0:00:21.579 ******
2026-09-07 18:14:41.789476 | instance | ok: [instance] => {
2026-09-07 18:14:41.789597 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-07 18:14:41.789626 | instance | }
2026-09-07 18:14:41.789640 | instance |
2026-09-07 18:14:41.789875 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 18:14:41.790025 | instance | Monday 07 September 2026  18:14:41 +0000 (0:00:00.075)       0:00:21.655 ******
2026-09-07 18:14:42.701493 | instance | changed: [instance]
2026-09-07 18:14:42.701579 | instance |
2026-09-07 18:14:42.701784 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 18:14:42.701829 | instance | Monday 07 September 2026  18:14:42 +0000 (0:00:00.912)       0:00:22.567 ******
2026-09-07 18:14:47.227181 | instance | changed: [instance]
2026-09-07 18:14:47.227322 | instance |
2026-09-07 18:14:47.227927 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-07 18:14:47.228120 | instance | Monday 07 September 2026  18:14:47 +0000 (0:00:04.524)       0:00:27.092 ******
2026-09-07 18:14:48.380321 | instance | ok: [instance]
2026-09-07 18:14:48.380634 | instance |
2026-09-07 18:14:48.381115 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-07 18:14:48.381149 | instance | Monday 07 September 2026  18:14:48 +0000 (0:00:01.153)       0:00:28.245 ******
2026-09-07 18:14:48.820670 | instance | changed: [instance]
2026-09-07 18:14:48.821371 | instance |
2026-09-07 18:14:48.821424 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-07 18:14:48.821435 | instance | Monday 07 September 2026  18:14:48 +0000 (0:00:00.440)       0:00:28.686 ******
2026-09-07 18:14:49.325917 | instance | changed: [instance]
2026-09-07 18:14:49.326716 | instance |
2026-09-07 18:14:49.326915 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-07 18:14:49.326931 | instance | Monday 07 September 2026  18:14:49 +0000 (0:00:00.505)       0:00:29.191 ******
2026-09-07 18:14:49.938683 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-07 18:14:49.939888 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-07 18:14:49.939940 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-07 18:14:49.939951 | instance |
2026-09-07 18:14:49.939961 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-07 18:14:49.939970 | instance | Monday 07 September 2026  18:14:49 +0000 (0:00:00.612)       0:00:29.804 ******
2026-09-07 18:14:50.436433 | instance | changed: [instance]
2026-09-07 18:14:50.436753 | instance |
2026-09-07 18:14:50.437023 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-07 18:14:50.437271 | instance | Monday 07 September 2026  18:14:50 +0000 (0:00:00.497)       0:00:30.301 ******
2026-09-07 18:14:50.926039 | instance | changed: [instance]
2026-09-07 18:14:50.926289 | instance |
2026-09-07 18:14:50.926561 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-07 18:14:50.926831 | instance | Monday 07 September 2026  18:14:50 +0000 (0:00:00.475)       0:00:30.777 ******
2026-09-07 18:14:50.927062 | instance |
2026-09-07 18:14:50.927325 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 18:14:50.927582 | instance | Monday 07 September 2026  18:14:50 +0000 (0:00:00.014)       0:00:30.792 ******
2026-09-07 18:14:51.721777 | instance | ok: [instance]
2026-09-07 18:14:51.721866 | instance |
2026-09-07 18:14:51.722039 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-07 18:14:51.722201 | instance | Monday 07 September 2026  18:14:51 +0000 (0:00:00.795)       0:00:31.588 ******
2026-09-07 18:14:52.702236 | instance | changed: [instance]
2026-09-07 18:14:52.702441 | instance |
2026-09-07 18:14:52.702701 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-07 18:14:52.703003 | instance | Monday 07 September 2026  18:14:52 +0000 (0:00:00.979)       0:00:32.567 ******
2026-09-07 18:14:53.342270 | instance | changed: [instance]
2026-09-07 18:14:53.342332 | instance |
2026-09-07 18:14:53.342343 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-07 18:14:53.342353 | instance | Monday 07 September 2026  18:14:53 +0000 (0:00:00.639)       0:00:33.206 ******
2026-09-07 18:14:53.407631 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-07 18:14:53.407782 | instance |
2026-09-07 18:14:53.408104 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-07 18:14:53.408144 | instance | Monday 07 September 2026  18:14:53 +0000 (0:00:00.066)       0:00:33.273 ******
2026-09-07 18:14:58.973641 | instance | changed: [instance]
2026-09-07 18:14:58.973697 | instance |
2026-09-07 18:14:58.973709 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-07 18:14:58.973718 | instance | Monday 07 September 2026  18:14:58 +0000 (0:00:05.564)       0:00:38.838 ******
2026-09-07 18:14:59.694005 | instance | ok: [instance] => (item=chronyd)
2026-09-07 18:14:59.695029 | instance | ok: [instance] => (item=sshd)
2026-09-07 18:14:59.695082 | instance |
2026-09-07 18:14:59.695093 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-07 18:14:59.695103 | instance | Monday 07 September 2026  18:14:59 +0000 (0:00:00.721)       0:00:39.559 ******
2026-09-07 18:15:06.729289 | instance | changed: [instance]
2026-09-07 18:15:06.730117 | instance |
2026-09-07 18:15:06.730171 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-07 18:15:06.730183 | instance | Monday 07 September 2026  18:15:06 +0000 (0:00:07.035)       0:00:46.594 ******
2026-09-07 18:15:06.947486 | instance | ok: [instance]
2026-09-07 18:15:06.947536 | instance |
2026-09-07 18:15:06.947547 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-07 18:15:06.947558 | instance | Monday 07 September 2026  18:15:06 +0000 (0:00:00.217)       0:00:46.812 ******
2026-09-07 18:15:07.430440 | instance | changed: [instance]
2026-09-07 18:15:07.430510 | instance |
2026-09-07 18:15:07.430547 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-07 18:15:07.430562 | instance | Monday 07 September 2026  18:15:07 +0000 (0:00:00.482)       0:00:47.294 ******
2026-09-07 18:15:07.801451 | instance | changed: [instance]
2026-09-07 18:15:07.801559 | instance |
2026-09-07 18:15:07.801907 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-07 18:15:07.801950 | instance | Monday 07 September 2026  18:15:07 +0000 (0:00:00.372)       0:00:47.667 ******
2026-09-07 18:15:07.947301 | instance | ok: [instance]
2026-09-07 18:15:07.948050 | instance |
2026-09-07 18:15:07.948108 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-07 18:15:07.948119 | instance | Monday 07 September 2026  18:15:07 +0000 (0:00:00.145)       0:00:47.812 ******
2026-09-07 18:15:08.194343 | instance | ok: [instance] => (item=instance)
2026-09-07 18:15:08.194416 | instance |
2026-09-07 18:15:08.194724 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-07 18:15:08.194880 | instance | Monday 07 September 2026  18:15:08 +0000 (0:00:00.247)       0:00:48.060 ******
2026-09-07 18:15:08.245971 | instance | ok: [instance]
2026-09-07 18:15:08.246051 | instance |
2026-09-07 18:15:08.246116 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-07 18:15:08.246251 | instance | Monday 07 September 2026  18:15:08 +0000 (0:00:00.051)       0:00:48.111 ******
2026-09-07 18:15:08.330777 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-07 18:15:08.330859 | instance |
2026-09-07 18:15:08.330923 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-07 18:15:08.331042 | instance | Monday 07 September 2026  18:15:08 +0000 (0:00:00.084)       0:00:48.196 ******
2026-09-07 18:15:08.656480 | instance | changed: [instance]
2026-09-07 18:15:08.656625 | instance |
2026-09-07 18:15:08.656977 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-07 18:15:08.657014 | instance | Monday 07 September 2026  18:15:08 +0000 (0:00:00.325)       0:00:48.522 ******
2026-09-07 18:15:09.399128 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-07 18:15:09.400467 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-07 18:15:09.400579 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-07 18:15:09.400593 | instance |
2026-09-07 18:15:09.400603 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-07 18:15:09.400612 | instance | Monday 07 September 2026  18:15:09 +0000 (0:00:00.742)       0:00:49.264 ******
2026-09-07 18:16:42.234146 | instance | ok: [instance]
2026-09-07 18:16:42.234236 | instance |
2026-09-07 18:16:42.234572 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-07 18:16:42.234613 | instance | Monday 07 September 2026  18:16:42 +0000 (0:01:32.835)       0:02:22.100 ******
2026-09-07 18:16:42.495811 | instance | changed: [instance]
2026-09-07 18:16:42.496018 | instance |
2026-09-07 18:16:42.496295 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-07 18:16:42.496602 | instance | Monday 07 September 2026  18:16:42 +0000 (0:00:00.261)       0:02:22.361 ******
2026-09-07 18:16:42.578210 | instance | ok: [instance]
2026-09-07 18:16:42.578288 | instance |
2026-09-07 18:16:42.578484 | instance | TASK [Install Ceph host] *******************************************************
2026-09-07 18:16:42.578527 | instance | Monday 07 September 2026  18:16:42 +0000 (0:00:00.083)       0:02:22.444 ******
2026-09-07 18:16:42.667626 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-07 18:16:42.667700 | instance |
2026-09-07 18:16:42.667766 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-07 18:16:42.667873 | instance | Monday 07 September 2026  18:16:42 +0000 (0:00:00.089)       0:02:22.533 ******
2026-09-07 18:16:44.313260 | instance | ok: [instance]
2026-09-07 18:16:44.313321 | instance |
2026-09-07 18:16:44.313336 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-07 18:16:44.313349 | instance | Monday 07 September 2026  18:16:44 +0000 (0:00:01.644)       0:02:24.178 ******
2026-09-07 18:16:44.393915 | instance | ok: [instance] => (item=instance)
2026-09-07 18:16:44.393966 | instance |
2026-09-07 18:16:44.393977 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-07 18:16:44.393987 | instance | Monday 07 September 2026  18:16:44 +0000 (0:00:00.080)       0:02:24.258 ******
2026-09-07 18:16:44.711210 | instance | ok: [instance]
2026-09-07 18:16:44.711465 | instance |
2026-09-07 18:16:44.712154 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-07 18:16:44.712392 | instance | Monday 07 September 2026  18:16:44 +0000 (0:00:00.317)       0:02:24.576 ******
2026-09-07 18:16:47.167687 | instance | ok: [instance]
2026-09-07 18:16:47.167731 | instance |
2026-09-07 18:16:47.167740 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-07 18:16:47.167748 | instance | Monday 07 September 2026  18:16:47 +0000 (0:00:02.455)       0:02:27.032 ******
2026-09-07 18:17:38.154238 | 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-07 18:17:38.155195 | 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_rak4at15/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_rak4at15/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_rak4at15/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_rak4at15/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-07T18:17:37.973+0000 7f1f7e8bb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBh/55qWMF5FCAAFRbnlWcAsMyLBTlyzz9QEi38aHIhGgGMxFC9JxPwZBQ=: Malformed input [buffer:3]\n2026-09-07T18:17:37.973+0000 7f1f7e8bb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T18:17:37.977+0000 7f1f7e8bb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBh/55qWMF5FCAAFRbnlWcAsMyLBTlyzz9QEi38aHIhGgGMxFC9JxPwZBQ=: Malformed input [buffer:3]\n2026-09-07T18:17:37.977+0000 7f1f7e8bb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T18:17:37.977+0000 7f1f7e8bb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBh/55qWMF5FCAAFRbnlWcAsMyLBTlyzz9QEi38aHIhGgGMxFC9JxPwZBQ=: Malformed input [buffer:3]\n2026-09-07T18:17:37.977+0000 7f1f7e8bb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T18:17:37.977+0000 7f1f7e8bb640 -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-07 18:17:38.160656 | instance |
2026-09-07 18:17:38.160712 | instance | PLAY RECAP *********************************************************************
2026-09-07 18:17:38.160724 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-07 18:17:38.160734 | instance |
2026-09-07 18:17:38.160743 | instance | Monday 07 September 2026  18:17:38 +0000 (0:00:50.992)       0:03:18.024 ******
2026-09-07 18:17:38.160751 | instance | ===============================================================================
2026-09-07 18:17:38.160760 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 92.84s
2026-09-07 18:17:38.160768 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.99s
2026-09-07 18:17:38.160777 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 7.04s
2026-09-07 18:17:38.162631 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.19s
2026-09-07 18:17:38.162691 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.56s
2026-09-07 18:17:38.162702 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.52s
2026-09-07 18:17:38.162712 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.91s
2026-09-07 18:17:38.162721 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.46s
2026-09-07 18:17:38.162770 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.75s
2026-09-07 18:17:38.162784 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.64s
2026-09-07 18:17:38.162796 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.46s
2026-09-07 18:17:38.162815 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.15s
2026-09-07 18:17:38.162878 | instance | Gathering Facts --------------------------------------------------------- 1.08s
2026-09-07 18:17:38.163227 | instance | Gathering Facts --------------------------------------------------------- 1.00s
2026-09-07 18:17:38.163525 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.99s
2026-09-07 18:17:38.163873 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.98s
2026-09-07 18:17:38.164201 | instance | Gathering Facts --------------------------------------------------------- 0.97s
2026-09-07 18:17:38.164488 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.91s
2026-09-07 18:17:38.164855 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.77s
2026-09-07 18:17:38.165166 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.74s
2026-09-07 18:17:38.257552 | 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-07 18:17:38.257813 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-07 18:17:38.257985 | 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-07 18:17:38.805394 | instance | ERROR
2026-09-07 18:17:38.805615 | instance | {
2026-09-07 18:17:38.805704 | instance |   "delta": "0:04:11.508040",
2026-09-07 18:17:38.805752 | instance |   "end": "2026-09-07 18:17:38.328475",
2026-09-07 18:17:38.805792 | instance |   "msg": "non-zero return code",
2026-09-07 18:17:38.805831 | instance |   "rc": 2,
2026-09-07 18:17:38.805869 | instance |   "start": "2026-09-07 18:13:26.820435"
2026-09-07 18:17:38.805907 | instance | }
failure
2026-09-07 18:17:38.815996 | 
2026-09-07 18:17:38.816090 | PLAY RECAP
2026-09-07 18:17:38.816163 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-07 18:17:38.816249 | 
2026-09-07 18:17:39.107319 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 18:17:39.114502 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 18:17:39.700735 | 
2026-09-07 18:17:39.700865 | PLAY [all]
2026-09-07 18:17:39.715973 | 
2026-09-07 18:17:39.716102 | TASK [gather-host-logs : creating directory for system status]
2026-09-07 18:17:40.111964 | instance | changed
2026-09-07 18:17:40.118777 | 
2026-09-07 18:17:40.118875 | TASK [gather-host-logs : Get logs for each host]
2026-09-07 18:17:40.493835 | instance | + systemd-cgls --full --all --no-pager
2026-09-07 18:17:40.523577 | instance | + ip addr
2026-09-07 18:17:40.526464 | instance | + ip route
2026-09-07 18:17:40.528944 | instance | + lsblk
2026-09-07 18:17:40.534018 | instance | + mount
2026-09-07 18:17:40.537118 | instance | + docker images
2026-09-07 18:17:40.561119 | instance | + brctl show
2026-09-07 18:17:40.561684 | instance | /bin/bash: line 8: brctl: command not found
2026-09-07 18:17:40.561983 | instance | + ps aux --sort=-%mem
2026-09-07 18:17:40.588370 | instance | + dpkg -l
2026-09-07 18:17:40.600317 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-07 18:17:40.600873 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-07 18:17:40.622791 | instance | + '[' '!' -z '' ']'
2026-09-07 18:17:40.683675 | instance | ok: Runtime: 0:00:00.133715
2026-09-07 18:17:40.692612 | 
2026-09-07 18:17:40.692712 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-07 18:17:41.344457 | instance | changed:
2026-09-07 18:17:41.344693 | instance | created directory /var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/logs/instance
2026-09-07 18:17:41.344747 | instance | cd+++++++++ system/
2026-09-07 18:17:41.344790 | instance | >f+++++++++ system/brctl-show.txt
2026-09-07 18:17:41.344830 | instance | >f+++++++++ system/docker-images.txt
2026-09-07 18:17:41.344868 | instance | >f+++++++++ system/ip-addr.txt
2026-09-07 18:17:41.344908 | instance | >f+++++++++ system/ip-route.txt
2026-09-07 18:17:41.344946 | instance | >f+++++++++ system/lsblk.txt
2026-09-07 18:17:41.344983 | instance | >f+++++++++ system/mount.txt
2026-09-07 18:17:41.345018 | instance | >f+++++++++ system/packages.txt
2026-09-07 18:17:41.345053 | instance | >f+++++++++ system/ps.txt
2026-09-07 18:17:41.345095 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-07 18:17:41.361376 | 
2026-09-07 18:17:41.361528 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-07 18:17:41.587018 | instance | changed: "values"
2026-09-07 18:17:41.730554 | instance | changed: "releases"
2026-09-07 18:17:41.744445 | 
2026-09-07 18:17:41.744686 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-07 18:17:42.013713 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-07 18:17:42.295717 | instance | ok: Runtime: 0:00:00.005878
2026-09-07 18:17:42.305922 | 
2026-09-07 18:17:42.306055 | TASK [helm-release-status : Downloads logs to executor]
2026-09-07 18:17:42.814664 | instance | changed:
2026-09-07 18:17:42.814909 | instance | cd+++++++++ helm/
2026-09-07 18:17:42.814992 | instance | cd+++++++++ helm/releases/
2026-09-07 18:17:42.815052 | instance | cd+++++++++ helm/values/
2026-09-07 18:17:42.834986 | 
2026-09-07 18:17:42.835215 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-07 18:17:43.061373 | instance | changed
2026-09-07 18:17:43.072665 | 
2026-09-07 18:17:43.072821 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-07 18:17:43.333483 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 18:17:43.334246 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 18:17:43.338882 | instance | environment: line 1: kubectl: command not found
2026-09-07 18:17:43.339795 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 18:17:43.342071 | instance | environment: line 1: kubectl: command not found
2026-09-07 18:17:43.343467 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 18:17:43.345283 | instance | environment: line 1: kubectl: command not found
2026-09-07 18:17:43.346550 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 18:17:43.347893 | instance | environment: line 1: kubectl: command not found
2026-09-07 18:17:43.348905 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 18:17:43.349793 | instance | environment: line 1: kubectl: command not found
2026-09-07 18:17:43.351045 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 18:17:43.621744 | instance | ok: Runtime: 0:00:00.024605
2026-09-07 18:17:43.636425 | 
2026-09-07 18:17:43.636560 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-07 18:17:43.846878 | instance | changed
2026-09-07 18:17:43.869508 | 
2026-09-07 18:17:43.869650 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-07 18:17:44.108628 | instance | environment: line 5: kubectl: command not found
2026-09-07 18:17:44.108744 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 18:17:44.109656 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 18:17:44.109834 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 18:17:44.414743 | instance | ok: Runtime: 0:00:00.006880
2026-09-07 18:17:44.424686 | 
2026-09-07 18:17:44.424811 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-07 18:17:44.913304 | instance | changed:
2026-09-07 18:17:44.913539 | instance | cd+++++++++ objects/
2026-09-07 18:17:44.913596 | instance | cd+++++++++ objects/cluster/
2026-09-07 18:17:44.913646 | instance | cd+++++++++ objects/namespaced/
2026-09-07 18:17:44.931646 | 
2026-09-07 18:17:44.931800 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-07 18:17:45.144041 | instance | changed
2026-09-07 18:17:45.149665 | 
2026-09-07 18:17:45.149751 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-07 18:17:45.366914 | instance | changed
2026-09-07 18:17:45.372882 | 
2026-09-07 18:17:45.372977 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-07 18:17:45.622558 | instance | environment: line 3: kubectl: command not found
2026-09-07 18:17:45.910229 | instance | ok: Runtime: 0:00:00.007897
2026-09-07 18:17:45.921136 | 
2026-09-07 18:17:45.921308 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-07 18:17:46.486499 | instance | changed:
2026-09-07 18:17:46.486847 | instance | cd+++++++++ pod-logs/
2026-09-07 18:17:46.486930 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-07 18:17:46.506523 | 
2026-09-07 18:17:46.506682 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-07 18:17:46.773551 | instance | changed
2026-09-07 18:17:46.782658 | 
2026-09-07 18:17:46.782811 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-07 18:17:47.015311 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 18:17:47.331811 | instance | ok: Runtime: 0:00:00.050194
2026-09-07 18:17:47.341446 | 
2026-09-07 18:17:47.341581 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-07 18:17:47.584615 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 18:17:47.615721 | instance | ceph-mgr endpoints:
2026-09-07 18:17:47.887582 | instance | ok: Runtime: 0:00:00.036545
2026-09-07 18:17:47.897955 | 
2026-09-07 18:17:47.898102 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-07 18:17:48.148368 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-07 18:17:48.439840 | instance | ok: Runtime: 0:00:00.053333
2026-09-07 18:17:48.450037 | 
2026-09-07 18:17:48.450168 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-07 18:17:48.947374 | instance | changed: cd+++++++++ prometheus/
2026-09-07 18:17:48.967877 | 
2026-09-07 18:17:48.968049 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-07 18:17:49.184236 | instance | changed
2026-09-07 18:17:49.190036 | 
2026-09-07 18:17:49.190122 | TASK [gather-selenium-data : Get selenium data]
2026-09-07 18:17:49.421241 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-07 18:17:49.422636 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-07 18:17:49.727291 | instance | ERROR
2026-09-07 18:17:49.727491 | instance | {
2026-09-07 18:17:49.727551 | instance |   "delta": "0:00:00.005487",
2026-09-07 18:17:49.727592 | instance |   "end": "2026-09-07 18:17:49.422984",
2026-09-07 18:17:49.727634 | instance |   "msg": "non-zero return code",
2026-09-07 18:17:49.727672 | instance |   "rc": 1,
2026-09-07 18:17:49.727709 | instance |   "start": "2026-09-07 18:17:49.417497"
2026-09-07 18:17:49.727744 | instance | }
2026-09-07 18:17:49.727788 | instance | ERROR: Ignoring Errors
2026-09-07 18:17:49.737287 | 
2026-09-07 18:17:49.737418 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-07 18:17:50.257435 | instance | changed: cd+++++++++ selenium/
2026-09-07 18:17:50.268310 | 
2026-09-07 18:17:50.268448 | PLAY RECAP
2026-09-07 18:17:50.268570 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-07 18:17:50.268622 | 
2026-09-07 18:17:50.384198 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 18:17:50.388282 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 18:17:51.049790 | 
2026-09-07 18:17:51.049908 | PLAY [all]
2026-09-07 18:17:51.061086 | 
2026-09-07 18:17:51.061194 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-07 18:17:51.114884 | instance | skipping: Conditional result was False
2026-09-07 18:17:51.121518 | 
2026-09-07 18:17:51.121617 | TASK [fetch-output : Set log path for single node]
2026-09-07 18:17:51.163483 | instance | ok
2026-09-07 18:17:51.172351 | 
2026-09-07 18:17:51.172491 | LOOP [fetch-output : Ensure local output dirs]
2026-09-07 18:17:51.555330 | instance -> localhost | ok: "/var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/logs"
2026-09-07 18:17:51.764851 | instance -> localhost | changed: "/var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/artifacts"
2026-09-07 18:17:51.979748 | instance -> localhost | changed: "/var/lib/zuul/builds/6b060e8364874c10a5d4897873dded37/work/docs"
2026-09-07 18:17:51.995104 | 
2026-09-07 18:17:51.995351 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-07 18:17:52.703989 | instance | changed: .d..t...... ./
2026-09-07 18:17:52.704324 | instance | changed: All items complete
2026-09-07 18:17:52.704383 | 
2026-09-07 18:17:53.183362 | instance | changed: .d..t...... ./
2026-09-07 18:17:53.682093 | instance | changed: .d..t...... ./
2026-09-07 18:17:53.709915 | 
2026-09-07 18:17:53.710143 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-07 18:17:54.156268 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006723
2026-09-07 18:17:54.391633 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007654
2026-09-07 18:17:54.409231 | 
2026-09-07 18:17:54.409397 | PLAY [all]
2026-09-07 18:17:54.416883 | 
2026-09-07 18:17:54.416969 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-07 18:17:54.845291 | instance | changed
2026-09-07 18:17:54.858293 | 
2026-09-07 18:17:54.858388 | PLAY RECAP
2026-09-07 18:17:54.858476 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-07 18:17:54.858518 | 
2026-09-07 18:17:55.051845 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 18:17:55.055748 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-07 18:17:55.619475 | 
2026-09-07 18:17:55.619594 | PLAY [localhost]
2026-09-07 18:17:55.628840 | 
2026-09-07 18:17:55.628911 | TASK [Generate Zuul manifest]
2026-09-07 18:17:55.644629 | localhost | ok
2026-09-07 18:17:55.660047 | 
2026-09-07 18:17:55.660134 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-07 18:17:56.043956 | localhost | changed
2026-09-07 18:17:56.067455 | 
2026-09-07 18:17:56.067611 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-07 18:17:56.096653 | localhost | ok
2026-09-07 18:17:56.112742 | 
2026-09-07 18:17:56.112889 | TASK [Upload logs]
2026-09-07 18:17:56.136624 | localhost | ok
2026-09-07 18:17:56.222759 | 
2026-09-07 18:17:56.223082 | TASK [Set zuul-log-path fact]
2026-09-07 18:17:56.241513 | localhost | ok
2026-09-07 18:17:56.256410 | 
2026-09-07 18:17:56.256520 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 18:17:56.285892 | localhost | ok
2026-09-07 18:17:56.296141 | 
2026-09-07 18:17:56.296323 | TASK [upload-logs : Create log directories]
2026-09-07 18:17:56.729299 | localhost | changed
2026-09-07 18:17:56.733534 | 
2026-09-07 18:17:56.733611 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-07 18:17:57.150526 | localhost -> localhost | ok: Runtime: 0:00:00.005611
2026-09-07 18:17:57.162261 | 
2026-09-07 18:17:57.162431 | TASK [upload-logs : Upload logs to log server]
2026-09-07 18:17:57.681942 | localhost | Output suppressed because no_log was given
2026-09-07 18:17:57.724847 | 
2026-09-07 18:17:57.724986 | LOOP [upload-logs : Compress console log and json output]
2026-09-07 18:17:57.782953 | localhost | skipping: Conditional result was False
2026-09-07 18:17:57.793452 | localhost | skipping: Conditional result was False
2026-09-07 18:17:57.807356 | 
2026-09-07 18:17:57.807582 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-07 18:17:57.852151 | localhost | skipping: Conditional result was False
2026-09-07 18:17:57.852835 | 
2026-09-07 18:17:57.858644 | localhost | skipping: Conditional result was False
2026-09-07 18:17:57.871047 | 
2026-09-07 18:17:57.871279 | LOOP [upload-logs : Upload console log and json output]