2026-08-24 15:36:27.161584 | Job console starting
2026-08-24 15:36:27.179675 | Updating git repos
2026-08-24 15:36:29.261180 | Cloning repos into workspace
2026-08-24 15:36:45.447975 | Restoring repo states
2026-08-24 15:36:54.856944 | Merging changes
2026-08-24 15:36:56.352210 | Checking out repos
2026-08-24 15:36:58.835775 | Preparing playbooks
2026-08-24 15:37:04.312376 | Running Ansible setup
2026-08-24 15:37:08.667535 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:37:09.694665 | 
2026-08-24 15:37:09.953703 | PLAY [localhost]
2026-08-24 15:37:09.967822 | 
2026-08-24 15:37:09.967949 | TASK [Gathering Facts]
2026-08-24 15:37:10.928596 | localhost | ok
2026-08-24 15:37:10.939879 | 
2026-08-24 15:37:10.940009 | TASK [Setup log path fact]
2026-08-24 15:37:10.963051 | localhost | ok
2026-08-24 15:37:10.978228 | 
2026-08-24 15:37:10.978332 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:37:11.007024 | localhost | ok
2026-08-24 15:37:11.016243 | 
2026-08-24 15:37:11.016352 | TASK [emit-job-header : Print job information]
2026-08-24 15:37:11.057112 | # Job Information
2026-08-24 15:37:11.057306 | Ansible Version: 2.16.18
2026-08-24 15:37:11.057362 | Job: atmosphere-molecule-csi-rbd
2026-08-24 15:37:11.057407 | Pipeline: check
2026-08-24 15:37:11.057449 | Executor: 2d72f0692154
2026-08-24 15:37:11.057483 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092
2026-08-24 15:37:11.057530 | Event ID: 573cb900-9fcf-11f1-878c-1e7e1ba02d76
2026-08-24 15:37:11.061709 | 
2026-08-24 15:37:11.061801 | LOOP [emit-job-header : Print node information]
2026-08-24 15:37:11.156386 | localhost | ok:
2026-08-24 15:37:11.156524 | localhost | # Node Information
2026-08-24 15:37:11.156553 | localhost | Inventory Hostname: instance
2026-08-24 15:37:11.156577 | localhost | Hostname: np0000190919
2026-08-24 15:37:11.156597 | localhost | Username: zuul
2026-08-24 15:37:11.156621 | localhost | Distro: Ubuntu 22.04
2026-08-24 15:37:11.156641 | localhost | Provider: yul1
2026-08-24 15:37:11.156661 | localhost | Region: ca-ymq-1
2026-08-24 15:37:11.156680 | localhost | Label: ubuntu-jammy
2026-08-24 15:37:11.156698 | localhost | Product Name: OpenStack Nova
2026-08-24 15:37:11.156716 | localhost | Interface IP: 199.19.213.200
2026-08-24 15:37:11.165233 | 
2026-08-24 15:37:11.165366 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 15:37:11.662243 | localhost -> localhost | changed
2026-08-24 15:37:11.669537 | 
2026-08-24 15:37:11.669666 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 15:37:12.729550 | localhost -> localhost | changed
2026-08-24 15:37:12.737619 | 
2026-08-24 15:37:12.737716 | PLAY [all]
2026-08-24 15:37:12.747901 | 
2026-08-24 15:37:12.748001 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 15:37:12.995342 | instance -> localhost | ok
2026-08-24 15:37:13.007919 | 
2026-08-24 15:37:13.008042 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 15:37:13.043798 | instance | ok
2026-08-24 15:37:13.059850 | instance | included: /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 15:37:13.066834 | 
2026-08-24 15:37:13.066900 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 15:37:13.871248 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 15:37:13.871399 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/5095d405202b4119b003f47c51630216_id_rsa
2026-08-24 15:37:13.871432 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/5095d405202b4119b003f47c51630216_id_rsa.pub
2026-08-24 15:37:13.871456 | instance -> localhost | The key fingerprint is:
2026-08-24 15:37:13.871480 | instance -> localhost | SHA256:xs8wVK1OgI4vFvPIBEtwcx2DopaRlzPYzC3v2S4OtLk zuul-build-sshkey
2026-08-24 15:37:13.871514 | instance -> localhost | The key's randomart image is:
2026-08-24 15:37:13.871538 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 15:37:13.871565 | instance -> localhost | |..O +ooo  ..     |
2026-08-24 15:37:13.871588 | instance -> localhost | | =+%..o...  .    |
2026-08-24 15:37:13.871611 | instance -> localhost | | o++=o  .. .     |
2026-08-24 15:37:13.871634 | instance -> localhost | |.o. =..o  o      |
2026-08-24 15:37:13.871656 | instance -> localhost | |.  +.*o So       |
2026-08-24 15:37:13.871679 | instance -> localhost | |  . Booo =.      |
2026-08-24 15:37:13.871700 | instance -> localhost | |   = ..   o      |
2026-08-24 15:37:13.871722 | instance -> localhost | |    o. .         |
2026-08-24 15:37:13.871746 | instance -> localhost | |   E...          |
2026-08-24 15:37:13.871769 | instance -> localhost | +----[SHA256]-----+
2026-08-24 15:37:13.871829 | instance -> localhost | ok: Runtime: 0:00:00.405615
2026-08-24 15:37:13.880480 | 
2026-08-24 15:37:13.880599 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 15:37:13.915869 | instance | ok
2026-08-24 15:37:13.926432 | instance | included: /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 15:37:13.936268 | 
2026-08-24 15:37:13.936411 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 15:37:13.962188 | instance | skipping: Conditional result was False
2026-08-24 15:37:13.970073 | 
2026-08-24 15:37:13.970179 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 15:37:14.398024 | instance | changed
2026-08-24 15:37:14.404645 | 
2026-08-24 15:37:14.404716 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 15:37:14.577546 | instance | ok
2026-08-24 15:37:14.586773 | 
2026-08-24 15:37:14.586929 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 15:37:15.072120 | instance | changed
2026-08-24 15:37:15.080521 | 
2026-08-24 15:37:15.080642 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 15:37:15.589599 | instance | changed
2026-08-24 15:37:15.597874 | 
2026-08-24 15:37:15.597948 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 15:37:15.620886 | instance | skipping: Conditional result was False
2026-08-24 15:37:15.628383 | 
2026-08-24 15:37:15.628457 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 15:37:16.050158 | instance -> localhost | changed
2026-08-24 15:37:16.067837 | 
2026-08-24 15:37:16.068000 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 15:37:16.349336 | instance -> localhost | Identity added: /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/5095d405202b4119b003f47c51630216_id_rsa (zuul-build-sshkey)
2026-08-24 15:37:16.349528 | instance -> localhost | ok: Runtime: 0:00:00.013626
2026-08-24 15:37:16.366205 | 
2026-08-24 15:37:16.366875 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 15:37:16.687317 | instance | ok
2026-08-24 15:37:16.692426 | 
2026-08-24 15:37:16.692502 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 15:37:16.716617 | instance | skipping: Conditional result was False
2026-08-24 15:37:16.731704 | 
2026-08-24 15:37:16.731834 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 15:37:17.077512 | instance | ok
2026-08-24 15:37:17.084387 | 
2026-08-24 15:37:17.084471 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 15:37:20.467505 | instance | Output suppressed because no_log was given
2026-08-24 15:37:20.479005 | 
2026-08-24 15:37:20.479127 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 15:37:20.679076 | instance | ok: "logs"
2026-08-24 15:37:20.679320 | instance | ok: All items complete
2026-08-24 15:37:20.679359 | 
2026-08-24 15:37:20.825220 | instance | ok: "artifacts"
2026-08-24 15:37:20.984834 | instance | ok: "docs"
2026-08-24 15:37:21.006700 | 
2026-08-24 15:37:21.006847 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 15:37:21.199473 | instance | changed: "logs"
2026-08-24 15:37:21.363121 | instance | changed: "artifacts"
2026-08-24 15:37:21.540456 | instance | changed: "docs"
2026-08-24 15:37:21.561863 | 
2026-08-24 15:37:21.562024 | PLAY RECAP
2026-08-24 15:37:21.562104 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 15:37:21.562151 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:37:21.562193 | 
2026-08-24 15:37:21.780340 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:37:21.822269 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:37:22.548355 | 
2026-08-24 15:37:22.548462 | PLAY [all]
2026-08-24 15:37:22.558465 | 
2026-08-24 15:37:22.558542 | TASK [setup-uv : Extract archive]
2026-08-24 15:37:24.843694 | instance | changed
2026-08-24 15:37:24.852240 | 
2026-08-24 15:37:24.852377 | TASK [setup-uv : Print version]
2026-08-24 15:37:25.223993 | instance | uv 0.8.13
2026-08-24 15:37:25.399999 | instance | ok: Runtime: 0:00:00.008314
2026-08-24 15:37:25.410680 | 
2026-08-24 15:37:25.410801 | TASK [Install Ansible collection siblings]
2026-08-24 15:37:34.624169 | instance | changed:
2026-08-24 15:37:34.624391 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 15:37:34.624425 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 15:37:34.624449 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 15:37:34.624472 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 15:37:34.624492 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 15:37:34.624518 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 15:37:34.624540 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 15:37:34.624563 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 15:37:34.624584 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 15:37:34.624604 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 15:37:34.624624 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 15:37:34.624644 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 15:37:34.624662 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 15:37:34.624681 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 15:37:34.624701 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 15:37:34.624721 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 15:37:34.625815 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 15:37:34.625859 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 15:37:34.625882 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 15:37:34.625903 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 15:37:34.625923 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-24 15:37:34.625992 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 15:37:34.626032 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:37:34.626070 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 15:37:34.626091 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 15:37:34.626110 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:37:34.626129 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:37:34.626148 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:37:34.626167 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 15:37:34.626186 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 15:37:34.626204 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:37:34.626225 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:37:34.626244 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 15:37:34.626263 | 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-08-24 15:37:34.626289 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.626309 | instance | Process install dependency map
2026-08-24 15:37:34.626328 | instance | Starting collection install process
2026-08-24 15:37:34.626348 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 15:37:34.626366 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 15:37:34.626385 | instance | ansible.netcommon:* was installed successfully
2026-08-24 15:37:34.626403 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 15:37:34.626421 | instance | Creating virtual environment at: .venv
2026-08-24 15:37:34.626440 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:37:34.626458 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 15:37:34.626477 | instance | Downloading netaddr (2.2MiB)
2026-08-24 15:37:34.626495 | instance | Downloading setuptools (1.1MiB)
2026-08-24 15:37:34.626514 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 15:37:34.626532 | instance | Downloading cryptography (4.2MiB)
2026-08-24 15:37:34.626551 | instance | Downloading pygments (1.2MiB)
2026-08-24 15:37:34.626569 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 15:37:34.626588 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 15:37:34.626607 | instance |    Building pyperclip==1.9.0
2026-08-24 15:37:34.626625 | instance |  Downloading rjsonnet
2026-08-24 15:37:34.626645 | instance |  Downloading netaddr
2026-08-24 15:37:34.626665 | instance |  Downloading pygments
2026-08-24 15:37:34.626684 | instance |  Downloading cryptography
2026-08-24 15:37:34.626703 | instance |  Downloading setuptools
2026-08-24 15:37:34.626721 | instance |  Downloading kubernetes
2026-08-24 15:37:34.626739 | instance |  Downloading ansible-core
2026-08-24 15:37:34.626756 | instance |  Downloading openstacksdk
2026-08-24 15:37:34.626774 | instance |       Built pyperclip==1.9.0
2026-08-24 15:37:34.626793 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:37:34.626812 | instance | Installed 79 packages in 37ms
2026-08-24 15:37:34.626831 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 15:37:34.626850 | 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-08-24 15:37:34.626868 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.626887 | instance | Process install dependency map
2026-08-24 15:37:34.626905 | instance | Starting collection install process
2026-08-24 15:37:34.626924 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 15:37:34.626949 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 15:37:34.626969 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 15:37:34.626987 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.627006 | instance | 2.17.12
2026-08-24 15:37:34.627026 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 15:37:34.627045 | 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-08-24 15:37:34.627064 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.627083 | instance | Process install dependency map
2026-08-24 15:37:34.627101 | instance | Starting collection install process
2026-08-24 15:37:34.627122 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 15:37:34.627140 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 15:37:34.627159 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 15:37:34.627179 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.627199 | instance | 2.17.12
2026-08-24 15:37:34.627219 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 15:37:34.627238 | 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-08-24 15:37:34.627257 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.627277 | instance | Process install dependency map
2026-08-24 15:37:34.627296 | instance | Starting collection install process
2026-08-24 15:37:34.627315 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 15:37:34.627334 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 15:37:34.627354 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 15:37:34.627373 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.627392 | instance | 2.17.12
2026-08-24 15:37:34.627412 | instance | Checked out community.crypto to 2.2.3
2026-08-24 15:37:34.627432 | 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-08-24 15:37:34.627451 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.627471 | instance | Process install dependency map
2026-08-24 15:37:34.627490 | instance | Starting collection install process
2026-08-24 15:37:34.627510 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 15:37:34.627529 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 15:37:34.627549 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 15:37:34.627593 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.627617 | instance | 2.17.12
2026-08-24 15:37:34.627636 | instance | Checked out community.general to 7.3.0
2026-08-24 15:37:34.627655 | 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-08-24 15:37:34.627674 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.627701 | instance | Process install dependency map
2026-08-24 15:37:34.627721 | instance | Starting collection install process
2026-08-24 15:37:34.627740 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 15:37:34.627758 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 15:37:34.627777 | instance | community.general:7.3.0 was installed successfully
2026-08-24 15:37:34.627795 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.627814 | instance | 2.17.12
2026-08-24 15:37:34.627833 | instance | Checked out community.mysql to 3.6.0
2026-08-24 15:37:34.627852 | 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-08-24 15:37:34.627871 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.627892 | instance | Process install dependency map
2026-08-24 15:37:34.627912 | instance | Starting collection install process
2026-08-24 15:37:34.627931 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 15:37:34.627950 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 15:37:34.627968 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 15:37:34.627988 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628006 | instance | 2.17.12
2026-08-24 15:37:34.628025 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 15:37:34.628045 | 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-08-24 15:37:34.628063 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.628082 | instance | Process install dependency map
2026-08-24 15:37:34.628101 | instance | Starting collection install process
2026-08-24 15:37:34.628119 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 15:37:34.628139 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 15:37:34.628157 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 15:37:34.628176 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628195 | instance | 2.17.12
2026-08-24 15:37:34.628213 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 15:37:34.628232 | 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-08-24 15:37:34.628250 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.628269 | instance | Process install dependency map
2026-08-24 15:37:34.628287 | instance | Starting collection install process
2026-08-24 15:37:34.628305 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 15:37:34.628323 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 15:37:34.628341 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 15:37:34.628360 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628378 | instance | 2.17.12
2026-08-24 15:37:34.628397 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 15:37:34.628415 | 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-08-24 15:37:34.628440 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.628459 | instance | Process install dependency map
2026-08-24 15:37:34.628478 | instance | Starting collection install process
2026-08-24 15:37:34.628497 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 15:37:34.628516 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 15:37:34.628535 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 15:37:34.628555 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628574 | instance | 2.17.12
2026-08-24 15:37:34.628594 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 15:37:34.628613 | 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-08-24 15:37:34.628632 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.628651 | instance | Process install dependency map
2026-08-24 15:37:34.628669 | instance | Starting collection install process
2026-08-24 15:37:34.628687 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 15:37:34.628705 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 15:37:34.628724 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 15:37:34.628742 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628760 | instance | 2.17.12
2026-08-24 15:37:34.628779 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 15:37:34.628797 | 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-08-24 15:37:34.628815 | instance | Starting galaxy collection install process
2026-08-24 15:37:34.628834 | instance | Process install dependency map
2026-08-24 15:37:34.628852 | instance | Starting collection install process
2026-08-24 15:37:34.628870 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 15:37:34.628889 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 15:37:34.628908 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 15:37:34.628926 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:37:34.628944 | instance | 2.17.12
2026-08-24 15:37:34.643097 | 
2026-08-24 15:37:34.643281 | PLAY RECAP
2026-08-24 15:37:34.643339 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:37:34.643363 | 
2026-08-24 15:37:34.793825 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:37:34.827152 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:37:35.490207 | 
2026-08-24 15:37:35.490348 | PLAY [all]
2026-08-24 15:37:35.502768 | 
2026-08-24 15:37:35.502892 | TASK [Install "jq" for log collection]
2026-08-24 15:38:15.026799 | instance | changed
2026-08-24 15:38:15.029204 | 
2026-08-24 15:38:15.029280 | PLAY RECAP
2026-08-24 15:38:15.029350 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:38:15.029415 | 
2026-08-24 15:38:15.146394 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:38:15.150719 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:38:16.131384 | 
2026-08-24 15:38:16.131532 | PLAY [all]
2026-08-24 15:38:16.143028 | 
2026-08-24 15:38:16.143151 | LOOP [Check inventory directories]
2026-08-24 15:38:16.478583 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 15:38:16.630789 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 15:38:16.782475 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 15:38:16.799650 | 
2026-08-24 15:38:16.799927 | LOOP [Copy inventory file for Zuul]
2026-08-24 15:38:17.564007 | instance | changed:
2026-08-24 15:38:17.564256 | instance | {
2026-08-24 15:38:17.564288 | instance |   "ansible_loop_var": "item",
2026-08-24 15:38:17.564312 | instance |   "changed": false,
2026-08-24 15:38:17.564331 | instance |   "failed": false,
2026-08-24 15:38:17.564357 | instance |   "invocation": {
2026-08-24 15:38:17.564376 | instance |     "module_args": {
2026-08-24 15:38:17.564395 | instance |       "checksum_algorithm": "sha1",
2026-08-24 15:38:17.564413 | instance |       "follow": true,
2026-08-24 15:38:17.564433 | instance |       "get_attributes": true,
2026-08-24 15:38:17.564459 | instance |       "get_checksum": true,
2026-08-24 15:38:17.564483 | instance |       "get_mime": true,
2026-08-24 15:38:17.564506 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 15:38:17.564529 | instance |     }
2026-08-24 15:38:17.564551 | instance |   },
2026-08-24 15:38:17.564574 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:38:17.564596 | instance |   "stat": {
2026-08-24 15:38:17.564618 | instance |     "atime": 1787585847.294126,
2026-08-24 15:38:17.564640 | instance |     "attr_flags": "e",
2026-08-24 15:38:17.564661 | instance |     "attributes": [
2026-08-24 15:38:17.564682 | instance |       "extents"
2026-08-24 15:38:17.564704 | instance |     ],
2026-08-24 15:38:17.564725 | instance |     "block_size": 4096,
2026-08-24 15:38:17.564747 | instance |     "blocks": 8,
2026-08-24 15:38:17.564769 | instance |     "charset": "unknown",
2026-08-24 15:38:17.564792 | instance |     "ctime": 1787585846.1981153,
2026-08-24 15:38:17.564814 | instance |     "dev": 64513,
2026-08-24 15:38:17.564841 | instance |     "device_type": 0,
2026-08-24 15:38:17.564868 | instance |     "executable": true,
2026-08-24 15:38:17.564894 | instance |     "exists": true,
2026-08-24 15:38:17.564921 | instance |     "gid": 1000,
2026-08-24 15:38:17.564947 | instance |     "gr_name": "zuul",
2026-08-24 15:38:17.564997 | instance |     "inode": 1048259,
2026-08-24 15:38:17.565020 | instance |     "isblk": false,
2026-08-24 15:38:17.565043 | instance |     "ischr": false,
2026-08-24 15:38:17.565065 | instance |     "isdir": true,
2026-08-24 15:38:17.565086 | instance |     "isfifo": false,
2026-08-24 15:38:17.565108 | instance |     "isgid": false,
2026-08-24 15:38:17.565129 | instance |     "islnk": false,
2026-08-24 15:38:17.565150 | instance |     "isreg": false,
2026-08-24 15:38:17.565171 | instance |     "issock": false,
2026-08-24 15:38:17.565192 | instance |     "isuid": false,
2026-08-24 15:38:17.565213 | instance |     "mimetype": "unknown",
2026-08-24 15:38:17.565235 | instance |     "mode": "0755",
2026-08-24 15:38:17.565259 | instance |     "mtime": 1787585846.1981153,
2026-08-24 15:38:17.565284 | instance |     "nlink": 21,
2026-08-24 15:38:17.565308 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:38:17.565332 | instance |     "pw_name": "zuul",
2026-08-24 15:38:17.565356 | instance |     "readable": true,
2026-08-24 15:38:17.565376 | instance |     "rgrp": true,
2026-08-24 15:38:17.565394 | instance |     "roth": true,
2026-08-24 15:38:17.565413 | instance |     "rusr": true,
2026-08-24 15:38:17.565431 | instance |     "size": 4096,
2026-08-24 15:38:17.565448 | instance |     "uid": 1000,
2026-08-24 15:38:17.565476 | instance |     "version": "1151252783",
2026-08-24 15:38:17.565496 | instance |     "wgrp": false,
2026-08-24 15:38:17.565516 | instance |     "woth": false,
2026-08-24 15:38:17.565535 | instance |     "writeable": true,
2026-08-24 15:38:17.565554 | instance |     "wusr": true,
2026-08-24 15:38:17.565571 | instance |     "xgrp": true,
2026-08-24 15:38:17.565588 | instance |     "xoth": true,
2026-08-24 15:38:17.565605 | instance |     "xusr": true
2026-08-24 15:38:17.565623 | instance |   }
2026-08-24 15:38:17.565641 | instance | }
2026-08-24 15:38:17.565677 | instance | ok: All items complete
2026-08-24 15:38:17.565699 | 
2026-08-24 15:38:17.572618 | instance | skipping: Conditional result was False
2026-08-24 15:38:17.573390 | instance | skipping: Conditional result was False
2026-08-24 15:38:17.594277 | 
2026-08-24 15:38:17.594405 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 15:38:17.940044 | instance | changed: 1 replacements made
2026-08-24 15:38:17.950337 | instance | skipping: Conditional result was False
2026-08-24 15:38:17.958848 | instance | skipping: Conditional result was False
2026-08-24 15:38:17.984514 | 
2026-08-24 15:38:17.984653 | TASK [Run Molecule scenario]
2026-08-24 15:38:18.991117 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 15:38:19.384060 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 15:38:19.384124 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 15:38:30.454076 | instance | INFO     [csi > dependency] Executing
2026-08-24 15:38:30.454175 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 15:38:30.454426 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 15:38:30.454537 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 15:38:30.462050 | instance | INFO     [csi > cleanup] Executing
2026-08-24 15:38:30.462390 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:38:30.470175 | instance | INFO     [csi > destroy] Executing
2026-08-24 15:38:30.470219 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 15:38:30.470337 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 15:38:30.477693 | instance | INFO     [csi > syntax] Executing
2026-08-24 15:38:32.088864 | instance |
2026-08-24 15:38:32.089170 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 15:38:32.152470 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 15:38:32.165539 | instance | INFO     [csi > create] Executing
2026-08-24 15:38:32.168149 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:38:32.175874 | instance | INFO     [csi > prepare] Executing
2026-08-24 15:38:32.983082 | instance |
2026-08-24 15:38:32.983312 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 15:38:32.983521 | instance |
2026-08-24 15:38:32.983700 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:38:32.983904 | instance | Monday 24 August 2026  15:38:32 +0000 (0:00:00.026)       0:00:00.026 *********
2026-08-24 15:38:34.130080 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:38:34.130355 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:38:34.130661 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:38:34.130995 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:38:34.131339 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:38:34.137832 | instance | ok: [instance]
2026-08-24 15:38:34.138170 | instance |
2026-08-24 15:38:34.138429 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 15:38:34.138696 | instance | Monday 24 August 2026  15:38:34 +0000 (0:00:01.155)       0:00:01.181 *********
2026-08-24 15:38:34.806220 | instance | changed: [instance]
2026-08-24 15:38:34.806521 | instance |
2026-08-24 15:38:34.806729 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 15:38:34.807000 | instance | Monday 24 August 2026  15:38:34 +0000 (0:00:00.667)       0:00:01.849 *********
2026-08-24 15:38:35.061664 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 15:38:35.062009 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 15:38:35.062381 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 15:38:35.069639 | instance | changed: [instance]
2026-08-24 15:38:35.069793 | instance |
2026-08-24 15:38:35.070016 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 15:38:35.070207 | instance | Monday 24 August 2026  15:38:35 +0000 (0:00:00.263)       0:00:02.113 *********
2026-08-24 15:38:35.915803 | instance | ok: [instance]
2026-08-24 15:38:35.915968 | instance |
2026-08-24 15:38:35.916241 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 15:38:35.916518 | instance |
2026-08-24 15:38:35.916789 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:38:35.917107 | instance | Monday 24 August 2026  15:38:35 +0000 (0:00:00.846)       0:00:02.959 *********
2026-08-24 15:38:36.596023 | instance | ok: [instance]
2026-08-24 15:38:36.596245 | instance |
2026-08-24 15:38:36.596525 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 15:38:36.596810 | instance | Monday 24 August 2026  15:38:36 +0000 (0:00:00.679)       0:00:03.639 *********
2026-08-24 15:38:57.628000 | instance | changed: [instance]
2026-08-24 15:38:57.628219 | instance |
2026-08-24 15:38:57.628516 | instance | TASK [Start up service] ********************************************************
2026-08-24 15:38:57.628798 | instance | Monday 24 August 2026  15:38:57 +0000 (0:00:21.031)       0:00:24.671 *********
2026-08-24 15:38:58.194618 | instance | ok: [instance]
2026-08-24 15:38:58.194706 | instance |
2026-08-24 15:38:58.194828 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 15:38:58.194959 | instance | Monday 24 August 2026  15:38:58 +0000 (0:00:00.567)       0:00:25.238 *********
2026-08-24 15:38:58.485057 | instance | ok: [instance]
2026-08-24 15:38:58.485279 | instance |
2026-08-24 15:38:58.485545 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 15:38:58.485804 | instance | Monday 24 August 2026  15:38:58 +0000 (0:00:00.290)       0:00:25.528 *********
2026-08-24 15:38:59.115638 | instance | changed: [instance]
2026-08-24 15:38:59.115957 | instance |
2026-08-24 15:38:59.116310 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 15:38:59.116684 | instance | Monday 24 August 2026  15:38:59 +0000 (0:00:00.630)       0:00:26.158 *********
2026-08-24 15:38:59.310901 | instance | ok: [instance]
2026-08-24 15:38:59.311135 | instance |
2026-08-24 15:38:59.311440 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 15:38:59.311822 | instance | Monday 24 August 2026  15:38:59 +0000 (0:00:00.195)       0:00:26.354 *********
2026-08-24 15:38:59.332764 | instance | skipping: [instance]
2026-08-24 15:38:59.332841 | instance |
2026-08-24 15:38:59.332972 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 15:38:59.333143 | instance | Monday 24 August 2026  15:38:59 +0000 (0:00:00.022)       0:00:26.376 *********
2026-08-24 15:38:59.858415 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:38:59.858615 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:38:59.858843 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:38:59.859054 | instance |
2026-08-24 15:38:59.859276 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 15:38:59.859509 | instance | Monday 24 August 2026  15:38:59 +0000 (0:00:00.525)       0:00:26.901 *********
2026-08-24 15:39:00.450381 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:39:00.451288 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:39:00.451337 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:39:00.451345 | instance |
2026-08-24 15:39:00.451352 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 15:39:00.451358 | instance | Monday 24 August 2026  15:39:00 +0000 (0:00:00.592)       0:00:27.493 *********
2026-08-24 15:39:01.130735 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:39:01.130810 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:39:01.131291 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:39:01.131331 | instance |
2026-08-24 15:39:01.131337 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 15:39:01.131342 | instance | Monday 24 August 2026  15:39:01 +0000 (0:00:00.680)       0:00:28.174 *********
2026-08-24 15:39:04.286398 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:39:04.286465 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:39:04.286594 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:39:04.286712 | instance |
2026-08-24 15:39:04.286836 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 15:39:04.286978 | instance | Monday 24 August 2026  15:39:04 +0000 (0:00:03.155)       0:00:31.329 *********
2026-08-24 15:39:06.133181 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 15:39:06.133481 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 15:39:06.133804 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 15:39:06.134173 | instance |
2026-08-24 15:39:06.134459 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:39:06.134752 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 15:39:06.135000 | instance |
2026-08-24 15:39:06.135265 | instance | Monday 24 August 2026  15:39:06 +0000 (0:00:01.846)       0:00:33.176 *********
2026-08-24 15:39:06.135523 | instance | ===============================================================================
2026-08-24 15:39:06.135780 | instance | Install depedencies ---------------------------------------------------- 21.03s
2026-08-24 15:39:06.136045 | instance | Create a volume group for each loop device ------------------------------ 3.16s
2026-08-24 15:39:06.136306 | instance | Create a logical volume for each loop device ---------------------------- 1.85s
2026-08-24 15:39:06.136566 | instance | Gathering Facts --------------------------------------------------------- 1.16s
2026-08-24 15:39:06.136867 | instance | Purge "snapd" package --------------------------------------------------- 0.85s
2026-08-24 15:39:06.137128 | instance | Start loop devices ------------------------------------------------------ 0.68s
2026-08-24 15:39:06.137503 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-08-24 15:39:06.137844 | instance | Configure short hostname ------------------------------------------------ 0.67s
2026-08-24 15:39:06.138255 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.63s
2026-08-24 15:39:06.138582 | instance | Set permissions on loopback devices ------------------------------------- 0.59s
2026-08-24 15:39:06.138893 | instance | Start up service -------------------------------------------------------- 0.57s
2026-08-24 15:39:06.139221 | instance | Create devices for Ceph ------------------------------------------------- 0.53s
2026-08-24 15:39:06.139516 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-24 15:39:06.139785 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s
2026-08-24 15:39:06.140045 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-24 15:39:06.140309 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-24 15:39:06.214009 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 15:39:06.226065 | instance | INFO     [csi > converge] Executing
2026-08-24 15:39:07.729824 | instance |
2026-08-24 15:39:07.730124 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 15:39:07.730384 | instance |
2026-08-24 15:39:07.730663 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:39:07.730941 | instance | Monday 24 August 2026  15:39:07 +0000 (0:00:00.007)       0:00:00.007 *********
2026-08-24 15:39:08.681167 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:39:08.681510 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:39:08.681856 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:39:08.682246 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:39:08.682550 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:39:08.692642 | instance | ok: [instance]
2026-08-24 15:39:08.692888 | instance |
2026-08-24 15:39:08.693195 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 15:39:08.693588 | instance | Monday 24 August 2026  15:39:08 +0000 (0:00:00.963)       0:00:00.970 *********
2026-08-24 15:39:08.738311 | instance | ok: [instance] => {
2026-08-24 15:39:08.738568 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 15:39:08.738868 | instance | }
2026-08-24 15:39:08.739120 | instance |
2026-08-24 15:39:08.739436 | instance | PLAY [all] *********************************************************************
2026-08-24 15:39:08.739665 | instance |
2026-08-24 15:39:08.739928 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:39:08.740217 | instance | Monday 24 August 2026  15:39:08 +0000 (0:00:00.045)       0:00:01.016 *********
2026-08-24 15:39:09.633321 | instance | ok: [instance]
2026-08-24 15:39:09.633587 | instance |
2026-08-24 15:39:09.633921 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 15:39:09.634275 | instance | Monday 24 August 2026  15:39:09 +0000 (0:00:00.894)       0:00:01.911 *********
2026-08-24 15:39:09.813580 | instance | ok: [instance]
2026-08-24 15:39:09.814001 | instance |
2026-08-24 15:39:09.814368 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 15:39:09.814765 | instance |
2026-08-24 15:39:09.815122 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:39:09.815474 | instance | Monday 24 August 2026  15:39:09 +0000 (0:00:00.180)       0:00:02.091 *********
2026-08-24 15:39:10.730424 | instance | ok: [instance]
2026-08-24 15:39:10.730499 | instance |
2026-08-24 15:39:10.730619 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:39:10.730811 | instance | Monday 24 August 2026  15:39:10 +0000 (0:00:00.915)       0:00:03.006 *********
2026-08-24 15:39:11.001415 | instance | ok: [instance]
2026-08-24 15:39:11.001598 | instance |
2026-08-24 15:39:11.001756 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:39:11.001911 | instance | Monday 24 August 2026  15:39:10 +0000 (0:00:00.271)       0:00:03.277 *********
2026-08-24 15:39:11.036842 | instance | skipping: [instance]
2026-08-24 15:39:11.036881 | instance |
2026-08-24 15:39:11.036887 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 15:39:11.036892 | instance | Monday 24 August 2026  15:39:11 +0000 (0:00:00.036)       0:00:03.314 *********
2026-08-24 15:39:11.371304 | instance | changed: [instance]
2026-08-24 15:39:11.371816 | instance |
2026-08-24 15:39:11.371975 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:39:11.371984 | instance | Monday 24 August 2026  15:39:11 +0000 (0:00:00.334)       0:00:03.649 *********
2026-08-24 15:39:11.436981 | instance | ok: [instance] => {
2026-08-24 15:39:11.437110 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 15:39:11.437903 | instance | }
2026-08-24 15:39:11.437964 | instance |
2026-08-24 15:39:11.437975 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:39:11.437982 | instance | Monday 24 August 2026  15:39:11 +0000 (0:00:00.065)       0:00:03.714 *********
2026-08-24 15:39:12.367841 | instance | changed: [instance]
2026-08-24 15:39:12.367912 | instance |
2026-08-24 15:39:12.368251 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:39:12.368283 | instance | Monday 24 August 2026  15:39:12 +0000 (0:00:00.931)       0:00:04.645 *********
2026-08-24 15:39:12.418904 | instance | skipping: [instance]
2026-08-24 15:39:12.418968 | instance |
2026-08-24 15:39:12.419247 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:39:12.419288 | instance | Monday 24 August 2026  15:39:12 +0000 (0:00:00.050)       0:00:04.696 *********
2026-08-24 15:39:12.467955 | instance | skipping: [instance]
2026-08-24 15:39:12.468426 | instance |
2026-08-24 15:39:12.468465 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:39:12.468471 | instance | Monday 24 August 2026  15:39:12 +0000 (0:00:00.049)       0:00:04.746 *********
2026-08-24 15:39:12.682580 | instance | ok: [instance]
2026-08-24 15:39:12.682660 | instance |
2026-08-24 15:39:12.682784 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:39:12.682998 | instance | Monday 24 August 2026  15:39:12 +0000 (0:00:00.214)       0:00:04.960 *********
2026-08-24 15:39:13.880328 | instance | ok: [instance]
2026-08-24 15:39:13.880402 | instance |
2026-08-24 15:39:13.880511 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:39:13.880681 | instance | Monday 24 August 2026  15:39:13 +0000 (0:00:01.197)       0:00:06.158 *********
2026-08-24 15:39:13.948448 | instance | ok: [instance] => {
2026-08-24 15:39:13.948576 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 15:39:13.948804 | instance | }
2026-08-24 15:39:13.949022 | instance |
2026-08-24 15:39:13.949222 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:39:13.949424 | instance | Monday 24 August 2026  15:39:13 +0000 (0:00:00.068)       0:00:06.226 *********
2026-08-24 15:39:14.554845 | instance | changed: [instance]
2026-08-24 15:39:14.555058 | instance |
2026-08-24 15:39:14.555339 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:39:14.555636 | instance | Monday 24 August 2026  15:39:14 +0000 (0:00:00.604)       0:00:06.830 *********
2026-08-24 15:39:17.422414 | instance | changed: [instance]
2026-08-24 15:39:17.422484 | instance |
2026-08-24 15:39:17.422629 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 15:39:17.422846 | instance | Monday 24 August 2026  15:39:17 +0000 (0:00:02.867)       0:00:09.698 *********
2026-08-24 15:39:17.454481 | instance | skipping: [instance]
2026-08-24 15:39:17.454582 | instance |
2026-08-24 15:39:17.454797 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 15:39:17.454950 | instance | Monday 24 August 2026  15:39:17 +0000 (0:00:00.032)       0:00:09.731 *********
2026-08-24 15:39:17.482444 | instance | skipping: [instance]
2026-08-24 15:39:17.482576 | instance |
2026-08-24 15:39:17.482965 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 15:39:17.483137 | instance | Monday 24 August 2026  15:39:17 +0000 (0:00:00.026)       0:00:09.758 *********
2026-08-24 15:39:17.514405 | instance | skipping: [instance]
2026-08-24 15:39:17.514629 | instance |
2026-08-24 15:39:17.514890 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 15:39:17.515092 | instance | Monday 24 August 2026  15:39:17 +0000 (0:00:00.032)       0:00:09.791 *********
2026-08-24 15:39:22.422539 | instance | changed: [instance]
2026-08-24 15:39:22.422692 | instance |
2026-08-24 15:39:22.422992 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 15:39:22.423053 | instance | Monday 24 August 2026  15:39:22 +0000 (0:00:04.908)       0:00:14.700 *********
2026-08-24 15:39:23.029896 | instance | changed: [instance]
2026-08-24 15:39:23.030293 | instance |
2026-08-24 15:39:23.030310 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 15:39:23.030316 | instance | Monday 24 August 2026  15:39:23 +0000 (0:00:00.607)       0:00:15.307 *********
2026-08-24 15:39:23.949426 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 15:39:23.950052 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 15:39:23.950168 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 15:39:23.950181 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 15:39:23.950828 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 15:39:23.950875 | instance |
2026-08-24 15:39:23.950889 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 15:39:23.950896 | instance | Monday 24 August 2026  15:39:23 +0000 (0:00:00.919)       0:00:16.227 *********
2026-08-24 15:39:24.516685 | instance | changed: [instance]
2026-08-24 15:39:24.516742 | instance |
2026-08-24 15:39:24.517351 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 15:39:24.517367 | instance | Monday 24 August 2026  15:39:24 +0000 (0:00:00.550)       0:00:16.778 *********
2026-08-24 15:39:24.517372 | instance |
2026-08-24 15:39:24.517377 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:39:24.517381 | instance | Monday 24 August 2026  15:39:24 +0000 (0:00:00.016)       0:00:16.794 *********
2026-08-24 15:39:25.428844 | instance | ok: [instance]
2026-08-24 15:39:25.428912 | instance |
2026-08-24 15:39:25.429229 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 15:39:25.429269 | instance | Monday 24 August 2026  15:39:25 +0000 (0:00:00.912)       0:00:17.706 *********
2026-08-24 15:39:25.883883 | instance | changed: [instance]
2026-08-24 15:39:25.883989 | instance |
2026-08-24 15:39:25.884406 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 15:39:25.884452 | instance | Monday 24 August 2026  15:39:25 +0000 (0:00:00.454)       0:00:18.161 *********
2026-08-24 15:39:26.395743 | instance | changed: [instance]
2026-08-24 15:39:26.395820 | instance |
2026-08-24 15:39:26.396089 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:39:26.396129 | instance | Monday 24 August 2026  15:39:26 +0000 (0:00:00.511)       0:00:18.673 *********
2026-08-24 15:39:26.604696 | instance | ok: [instance]
2026-08-24 15:39:26.604773 | instance |
2026-08-24 15:39:26.605046 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:39:26.605087 | instance | Monday 24 August 2026  15:39:26 +0000 (0:00:00.208)       0:00:18.882 *********
2026-08-24 15:39:26.666971 | instance | ok: [instance] => {
2026-08-24 15:39:26.667070 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 15:39:26.667603 | instance | }
2026-08-24 15:39:26.667644 | instance |
2026-08-24 15:39:26.667650 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:39:26.667655 | instance | Monday 24 August 2026  15:39:26 +0000 (0:00:00.062)       0:00:18.944 *********
2026-08-24 15:39:27.562022 | instance | changed: [instance]
2026-08-24 15:39:27.562563 | instance |
2026-08-24 15:39:27.562617 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:39:27.562627 | instance | Monday 24 August 2026  15:39:27 +0000 (0:00:00.894)       0:00:19.839 *********
2026-08-24 15:39:31.922947 | instance | changed: [instance]
2026-08-24 15:39:31.923031 | instance |
2026-08-24 15:39:31.923070 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 15:39:31.923237 | instance | Monday 24 August 2026  15:39:31 +0000 (0:00:04.361)       0:00:24.201 *********
2026-08-24 15:39:32.911813 | instance | ok: [instance]
2026-08-24 15:39:32.911908 | instance |
2026-08-24 15:39:32.912163 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 15:39:32.912201 | instance | Monday 24 August 2026  15:39:32 +0000 (0:00:00.988)       0:00:25.189 *********
2026-08-24 15:39:33.375489 | instance | changed: [instance]
2026-08-24 15:39:33.375565 | instance |
2026-08-24 15:39:33.375818 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 15:39:33.375857 | instance | Monday 24 August 2026  15:39:33 +0000 (0:00:00.463)       0:00:25.653 *********
2026-08-24 15:39:33.837820 | instance | changed: [instance]
2026-08-24 15:39:33.837917 | instance |
2026-08-24 15:39:33.838227 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 15:39:33.838268 | instance | Monday 24 August 2026  15:39:33 +0000 (0:00:00.462)       0:00:26.115 *********
2026-08-24 15:39:34.394207 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 15:39:34.394281 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 15:39:34.394829 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 15:39:34.394869 | instance |
2026-08-24 15:39:34.394874 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 15:39:34.394879 | instance | Monday 24 August 2026  15:39:34 +0000 (0:00:00.556)       0:00:26.672 *********
2026-08-24 15:39:34.860268 | instance | changed: [instance]
2026-08-24 15:39:34.860369 | instance |
2026-08-24 15:39:34.860640 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 15:39:34.860681 | instance | Monday 24 August 2026  15:39:34 +0000 (0:00:00.465)       0:00:27.138 *********
2026-08-24 15:39:35.322835 | instance | changed: [instance]
2026-08-24 15:39:35.322989 | instance |
2026-08-24 15:39:35.323125 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 15:39:35.323300 | instance | Monday 24 August 2026  15:39:35 +0000 (0:00:00.445)       0:00:27.583 *********
2026-08-24 15:39:35.324026 | instance |
2026-08-24 15:39:35.324065 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:39:35.324071 | instance | Monday 24 August 2026  15:39:35 +0000 (0:00:00.017)       0:00:27.600 *********
2026-08-24 15:39:36.016739 | instance | ok: [instance]
2026-08-24 15:39:36.016779 | instance |
2026-08-24 15:39:36.016785 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 15:39:36.016796 | instance | Monday 24 August 2026  15:39:36 +0000 (0:00:00.693)       0:00:28.294 *********
2026-08-24 15:39:36.884774 | instance | changed: [instance]
2026-08-24 15:39:36.884815 | instance |
2026-08-24 15:39:36.884821 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 15:39:36.884826 | instance | Monday 24 August 2026  15:39:36 +0000 (0:00:00.868)       0:00:29.162 *********
2026-08-24 15:39:37.439493 | instance | changed: [instance]
2026-08-24 15:39:37.439522 | instance |
2026-08-24 15:39:37.439527 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 15:39:37.439532 | instance | Monday 24 August 2026  15:39:37 +0000 (0:00:00.554)       0:00:29.717 *********
2026-08-24 15:39:37.492887 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 15:39:37.492979 | instance |
2026-08-24 15:39:37.492989 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 15:39:37.492996 | instance | Monday 24 August 2026  15:39:37 +0000 (0:00:00.053)       0:00:29.770 *********
2026-08-24 15:39:42.324788 | instance | changed: [instance]
2026-08-24 15:39:42.325019 | instance |
2026-08-24 15:39:42.325039 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 15:39:42.325054 | instance | Monday 24 August 2026  15:39:42 +0000 (0:00:04.831)       0:00:34.601 *********
2026-08-24 15:39:42.975322 | instance | ok: [instance] => (item=chronyd)
2026-08-24 15:39:42.975404 | instance | ok: [instance] => (item=sshd)
2026-08-24 15:39:42.975436 | instance |
2026-08-24 15:39:42.975713 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 15:39:42.975784 | instance | Monday 24 August 2026  15:39:42 +0000 (0:00:00.651)       0:00:35.253 *********
2026-08-24 15:39:43.937027 | instance | changed: [instance]
2026-08-24 15:39:43.937100 | instance |
2026-08-24 15:39:43.937359 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 15:39:43.937400 | instance | Monday 24 August 2026  15:39:43 +0000 (0:00:00.961)       0:00:36.215 *********
2026-08-24 15:39:44.128414 | instance | ok: [instance]
2026-08-24 15:39:44.128557 | instance |
2026-08-24 15:39:44.128981 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 15:39:44.129150 | instance | Monday 24 August 2026  15:39:44 +0000 (0:00:00.190)       0:00:36.406 *********
2026-08-24 15:39:44.554336 | instance | changed: [instance]
2026-08-24 15:39:44.554432 | instance |
2026-08-24 15:39:44.554729 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 15:39:44.554769 | instance | Monday 24 August 2026  15:39:44 +0000 (0:00:00.426)       0:00:36.832 *********
2026-08-24 15:39:44.871575 | instance | changed: [instance]
2026-08-24 15:39:44.871658 | instance |
2026-08-24 15:39:44.871952 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 15:39:44.871993 | instance | Monday 24 August 2026  15:39:44 +0000 (0:00:00.317)       0:00:37.149 *********
2026-08-24 15:39:44.982480 | instance | ok: [instance]
2026-08-24 15:39:44.982556 | instance |
2026-08-24 15:39:44.982815 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 15:39:44.982847 | instance | Monday 24 August 2026  15:39:44 +0000 (0:00:00.110)       0:00:37.260 *********
2026-08-24 15:39:45.211411 | instance | ok: [instance] => (item=instance)
2026-08-24 15:39:45.211480 | instance |
2026-08-24 15:39:45.211757 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 15:39:45.211797 | instance | Monday 24 August 2026  15:39:45 +0000 (0:00:00.228)       0:00:37.489 *********
2026-08-24 15:39:45.263228 | instance | ok: [instance]
2026-08-24 15:39:45.263605 | instance |
2026-08-24 15:39:45.263644 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 15:39:45.263650 | instance | Monday 24 August 2026  15:39:45 +0000 (0:00:00.051)       0:00:37.541 *********
2026-08-24 15:39:45.330509 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 15:39:45.330577 | instance |
2026-08-24 15:39:45.330802 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 15:39:45.330826 | instance | Monday 24 August 2026  15:39:45 +0000 (0:00:00.067)       0:00:37.608 *********
2026-08-24 15:39:45.639627 | instance | changed: [instance]
2026-08-24 15:39:45.640328 | instance |
2026-08-24 15:39:45.640381 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 15:39:45.640393 | instance | Monday 24 August 2026  15:39:45 +0000 (0:00:00.308)       0:00:37.917 *********
2026-08-24 15:39:46.318761 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 15:39:46.319403 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 15:39:46.319419 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 15:39:46.319424 | instance |
2026-08-24 15:39:46.319429 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 15:39:46.319433 | instance | Monday 24 August 2026  15:39:46 +0000 (0:00:00.679)       0:00:38.596 *********
2026-08-24 15:41:09.871549 | instance | ok: [instance]
2026-08-24 15:41:09.871664 | instance |
2026-08-24 15:41:09.872018 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 15:41:09.872063 | instance | Monday 24 August 2026  15:41:09 +0000 (0:01:23.552)       0:02:02.149 *********
2026-08-24 15:41:10.108684 | instance | changed: [instance]
2026-08-24 15:41:10.108807 | instance |
2026-08-24 15:41:10.108971 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 15:41:10.109135 | instance | Monday 24 August 2026  15:41:10 +0000 (0:00:00.237)       0:02:02.386 *********
2026-08-24 15:41:10.186869 | instance | ok: [instance]
2026-08-24 15:41:10.186957 | instance |
2026-08-24 15:41:10.187295 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 15:41:10.187318 | instance | Monday 24 August 2026  15:41:10 +0000 (0:00:00.078)       0:02:02.465 *********
2026-08-24 15:41:10.270384 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 15:41:10.270509 | instance |
2026-08-24 15:41:10.270867 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 15:41:10.270886 | instance | Monday 24 August 2026  15:41:10 +0000 (0:00:00.083)       0:02:02.548 *********
2026-08-24 15:41:11.868609 | instance | ok: [instance]
2026-08-24 15:41:11.868877 | instance |
2026-08-24 15:41:11.868944 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 15:41:11.869080 | instance | Monday 24 August 2026  15:41:11 +0000 (0:00:01.597)       0:02:04.146 *********
2026-08-24 15:41:11.941797 | instance | ok: [instance] => (item=instance)
2026-08-24 15:41:11.942025 | instance |
2026-08-24 15:41:11.942211 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 15:41:11.942386 | instance | Monday 24 August 2026  15:41:11 +0000 (0:00:00.073)       0:02:04.219 *********
2026-08-24 15:41:12.301270 | instance | ok: [instance]
2026-08-24 15:41:12.301326 | instance |
2026-08-24 15:41:12.301463 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 15:41:12.301615 | instance | Monday 24 August 2026  15:41:12 +0000 (0:00:00.359)       0:02:04.579 *********
2026-08-24 15:41:14.594888 | instance | ok: [instance]
2026-08-24 15:41:14.595123 | instance |
2026-08-24 15:41:14.595438 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 15:41:14.595730 | instance | Monday 24 August 2026  15:41:14 +0000 (0:00:02.293)       0:02:06.872 *********
2026-08-24 15:41:58.260820 | 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-08-24 15:41:58.260905 | 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__6y2okob/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__6y2okob/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__6y2okob/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__6y2okob/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-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDsZYxqmiu4GSAAQaV0ycX5RXKye3xyD0hfY1SfoffPXozd5E5hh006CZQ=: Malformed input [buffer:3]\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDsZYxqmiu4GSAAQaV0ycX5RXKye3xyD0hfY1SfoffPXozd5E5hh006CZQ=: Malformed input [buffer:3]\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDsZYxqmiu4GSAAQaV0ycX5RXKye3xyD0hfY1SfoffPXozd5E5hh006CZQ=: Malformed input [buffer:3]\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:41:58.093+0000 7ff1e71c1640 -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-08-24 15:41:58.263240 | instance |
2026-08-24 15:41:58.265997 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:41:58.266047 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-24 15:41:58.266054 | instance |
2026-08-24 15:41:58.266058 | instance | Monday 24 August 2026  15:41:58 +0000 (0:00:43.668)       0:02:50.541 *********
2026-08-24 15:41:58.266063 | instance | ===============================================================================
2026-08-24 15:41:58.266067 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 83.55s
2026-08-24 15:41:58.266071 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.67s
2026-08-24 15:41:58.266075 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.91s
2026-08-24 15:41:58.266079 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.83s
2026-08-24 15:41:58.266083 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.36s
2026-08-24 15:41:58.266151 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-08-24 15:41:58.266381 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.29s
2026-08-24 15:41:58.266585 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.61s
2026-08-24 15:41:58.266803 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.60s
2026-08-24 15:41:58.267006 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.20s
2026-08-24 15:41:58.267208 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.99s
2026-08-24 15:41:58.267409 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-08-24 15:41:58.267610 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.96s
2026-08-24 15:41:58.267809 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.93s
2026-08-24 15:41:58.268010 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.92s
2026-08-24 15:41:58.268207 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-24 15:41:58.268406 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.89s
2026-08-24 15:41:58.268605 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-24 15:41:58.268811 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.87s
2026-08-24 15:41:58.269012 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.68s
2026-08-24 15:41:58.361616 | 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-08-24 15:41:58.361988 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 15:41:58.362221 | 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-08-24 15:41:58.805594 | instance | ERROR
2026-08-24 15:41:58.805941 | instance | {
2026-08-24 15:41:58.806000 | instance |   "delta": "0:03:40.003609",
2026-08-24 15:41:58.806032 | instance |   "end": "2026-08-24 15:41:58.418761",
2026-08-24 15:41:58.806061 | instance |   "msg": "non-zero return code",
2026-08-24 15:41:58.806088 | instance |   "rc": 2,
2026-08-24 15:41:58.806115 | instance |   "start": "2026-08-24 15:38:18.415152"
2026-08-24 15:41:58.806142 | instance | }
failure
2026-08-24 15:41:58.814458 | 
2026-08-24 15:41:58.814599 | PLAY RECAP
2026-08-24 15:41:58.814663 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:41:58.814696 | 
2026-08-24 15:41:59.054141 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:41:59.099559 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:41:59.993273 | 
2026-08-24 15:41:59.993754 | PLAY [all]
2026-08-24 15:42:00.032988 | 
2026-08-24 15:42:00.033129 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 15:42:00.408820 | instance | changed
2026-08-24 15:42:00.414688 | 
2026-08-24 15:42:00.414793 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 15:42:00.779711 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 15:42:00.797924 | instance | + ip addr
2026-08-24 15:42:00.800828 | instance | + ip route
2026-08-24 15:42:00.803476 | instance | + lsblk
2026-08-24 15:42:00.809158 | instance | + mount
2026-08-24 15:42:00.810874 | instance | + docker images
2026-08-24 15:42:00.831761 | instance | + brctl show
2026-08-24 15:42:00.832346 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 15:42:00.832669 | instance | + ps aux --sort=-%mem
2026-08-24 15:42:00.856873 | instance | + dpkg -l
2026-08-24 15:42:00.869294 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 15:42:00.869848 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 15:42:00.885125 | instance | + '[' '!' -z '' ']'
2026-08-24 15:42:00.968825 | instance | ok: Runtime: 0:00:00.110033
2026-08-24 15:42:00.977265 | 
2026-08-24 15:42:00.977403 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 15:42:01.654067 | instance | changed:
2026-08-24 15:42:01.654289 | instance | created directory /var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/logs/instance
2026-08-24 15:42:01.654339 | instance | cd+++++++++ system/
2026-08-24 15:42:01.654370 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 15:42:01.654401 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 15:42:01.654433 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 15:42:01.654468 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 15:42:01.654497 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 15:42:01.654525 | instance | >f+++++++++ system/mount.txt
2026-08-24 15:42:01.654562 | instance | >f+++++++++ system/packages.txt
2026-08-24 15:42:01.654600 | instance | >f+++++++++ system/ps.txt
2026-08-24 15:42:01.654634 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 15:42:01.666670 | 
2026-08-24 15:42:01.666775 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 15:42:01.858678 | instance | changed: "values"
2026-08-24 15:42:02.023383 | instance | changed: "releases"
2026-08-24 15:42:02.039621 | 
2026-08-24 15:42:02.039831 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 15:42:02.247258 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 15:42:02.576659 | instance | ok: Runtime: 0:00:00.005178
2026-08-24 15:42:02.587614 | 
2026-08-24 15:42:02.587783 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 15:42:03.136754 | instance | changed:
2026-08-24 15:42:03.137172 | instance | cd+++++++++ helm/
2026-08-24 15:42:03.137243 | instance | cd+++++++++ helm/releases/
2026-08-24 15:42:03.137294 | instance | cd+++++++++ helm/values/
2026-08-24 15:42:03.146441 | 
2026-08-24 15:42:03.146517 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 15:42:03.355599 | instance | changed
2026-08-24 15:42:03.365396 | 
2026-08-24 15:42:03.365640 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 15:42:03.621693 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:42:03.622012 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:42:03.625705 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:42:03.626642 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:42:03.627904 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:42:03.628583 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:42:03.630276 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:42:03.631663 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:42:03.632492 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:42:03.633448 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:42:03.634104 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:42:03.635275 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:42:03.901616 | instance | ok: Runtime: 0:00:00.021131
2026-08-24 15:42:03.907075 | 
2026-08-24 15:42:03.907155 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 15:42:04.111724 | instance | changed
2026-08-24 15:42:04.117066 | 
2026-08-24 15:42:04.117155 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 15:42:04.330064 | instance | environment: line 5: kubectl: command not found
2026-08-24 15:42:04.331051 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:42:04.331092 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:42:04.331109 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:42:04.684381 | instance | ok: Runtime: 0:00:00.008217
2026-08-24 15:42:04.692785 | 
2026-08-24 15:42:04.692863 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 15:42:05.179900 | instance | changed:
2026-08-24 15:42:05.180081 | instance | cd+++++++++ objects/
2026-08-24 15:42:05.180123 | instance | cd+++++++++ objects/cluster/
2026-08-24 15:42:05.180157 | instance | cd+++++++++ objects/namespaced/
2026-08-24 15:42:05.190354 | 
2026-08-24 15:42:05.190419 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 15:42:05.387201 | instance | changed
2026-08-24 15:42:05.392174 | 
2026-08-24 15:42:05.392237 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 15:42:05.589615 | instance | changed
2026-08-24 15:42:05.595924 | 
2026-08-24 15:42:05.596010 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 15:42:05.798327 | instance | environment: line 3: kubectl: command not found
2026-08-24 15:42:06.132681 | instance | ok: Runtime: 0:00:00.007746
2026-08-24 15:42:06.139377 | 
2026-08-24 15:42:06.139450 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 15:42:06.652362 | instance | changed:
2026-08-24 15:42:06.652552 | instance | cd+++++++++ pod-logs/
2026-08-24 15:42:06.652609 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 15:42:06.665345 | 
2026-08-24 15:42:06.665496 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 15:42:06.853638 | instance | changed
2026-08-24 15:42:06.861163 | 
2026-08-24 15:42:06.861263 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 15:42:07.065478 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:42:07.397245 | instance | ok: Runtime: 0:00:00.045566
2026-08-24 15:42:07.404319 | 
2026-08-24 15:42:07.404427 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 15:42:07.613398 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:42:07.643174 | instance | ceph-mgr endpoints:
2026-08-24 15:42:07.939187 | instance | ok: Runtime: 0:00:00.036214
2026-08-24 15:42:07.949306 | 
2026-08-24 15:42:07.949471 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 15:42:08.162069 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 15:42:08.487331 | instance | ok: Runtime: 0:00:00.034180
2026-08-24 15:42:08.493186 | 
2026-08-24 15:42:08.493268 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 15:42:08.989722 | instance | changed: cd+++++++++ prometheus/
2026-08-24 15:42:08.998875 | 
2026-08-24 15:42:08.998953 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 15:42:09.196929 | instance | changed
2026-08-24 15:42:09.202049 | 
2026-08-24 15:42:09.202117 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 15:42:09.450161 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 15:42:09.451585 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 15:42:09.738055 | instance | ERROR
2026-08-24 15:42:09.738260 | instance | {
2026-08-24 15:42:09.738304 | instance |   "delta": "0:00:00.005952",
2026-08-24 15:42:09.738334 | instance |   "end": "2026-08-24 15:42:09.451918",
2026-08-24 15:42:09.738364 | instance |   "msg": "non-zero return code",
2026-08-24 15:42:09.738393 | instance |   "rc": 1,
2026-08-24 15:42:09.738419 | instance |   "start": "2026-08-24 15:42:09.445966"
2026-08-24 15:42:09.738453 | instance | }
2026-08-24 15:42:09.738501 | instance | ERROR: Ignoring Errors
2026-08-24 15:42:09.745514 | 
2026-08-24 15:42:09.745594 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 15:42:10.237927 | instance | changed: cd+++++++++ selenium/
2026-08-24 15:42:10.244738 | 
2026-08-24 15:42:10.244800 | PLAY RECAP
2026-08-24 15:42:10.244847 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 15:42:10.244870 | 
2026-08-24 15:42:10.372549 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:42:10.377589 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:42:11.156536 | 
2026-08-24 15:42:11.156706 | PLAY [all]
2026-08-24 15:42:11.170412 | 
2026-08-24 15:42:11.170535 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 15:42:11.215991 | instance | skipping: Conditional result was False
2026-08-24 15:42:11.226051 | 
2026-08-24 15:42:11.226150 | TASK [fetch-output : Set log path for single node]
2026-08-24 15:42:11.270344 | instance | ok
2026-08-24 15:42:11.275483 | 
2026-08-24 15:42:11.275553 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 15:42:11.687513 | instance -> localhost | ok: "/var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/logs"
2026-08-24 15:42:11.905137 | instance -> localhost | changed: "/var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/artifacts"
2026-08-24 15:42:12.123062 | instance -> localhost | changed: "/var/lib/zuul/builds/5095d405202b4119b003f47c51630216/work/docs"
2026-08-24 15:42:12.143647 | 
2026-08-24 15:42:12.143855 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 15:42:12.807056 | instance | changed: .d..t...... ./
2026-08-24 15:42:12.807370 | instance | changed: All items complete
2026-08-24 15:42:12.807408 | 
2026-08-24 15:42:13.260267 | instance | changed: .d..t...... ./
2026-08-24 15:42:13.726770 | instance | changed: .d..t...... ./
2026-08-24 15:42:13.751653 | 
2026-08-24 15:42:13.751827 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 15:42:14.263752 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006392
2026-08-24 15:42:14.518896 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007443
2026-08-24 15:42:14.530329 | 
2026-08-24 15:42:14.530447 | PLAY [all]
2026-08-24 15:42:14.536893 | 
2026-08-24 15:42:14.536985 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 15:42:15.006579 | instance | changed
2026-08-24 15:42:15.012878 | 
2026-08-24 15:42:15.012981 | PLAY RECAP
2026-08-24 15:42:15.013036 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 15:42:15.013061 | 
2026-08-24 15:42:15.162459 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:42:15.169674 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 15:42:15.847161 | 
2026-08-24 15:42:15.847361 | PLAY [localhost]
2026-08-24 15:42:15.859200 | 
2026-08-24 15:42:15.859306 | TASK [Generate Zuul manifest]
2026-08-24 15:42:15.882087 | localhost | ok
2026-08-24 15:42:15.908833 | 
2026-08-24 15:42:15.909109 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 15:42:16.266503 | localhost | changed
2026-08-24 15:42:16.278403 | 
2026-08-24 15:42:16.278502 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 15:42:16.310508 | localhost | ok
2026-08-24 15:42:16.322161 | 
2026-08-24 15:42:16.322256 | TASK [Upload logs]
2026-08-24 15:42:16.344568 | localhost | ok
2026-08-24 15:42:16.409354 | 
2026-08-24 15:42:16.409495 | TASK [Set zuul-log-path fact]
2026-08-24 15:42:16.427743 | localhost | ok
2026-08-24 15:42:16.442805 | 
2026-08-24 15:42:16.442935 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:42:16.476436 | localhost | ok
2026-08-24 15:42:16.485329 | 
2026-08-24 15:42:16.485466 | TASK [upload-logs : Create log directories]
2026-08-24 15:42:16.957115 | localhost | changed
2026-08-24 15:42:16.964300 | 
2026-08-24 15:42:16.964402 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 15:42:17.399845 | localhost -> localhost | ok: Runtime: 0:00:00.006048
2026-08-24 15:42:17.406409 | 
2026-08-24 15:42:17.406505 | TASK [upload-logs : Upload logs to log server]
2026-08-24 15:42:17.878216 | localhost | Output suppressed because no_log was given
2026-08-24 15:42:17.915084 | 
2026-08-24 15:42:17.915200 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 15:42:17.958647 | localhost | skipping: Conditional result was False
2026-08-24 15:42:17.968086 | localhost | skipping: Conditional result was False
2026-08-24 15:42:17.977737 | 
2026-08-24 15:42:17.977868 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 15:42:18.016899 | localhost | skipping: Conditional result was False
2026-08-24 15:42:18.017328 | 
2026-08-24 15:42:18.021453 | localhost | skipping: Conditional result was False
2026-08-24 15:42:18.029878 | 
2026-08-24 15:42:18.030002 | LOOP [upload-logs : Upload console log and json output]