2026-08-22 10:26:46.336771 | Job console starting
2026-08-22 10:26:46.348212 | Updating git repos
2026-08-22 10:26:51.647406 | Cloning repos into workspace
2026-08-22 10:27:12.131802 | Restoring repo states
2026-08-22 10:27:21.734136 | Merging changes
2026-08-22 10:27:26.125783 | Checking out repos
2026-08-22 10:27:32.556820 | Preparing playbooks
2026-08-22 10:27:39.355435 | Running Ansible setup
2026-08-22 10:27:43.488233 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 10:27:44.141548 | 
2026-08-22 10:27:44.142103 | PLAY [localhost]
2026-08-22 10:27:44.149797 | 
2026-08-22 10:27:44.149879 | TASK [Gathering Facts]
2026-08-22 10:27:45.039017 | localhost | ok
2026-08-22 10:27:45.050341 | 
2026-08-22 10:27:45.053892 | TASK [Setup log path fact]
2026-08-22 10:27:45.084604 | localhost | ok
2026-08-22 10:27:45.099442 | 
2026-08-22 10:27:45.099591 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 10:27:45.131714 | localhost | ok
2026-08-22 10:27:45.142168 | 
2026-08-22 10:27:45.142238 | TASK [emit-job-header : Print job information]
2026-08-22 10:27:45.183885 | # Job Information
2026-08-22 10:27:45.184108 | Ansible Version: 2.16.18
2026-08-22 10:27:45.184181 | Job: atmosphere-molecule-csi-rbd
2026-08-22 10:27:45.184231 | Pipeline: check
2026-08-22 10:27:45.184277 | Executor: 2d72f0692154
2026-08-22 10:27:45.184324 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4335
2026-08-22 10:27:45.184376 | Event ID: 40845e60-9e13-11f1-8eba-4e355a452b67
2026-08-22 10:27:45.188144 | 
2026-08-22 10:27:45.188232 | LOOP [emit-job-header : Print node information]
2026-08-22 10:27:45.292129 | localhost | ok:
2026-08-22 10:27:45.292411 | localhost | # Node Information
2026-08-22 10:27:45.292509 | localhost | Inventory Hostname: instance
2026-08-22 10:27:45.292555 | localhost | Hostname: np0000190578
2026-08-22 10:27:45.292586 | localhost | Username: zuul
2026-08-22 10:27:45.292617 | localhost | Distro: Ubuntu 22.04
2026-08-22 10:27:45.292644 | localhost | Provider: yul1
2026-08-22 10:27:45.292670 | localhost | Region: ca-ymq-1
2026-08-22 10:27:45.292695 | localhost | Label: ubuntu-jammy
2026-08-22 10:27:45.292720 | localhost | Product Name: OpenStack Nova
2026-08-22 10:27:45.292745 | localhost | Interface IP: 199.19.213.124
2026-08-22 10:27:45.302426 | 
2026-08-22 10:27:45.302595 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 10:27:46.000816 | localhost -> localhost | changed
2026-08-22 10:27:46.009836 | 
2026-08-22 10:27:46.009953 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 10:27:49.176508 | localhost -> localhost | changed
2026-08-22 10:27:49.186725 | 
2026-08-22 10:27:49.186786 | PLAY [all]
2026-08-22 10:27:49.203559 | 
2026-08-22 10:27:49.203761 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 10:27:49.441319 | instance -> localhost | ok
2026-08-22 10:27:49.447599 | 
2026-08-22 10:27:49.447861 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 10:27:49.482540 | instance | ok
2026-08-22 10:27:49.499806 | instance | included: /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 10:27:49.505351 | 
2026-08-22 10:27:49.505413 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 10:27:50.641276 | instance -> localhost | Generating public/private rsa key pair.
2026-08-22 10:27:50.720183 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/964e934fde5a40f8b164b0a495bac163_id_rsa
2026-08-22 10:27:50.720290 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/964e934fde5a40f8b164b0a495bac163_id_rsa.pub
2026-08-22 10:27:50.720349 | instance -> localhost | The key fingerprint is:
2026-08-22 10:27:50.720399 | instance -> localhost | SHA256:Zchx5iPyhwevXilfZNd8IpJsyc9ewIzlgndRStfIJAI zuul-build-sshkey
2026-08-22 10:27:50.720467 | instance -> localhost | The key's randomart image is:
2026-08-22 10:27:50.720515 | instance -> localhost | +---[RSA 3072]----+
2026-08-22 10:27:50.720575 | instance -> localhost | |        E.+ oo+o |
2026-08-22 10:27:50.720624 | instance -> localhost | |       . * o =o .|
2026-08-22 10:27:50.720670 | instance -> localhost | |      . = = +    |
2026-08-22 10:27:50.720716 | instance -> localhost | |       o @ X . o |
2026-08-22 10:27:50.720762 | instance -> localhost | |        S # X o +|
2026-08-22 10:27:50.720806 | instance -> localhost | |         * X + ..|
2026-08-22 10:27:50.720850 | instance -> localhost | |        o o + .  |
2026-08-22 10:27:50.720894 | instance -> localhost | |       . + o .   |
2026-08-22 10:27:50.720945 | instance -> localhost | |        . . .    |
2026-08-22 10:27:50.721031 | instance -> localhost | +----[SHA256]-----+
2026-08-22 10:27:50.721131 | instance -> localhost | ok: Runtime: 0:00:00.652623
2026-08-22 10:27:50.732741 | 
2026-08-22 10:27:50.732809 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 10:27:50.778774 | instance | ok
2026-08-22 10:27:50.788391 | instance | included: /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 10:27:50.795955 | 
2026-08-22 10:27:50.796031 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 10:27:50.821483 | instance | skipping: Conditional result was False
2026-08-22 10:27:50.831855 | 
2026-08-22 10:27:50.831955 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 10:27:51.312814 | instance | changed
2026-08-22 10:27:51.324674 | 
2026-08-22 10:27:51.324805 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 10:27:51.529914 | instance | ok
2026-08-22 10:27:51.544729 | 
2026-08-22 10:27:51.544845 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 10:27:52.058640 | instance | changed
2026-08-22 10:27:52.558515 | 
2026-08-22 10:27:52.558709 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 10:27:53.027675 | instance | changed
2026-08-22 10:27:53.034958 | 
2026-08-22 10:27:53.035028 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 10:27:53.058427 | instance | skipping: Conditional result was False
2026-08-22 10:27:53.068309 | 
2026-08-22 10:27:53.068396 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 10:27:53.479194 | instance -> localhost | changed
2026-08-22 10:27:53.492446 | 
2026-08-22 10:27:53.492517 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 10:27:54.002521 | instance -> localhost | Identity added: /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/964e934fde5a40f8b164b0a495bac163_id_rsa (zuul-build-sshkey)
2026-08-22 10:27:54.002767 | instance -> localhost | ok: Runtime: 0:00:00.015588
2026-08-22 10:27:54.008496 | 
2026-08-22 10:27:54.008561 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 10:27:54.350674 | instance | ok
2026-08-22 10:27:54.362113 | 
2026-08-22 10:27:54.362190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 10:27:54.386071 | instance | skipping: Conditional result was False
2026-08-22 10:27:54.401212 | 
2026-08-22 10:27:54.401304 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 10:27:54.739974 | instance | ok
2026-08-22 10:27:54.746177 | 
2026-08-22 10:27:54.746263 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 10:27:58.434125 | instance | Output suppressed because no_log was given
2026-08-22 10:27:58.445423 | 
2026-08-22 10:27:58.445492 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 10:27:58.642315 | instance | ok: "logs"
2026-08-22 10:27:58.642585 | instance | ok: All items complete
2026-08-22 10:27:58.642618 | 
2026-08-22 10:27:58.795151 | instance | ok: "artifacts"
2026-08-22 10:27:58.949214 | instance | ok: "docs"
2026-08-22 10:27:58.966147 | 
2026-08-22 10:27:58.966365 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 10:27:59.154518 | instance | changed: "logs"
2026-08-22 10:27:59.317833 | instance | changed: "artifacts"
2026-08-22 10:27:59.478845 | instance | changed: "docs"
2026-08-22 10:27:59.487704 | 
2026-08-22 10:27:59.487811 | PLAY RECAP
2026-08-22 10:27:59.487862 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 10:27:59.487894 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 10:27:59.487917 | 
2026-08-22 10:27:59.674089 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 10:27:59.677200 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 10:28:00.258850 | 
2026-08-22 10:28:00.258984 | PLAY [all]
2026-08-22 10:28:00.269384 | 
2026-08-22 10:28:00.269461 | TASK [setup-uv : Extract archive]
2026-08-22 10:28:02.422646 | instance | changed
2026-08-22 10:28:02.482695 | 
2026-08-22 10:28:02.482873 | TASK [setup-uv : Print version]
2026-08-22 10:28:02.873964 | instance | uv 0.8.13
2026-08-22 10:28:03.040533 | instance | ok: Runtime: 0:00:00.011809
2026-08-22 10:28:03.052753 | 
2026-08-22 10:28:03.052889 | TASK [Install Ansible collection siblings]
2026-08-22 10:28:11.728605 | instance | changed:
2026-08-22 10:28:11.728828 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 10:28:11.728870 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 10:28:11.728901 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 10:28:11.728930 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 10:28:11.728982 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 10:28:11.729032 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 10:28:11.729069 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 10:28:11.729101 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 10:28:11.729128 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 10:28:11.729157 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 10:28:11.729185 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 10:28:11.729211 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 10:28:11.729238 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-22 10:28:11.729286 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-22 10:28:11.729309 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-22 10:28:11.729329 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-22 10:28:11.729348 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-22 10:28:11.729366 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-22 10:28:11.729384 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-22 10:28:11.729401 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-22 10:28:11.729419 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-22 10:28:11.729437 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-22 10:28:11.729457 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 10:28:11.729491 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-22 10:28:11.729511 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-22 10:28:11.729529 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 10:28:11.729548 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 10:28:11.729565 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 10:28:11.729631 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-22 10:28:11.729654 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-22 10:28:11.729673 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 10:28:11.729692 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 10:28:11.729710 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-22 10:28:11.729774 | 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-22 10:28:11.729814 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.729835 | instance | Process install dependency map
2026-08-22 10:28:11.729854 | instance | Starting collection install process
2026-08-22 10:28:11.729873 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-22 10:28:11.729892 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-22 10:28:11.729911 | instance | ansible.netcommon:* was installed successfully
2026-08-22 10:28:11.729929 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-22 10:28:11.729947 | instance | Creating virtual environment at: .venv
2026-08-22 10:28:11.729965 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 10:28:11.729983 | instance | Downloading kubernetes (1.9MiB)
2026-08-22 10:28:11.730001 | instance | Downloading netaddr (2.2MiB)
2026-08-22 10:28:11.730029 | instance | Downloading ansible-core (2.1MiB)
2026-08-22 10:28:11.730056 | instance | Downloading rjsonnet (1.2MiB)
2026-08-22 10:28:11.730075 | instance | Downloading pydantic-core (2.0MiB)
2026-08-22 10:28:11.730095 | instance | Downloading openstacksdk (1.7MiB)
2026-08-22 10:28:11.730113 | instance | Downloading cryptography (4.2MiB)
2026-08-22 10:28:11.730131 | instance | Downloading pygments (1.2MiB)
2026-08-22 10:28:11.730149 | instance | Downloading setuptools (1.1MiB)
2026-08-22 10:28:11.730167 | instance |    Building pyperclip==1.9.0
2026-08-22 10:28:11.730187 | instance |  Downloading rjsonnet
2026-08-22 10:28:11.730205 | instance |  Downloading pydantic-core
2026-08-22 10:28:11.730223 | instance |  Downloading netaddr
2026-08-22 10:28:11.730241 | instance |  Downloading pygments
2026-08-22 10:28:11.730258 | instance |  Downloading cryptography
2026-08-22 10:28:11.730277 | instance |  Downloading setuptools
2026-08-22 10:28:11.730295 | instance |  Downloading kubernetes
2026-08-22 10:28:11.730313 | instance |  Downloading ansible-core
2026-08-22 10:28:11.730331 | instance |  Downloading openstacksdk
2026-08-22 10:28:11.730349 | instance |       Built pyperclip==1.9.0
2026-08-22 10:28:11.730368 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 10:28:11.730386 | instance | Installed 83 packages in 40ms
2026-08-22 10:28:11.730404 | instance | Checked out ansible.posix to 1.6.0
2026-08-22 10:28:11.730422 | 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-22 10:28:11.730440 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.730458 | instance | Process install dependency map
2026-08-22 10:28:11.730484 | instance | Starting collection install process
2026-08-22 10:28:11.730503 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-22 10:28:11.730521 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-22 10:28:11.730539 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-22 10:28:11.730557 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.730575 | instance | 2.17.12
2026-08-22 10:28:11.730593 | instance | Checked out ansible.utils to v6.1.0
2026-08-22 10:28:11.730611 | 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-22 10:28:11.730630 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.730647 | instance | Process install dependency map
2026-08-22 10:28:11.730665 | instance | Starting collection install process
2026-08-22 10:28:11.730683 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-22 10:28:11.730702 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-22 10:28:11.730720 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-22 10:28:11.730738 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.730755 | instance | 2.17.12
2026-08-22 10:28:11.730773 | instance | Checked out atmosphere.common to v0.7.0
2026-08-22 10:28:11.730791 | 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-22 10:28:11.730810 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.730828 | instance | Process install dependency map
2026-08-22 10:28:11.730845 | instance | Starting collection install process
2026-08-22 10:28:11.730863 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-22 10:28:11.730881 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-22 10:28:11.730899 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-22 10:28:11.730916 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.730933 | instance | 2.17.12
2026-08-22 10:28:11.730951 | instance | Checked out community.crypto to 2.2.3
2026-08-22 10:28:11.730969 | 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-22 10:28:11.730987 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.731005 | instance | Process install dependency map
2026-08-22 10:28:11.731024 | instance | Starting collection install process
2026-08-22 10:28:11.731048 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-22 10:28:11.731074 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-22 10:28:11.731096 | instance | community.crypto:2.2.3 was installed successfully
2026-08-22 10:28:11.731115 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.731133 | instance | 2.17.12
2026-08-22 10:28:11.731151 | instance | Checked out community.general to 7.3.0
2026-08-22 10:28:11.731169 | 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-22 10:28:11.731198 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.731217 | instance | Process install dependency map
2026-08-22 10:28:11.731245 | instance | Starting collection install process
2026-08-22 10:28:11.731265 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-22 10:28:11.731287 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-22 10:28:11.731307 | instance | community.general:7.3.0 was installed successfully
2026-08-22 10:28:11.731326 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.731344 | instance | 2.17.12
2026-08-22 10:28:11.731362 | instance | Checked out community.mysql to 3.6.0
2026-08-22 10:28:11.731382 | 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-22 10:28:11.731401 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.731419 | instance | Process install dependency map
2026-08-22 10:28:11.731438 | instance | Starting collection install process
2026-08-22 10:28:11.731455 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-22 10:28:11.731474 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-22 10:28:11.731491 | instance | community.mysql:3.6.0 was installed successfully
2026-08-22 10:28:11.731509 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.731527 | instance | 2.17.12
2026-08-22 10:28:11.731544 | instance | Checked out kubernetes.core to 2.4.0
2026-08-22 10:28:11.731563 | 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-22 10:28:11.731582 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.731600 | instance | Process install dependency map
2026-08-22 10:28:11.731618 | instance | Starting collection install process
2026-08-22 10:28:11.731666 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-22 10:28:11.731690 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-22 10:28:11.731709 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-22 10:28:11.731752 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.731772 | instance | 2.17.12
2026-08-22 10:28:11.731790 | instance | Checked out openstack.cloud to 2.6.0
2026-08-22 10:28:11.731830 | 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-22 10:28:11.731854 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.731872 | instance | Process install dependency map
2026-08-22 10:28:11.731890 | instance | Starting collection install process
2026-08-22 10:28:11.731908 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-22 10:28:11.731926 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-22 10:28:11.731944 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-22 10:28:11.731962 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.731979 | instance | 2.17.12
2026-08-22 10:28:11.732004 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-22 10:28:11.732024 | 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-22 10:28:11.732042 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.732068 | instance | Process install dependency map
2026-08-22 10:28:11.732090 | instance | Starting collection install process
2026-08-22 10:28:11.732108 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-22 10:28:11.732126 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-22 10:28:11.732144 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-22 10:28:11.732162 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.732180 | instance | 2.17.12
2026-08-22 10:28:11.732197 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-22 10:28:11.732235 | 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-22 10:28:11.732255 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.732274 | instance | Process install dependency map
2026-08-22 10:28:11.732407 | instance | Starting collection install process
2026-08-22 10:28:11.732449 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-22 10:28:11.732471 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-22 10:28:11.732490 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-22 10:28:11.732509 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.732527 | instance | 2.17.12
2026-08-22 10:28:11.732546 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-22 10:28:11.732564 | 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-22 10:28:11.732582 | instance | Starting galaxy collection install process
2026-08-22 10:28:11.732600 | instance | Process install dependency map
2026-08-22 10:28:11.732618 | instance | Starting collection install process
2026-08-22 10:28:11.732635 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-22 10:28:11.732653 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-22 10:28:11.732671 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-22 10:28:11.732688 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 10:28:11.732706 | instance | 2.17.12
2026-08-22 10:28:11.739004 | 
2026-08-22 10:28:11.739055 | PLAY RECAP
2026-08-22 10:28:11.739101 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 10:28:11.739122 | 
2026-08-22 10:28:11.945955 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 10:28:11.949767 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 10:28:12.571290 | 
2026-08-22 10:28:12.571431 | PLAY [all]
2026-08-22 10:28:12.582899 | 
2026-08-22 10:28:12.582978 | TASK [Install "jq" for log collection]
2026-08-22 10:28:22.096814 | instance | changed
2026-08-22 10:28:22.211044 | 
2026-08-22 10:28:22.211208 | PLAY RECAP
2026-08-22 10:28:22.211289 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 10:28:22.211457 | 
2026-08-22 10:28:22.444063 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 10:28:22.446197 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 10:28:23.123305 | 
2026-08-22 10:28:23.123463 | PLAY [all]
2026-08-22 10:28:23.135037 | 
2026-08-22 10:28:23.135123 | LOOP [Check inventory directories]
2026-08-22 10:28:23.466911 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-22 10:28:23.606114 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-22 10:28:23.754310 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-22 10:28:23.774077 | 
2026-08-22 10:28:23.774302 | LOOP [Copy inventory file for Zuul]
2026-08-22 10:28:24.574885 | instance | changed:
2026-08-22 10:28:24.575112 | instance | {
2026-08-22 10:28:24.575152 | instance |   "ansible_loop_var": "item",
2026-08-22 10:28:24.575185 | instance |   "changed": false,
2026-08-22 10:28:24.575214 | instance |   "failed": false,
2026-08-22 10:28:24.575245 | instance |   "invocation": {
2026-08-22 10:28:24.575272 | instance |     "module_args": {
2026-08-22 10:28:24.575298 | instance |       "checksum_algorithm": "sha1",
2026-08-22 10:28:24.575323 | instance |       "follow": true,
2026-08-22 10:28:24.575348 | instance |       "get_attributes": true,
2026-08-22 10:28:24.575376 | instance |       "get_checksum": true,
2026-08-22 10:28:24.575401 | instance |       "get_mime": true,
2026-08-22 10:28:24.575426 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-22 10:28:24.575450 | instance |     }
2026-08-22 10:28:24.575475 | instance |   },
2026-08-22 10:28:24.575499 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-22 10:28:24.575524 | instance |   "stat": {
2026-08-22 10:28:24.575548 | instance |     "atime": 1787394484.7690895,
2026-08-22 10:28:24.575573 | instance |     "attr_flags": "e",
2026-08-22 10:28:24.575598 | instance |     "attributes": [
2026-08-22 10:28:24.575622 | instance |       "extents"
2026-08-22 10:28:24.575646 | instance |     ],
2026-08-22 10:28:24.575670 | instance |     "block_size": 4096,
2026-08-22 10:28:24.575694 | instance |     "blocks": 8,
2026-08-22 10:28:24.575718 | instance |     "charset": "unknown",
2026-08-22 10:28:24.575744 | instance |     "ctime": 1787394483.809011,
2026-08-22 10:28:24.575769 | instance |     "dev": 64513,
2026-08-22 10:28:24.575793 | instance |     "device_type": 0,
2026-08-22 10:28:24.575817 | instance |     "executable": true,
2026-08-22 10:28:24.575841 | instance |     "exists": true,
2026-08-22 10:28:24.575865 | instance |     "gid": 1000,
2026-08-22 10:28:24.575889 | instance |     "gr_name": "zuul",
2026-08-22 10:28:24.575914 | instance |     "inode": 1047538,
2026-08-22 10:28:24.575937 | instance |     "isblk": false,
2026-08-22 10:28:24.575962 | instance |     "ischr": false,
2026-08-22 10:28:24.575987 | instance |     "isdir": true,
2026-08-22 10:28:24.576011 | instance |     "isfifo": false,
2026-08-22 10:28:24.576034 | instance |     "isgid": false,
2026-08-22 10:28:24.576058 | instance |     "islnk": false,
2026-08-22 10:28:24.576082 | instance |     "isreg": false,
2026-08-22 10:28:24.576105 | instance |     "issock": false,
2026-08-22 10:28:24.576128 | instance |     "isuid": false,
2026-08-22 10:28:24.576151 | instance |     "mimetype": "unknown",
2026-08-22 10:28:24.576175 | instance |     "mode": "0755",
2026-08-22 10:28:24.576198 | instance |     "mtime": 1787394483.809011,
2026-08-22 10:28:24.576221 | instance |     "nlink": 23,
2026-08-22 10:28:24.576244 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-22 10:28:24.576267 | instance |     "pw_name": "zuul",
2026-08-22 10:28:24.576295 | instance |     "readable": true,
2026-08-22 10:28:24.576320 | instance |     "rgrp": true,
2026-08-22 10:28:24.576344 | instance |     "roth": true,
2026-08-22 10:28:24.576382 | instance |     "rusr": true,
2026-08-22 10:28:24.576407 | instance |     "size": 4096,
2026-08-22 10:28:24.576431 | instance |     "uid": 1000,
2026-08-22 10:28:24.576454 | instance |     "version": "2574766825",
2026-08-22 10:28:24.576479 | instance |     "wgrp": false,
2026-08-22 10:28:24.576505 | instance |     "woth": false,
2026-08-22 10:28:24.576529 | instance |     "writeable": true,
2026-08-22 10:28:24.576553 | instance |     "wusr": true,
2026-08-22 10:28:24.576577 | instance |     "xgrp": true,
2026-08-22 10:28:24.576601 | instance |     "xoth": true,
2026-08-22 10:28:24.576624 | instance |     "xusr": true
2026-08-22 10:28:24.576662 | instance |   }
2026-08-22 10:28:24.576691 | instance | }
2026-08-22 10:28:24.576738 | instance | ok: All items complete
2026-08-22 10:28:24.576767 | 
2026-08-22 10:28:24.578493 | instance | skipping: Conditional result was False
2026-08-22 10:28:24.579305 | instance | skipping: Conditional result was False
2026-08-22 10:28:24.589223 | 
2026-08-22 10:28:24.589369 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 10:28:24.939122 | instance | changed: 1 replacements made
2026-08-22 10:28:24.942609 | instance | skipping: Conditional result was False
2026-08-22 10:28:24.947474 | instance | skipping: Conditional result was False
2026-08-22 10:28:24.963166 | 
2026-08-22 10:28:24.963351 | TASK [Run Molecule scenario]
2026-08-22 10:28:25.914633 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-22 10:28:26.306344 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 10:28:26.306462 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-22 10:28:37.404443 | instance | INFO     [csi > dependency] Executing
2026-08-22 10:28:37.404697 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-22 10:28:37.405050 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-22 10:28:37.405235 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 10:28:37.413456 | instance | INFO     [csi > cleanup] Executing
2026-08-22 10:28:37.413886 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 10:28:37.421869 | instance | INFO     [csi > destroy] Executing
2026-08-22 10:28:37.421914 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-22 10:28:37.422017 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-22 10:28:37.429862 | instance | INFO     [csi > syntax] Executing
2026-08-22 10:28:39.067976 | instance |
2026-08-22 10:28:39.068201 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 10:28:39.131875 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-22 10:28:39.147366 | instance | INFO     [csi > create] Executing
2026-08-22 10:28:39.149120 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 10:28:39.156644 | instance | INFO     [csi > prepare] Executing
2026-08-22 10:28:39.948435 | instance |
2026-08-22 10:28:39.948662 | instance | PLAY [Prepare] *****************************************************************
2026-08-22 10:28:39.948961 | instance |
2026-08-22 10:28:39.949254 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 10:28:39.949537 | instance | Saturday 22 August 2026  10:28:39 +0000 (0:00:00.024)       0:00:00.024 *******
2026-08-22 10:28:41.086604 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 10:28:41.087013 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 10:28:41.087454 | instance | interpreter could change the meaning of that path. See
2026-08-22 10:28:41.087854 | instance | https://docs.ansible.com/ansible-
2026-08-22 10:28:41.088279 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 10:28:41.095315 | instance | ok: [instance]
2026-08-22 10:28:41.095737 | instance |
2026-08-22 10:28:41.096138 | instance | TASK [Configure short hostname] ************************************************
2026-08-22 10:28:41.096546 | instance | Saturday 22 August 2026  10:28:41 +0000 (0:00:01.147)       0:00:01.171 *******
2026-08-22 10:28:41.755250 | instance | changed: [instance]
2026-08-22 10:28:41.755506 | instance |
2026-08-22 10:28:41.755804 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-22 10:28:41.756123 | instance | Saturday 22 August 2026  10:28:41 +0000 (0:00:00.659)       0:00:01.831 *******
2026-08-22 10:28:42.004886 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-22 10:28:42.005196 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-22 10:28:42.005520 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-22 10:28:42.011816 | instance | changed: [instance]
2026-08-22 10:28:42.012040 | instance |
2026-08-22 10:28:42.012296 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-22 10:28:42.012533 | instance | Saturday 22 August 2026  10:28:42 +0000 (0:00:00.256)       0:00:02.088 *******
2026-08-22 10:28:42.796777 | instance | ok: [instance]
2026-08-22 10:28:42.797021 | instance |
2026-08-22 10:28:42.797334 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-22 10:28:42.797635 | instance |
2026-08-22 10:28:42.797899 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 10:28:42.798167 | instance | Saturday 22 August 2026  10:28:42 +0000 (0:00:00.784)       0:00:02.873 *******
2026-08-22 10:28:43.490778 | instance | ok: [instance]
2026-08-22 10:28:43.490974 | instance |
2026-08-22 10:28:43.491221 | instance | TASK [Install depedencies] *****************************************************
2026-08-22 10:28:43.491474 | instance | Saturday 22 August 2026  10:28:43 +0000 (0:00:00.693)       0:00:03.566 *******
2026-08-22 10:29:02.543516 | instance | changed: [instance]
2026-08-22 10:29:02.543743 | instance |
2026-08-22 10:29:02.544029 | instance | TASK [Start up service] ********************************************************
2026-08-22 10:29:02.544398 | instance | Saturday 22 August 2026  10:29:02 +0000 (0:00:19.052)       0:00:22.619 *******
2026-08-22 10:29:03.105503 | instance | ok: [instance]
2026-08-22 10:29:03.105801 | instance |
2026-08-22 10:29:03.106184 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-22 10:29:03.106568 | instance | Saturday 22 August 2026  10:29:03 +0000 (0:00:00.562)       0:00:23.181 *******
2026-08-22 10:29:03.393453 | instance | ok: [instance]
2026-08-22 10:29:03.393719 | instance |
2026-08-22 10:29:03.394013 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-22 10:29:03.394293 | instance | Saturday 22 August 2026  10:29:03 +0000 (0:00:00.288)       0:00:23.469 *******
2026-08-22 10:29:04.045830 | instance | changed: [instance]
2026-08-22 10:29:04.045988 | instance |
2026-08-22 10:29:04.046177 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-22 10:29:04.046360 | instance | Saturday 22 August 2026  10:29:04 +0000 (0:00:00.652)       0:00:24.122 *******
2026-08-22 10:29:04.230671 | instance | ok: [instance]
2026-08-22 10:29:04.230899 | instance |
2026-08-22 10:29:04.231178 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-22 10:29:04.231511 | instance | Saturday 22 August 2026  10:29:04 +0000 (0:00:00.184)       0:00:24.307 *******
2026-08-22 10:29:04.252642 | instance | skipping: [instance]
2026-08-22 10:29:04.252882 | instance |
2026-08-22 10:29:04.253147 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-22 10:29:04.253414 | instance | Saturday 22 August 2026  10:29:04 +0000 (0:00:00.021)       0:00:24.328 *******
2026-08-22 10:29:04.758511 | instance | changed: [instance] => (item=osd0)
2026-08-22 10:29:04.758686 | instance | changed: [instance] => (item=osd1)
2026-08-22 10:29:04.758879 | instance | changed: [instance] => (item=osd2)
2026-08-22 10:29:04.759051 | instance |
2026-08-22 10:29:04.759268 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-22 10:29:04.759461 | instance | Saturday 22 August 2026  10:29:04 +0000 (0:00:00.506)       0:00:24.834 *******
2026-08-22 10:29:05.375340 | instance | changed: [instance] => (item=osd0)
2026-08-22 10:29:05.375443 | instance | changed: [instance] => (item=osd1)
2026-08-22 10:29:05.375449 | instance | changed: [instance] => (item=osd2)
2026-08-22 10:29:05.375453 | instance |
2026-08-22 10:29:05.375458 | instance | TASK [Start loop devices] ******************************************************
2026-08-22 10:29:05.375466 | instance | Saturday 22 August 2026  10:29:05 +0000 (0:00:00.615)       0:00:25.450 *******
2026-08-22 10:29:06.066075 | instance | changed: [instance] => (item=osd0)
2026-08-22 10:29:06.066190 | instance | changed: [instance] => (item=osd1)
2026-08-22 10:29:06.066981 | instance | changed: [instance] => (item=osd2)
2026-08-22 10:29:06.067027 | instance |
2026-08-22 10:29:06.067035 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-22 10:29:06.067042 | instance | Saturday 22 August 2026  10:29:06 +0000 (0:00:00.692)       0:00:26.142 *******
2026-08-22 10:29:09.302741 | instance | changed: [instance] => (item=osd0)
2026-08-22 10:29:09.302867 | instance | changed: [instance] => (item=osd1)
2026-08-22 10:29:09.303674 | instance | changed: [instance] => (item=osd2)
2026-08-22 10:29:09.303720 | instance |
2026-08-22 10:29:09.303728 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-22 10:29:09.303736 | instance | Saturday 22 August 2026  10:29:09 +0000 (0:00:03.236)       0:00:29.378 *******
2026-08-22 10:29:11.228310 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-22 10:29:11.228361 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-22 10:29:11.228382 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-22 10:29:11.228391 | instance |
2026-08-22 10:29:11.228400 | instance | PLAY RECAP *********************************************************************
2026-08-22 10:29:11.228409 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 10:29:11.228418 | instance |
2026-08-22 10:29:11.228426 | instance | Saturday 22 August 2026  10:29:11 +0000 (0:00:01.922)       0:00:31.301 *******
2026-08-22 10:29:11.228434 | instance | ===============================================================================
2026-08-22 10:29:11.228443 | instance | Install depedencies ---------------------------------------------------- 19.05s
2026-08-22 10:29:11.228451 | instance | Create a volume group for each loop device ------------------------------ 3.24s
2026-08-22 10:29:11.228458 | instance | Create a logical volume for each loop device ---------------------------- 1.92s
2026-08-22 10:29:11.228646 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-08-22 10:29:11.228942 | instance | Purge "snapd" package --------------------------------------------------- 0.78s
2026-08-22 10:29:11.229216 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-22 10:29:11.229486 | instance | Start loop devices ------------------------------------------------------ 0.69s
2026-08-22 10:29:11.229756 | instance | Configure short hostname ------------------------------------------------ 0.66s
2026-08-22 10:29:11.230082 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-22 10:29:11.230384 | instance | Set permissions on loopback devices ------------------------------------- 0.62s
2026-08-22 10:29:11.230662 | instance | Start up service -------------------------------------------------------- 0.56s
2026-08-22 10:29:11.230925 | instance | Create devices for Ceph ------------------------------------------------- 0.51s
2026-08-22 10:29:11.231197 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-22 10:29:11.231502 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s
2026-08-22 10:29:11.231776 | instance | Get list of all loopback devices ---------------------------------------- 0.18s
2026-08-22 10:29:11.232113 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-22 10:29:11.294259 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-22 10:29:11.305740 | instance | INFO     [csi > converge] Executing
2026-08-22 10:29:12.833599 | instance |
2026-08-22 10:29:12.833763 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-22 10:29:12.833926 | instance |
2026-08-22 10:29:12.834102 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 10:29:12.834278 | instance | Saturday 22 August 2026  10:29:12 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-22 10:29:13.755630 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 10:29:13.755751 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 10:29:13.755920 | instance | interpreter could change the meaning of that path. See
2026-08-22 10:29:13.756086 | instance | https://docs.ansible.com/ansible-
2026-08-22 10:29:13.756272 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 10:29:13.767157 | instance | ok: [instance]
2026-08-22 10:29:13.767263 | instance |
2026-08-22 10:29:13.767392 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-22 10:29:13.767517 | instance | Saturday 22 August 2026  10:29:13 +0000 (0:00:00.933)       0:00:00.941 *******
2026-08-22 10:29:13.805131 | instance | ok: [instance] => {
2026-08-22 10:29:13.805401 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-22 10:29:13.805666 | instance | }
2026-08-22 10:29:13.805926 | instance |
2026-08-22 10:29:13.806195 | instance | PLAY [all] *********************************************************************
2026-08-22 10:29:13.806451 | instance |
2026-08-22 10:29:13.806749 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 10:29:13.807074 | instance | Saturday 22 August 2026  10:29:13 +0000 (0:00:00.037)       0:00:00.979 *******
2026-08-22 10:29:14.655836 | instance | ok: [instance]
2026-08-22 10:29:14.656092 | instance |
2026-08-22 10:29:14.656396 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-22 10:29:14.656709 | instance | Saturday 22 August 2026  10:29:14 +0000 (0:00:00.850)       0:00:01.829 *******
2026-08-22 10:29:14.694774 | instance | skipping: [instance]
2026-08-22 10:29:14.694992 | instance |
2026-08-22 10:29:14.695289 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-22 10:29:14.695601 | instance | Saturday 22 August 2026  10:29:14 +0000 (0:00:00.039)       0:00:01.868 *******
2026-08-22 10:29:14.878985 | instance | ok: [instance]
2026-08-22 10:29:14.879219 | instance |
2026-08-22 10:29:14.879499 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-22 10:29:14.879747 | instance |
2026-08-22 10:29:14.880077 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 10:29:14.880389 | instance | Saturday 22 August 2026  10:29:14 +0000 (0:00:00.184)       0:00:02.053 *******
2026-08-22 10:29:15.786316 | instance | ok: [instance]
2026-08-22 10:29:15.786725 | instance |
2026-08-22 10:29:15.787080 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 10:29:15.787420 | instance | Saturday 22 August 2026  10:29:15 +0000 (0:00:00.906)       0:00:02.959 *******
2026-08-22 10:29:16.128826 | instance | ok: [instance]
2026-08-22 10:29:16.128922 | instance |
2026-08-22 10:29:16.129034 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 10:29:16.129287 | instance | Saturday 22 August 2026  10:29:16 +0000 (0:00:00.340)       0:00:03.300 *******
2026-08-22 10:29:16.169029 | instance | skipping: [instance]
2026-08-22 10:29:16.169105 | instance |
2026-08-22 10:29:16.169262 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-22 10:29:16.169485 | instance | Saturday 22 August 2026  10:29:16 +0000 (0:00:00.041)       0:00:03.341 *******
2026-08-22 10:29:16.547022 | instance | changed: [instance]
2026-08-22 10:29:16.547213 | instance |
2026-08-22 10:29:16.547375 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 10:29:16.547531 | instance | Saturday 22 August 2026  10:29:16 +0000 (0:00:00.378)       0:00:03.719 *******
2026-08-22 10:29:16.619199 | instance | ok: [instance] => {
2026-08-22 10:29:16.619231 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-22 10:29:16.619237 | instance | }
2026-08-22 10:29:16.619241 | instance |
2026-08-22 10:29:16.619245 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 10:29:16.619250 | instance | Saturday 22 August 2026  10:29:16 +0000 (0:00:00.072)       0:00:03.792 *******
2026-08-22 10:29:17.291183 | instance | changed: [instance]
2026-08-22 10:29:17.291413 | instance |
2026-08-22 10:29:17.291855 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 10:29:17.291907 | instance | Saturday 22 August 2026  10:29:17 +0000 (0:00:00.672)       0:00:04.464 *******
2026-08-22 10:29:17.342705 | instance | skipping: [instance]
2026-08-22 10:29:17.342770 | instance |
2026-08-22 10:29:17.343048 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 10:29:17.343086 | instance | Saturday 22 August 2026  10:29:17 +0000 (0:00:00.052)       0:00:04.516 *******
2026-08-22 10:29:17.392843 | instance | skipping: [instance]
2026-08-22 10:29:17.392919 | instance |
2026-08-22 10:29:17.393309 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 10:29:17.393347 | instance | Saturday 22 August 2026  10:29:17 +0000 (0:00:00.050)       0:00:04.566 *******
2026-08-22 10:29:17.606306 | instance | ok: [instance]
2026-08-22 10:29:17.606339 | instance |
2026-08-22 10:29:17.606344 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 10:29:17.606349 | instance | Saturday 22 August 2026  10:29:17 +0000 (0:00:00.213)       0:00:04.780 *******
2026-08-22 10:29:18.834630 | instance | ok: [instance]
2026-08-22 10:29:18.834695 | instance |
2026-08-22 10:29:18.834957 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 10:29:18.835010 | instance | Saturday 22 August 2026  10:29:18 +0000 (0:00:01.228)       0:00:06.008 *******
2026-08-22 10:29:18.903918 | instance | ok: [instance] => {
2026-08-22 10:29:18.904013 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-22 10:29:18.904321 | instance | }
2026-08-22 10:29:18.904697 | instance |
2026-08-22 10:29:18.904942 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 10:29:18.904980 | instance | Saturday 22 August 2026  10:29:18 +0000 (0:00:00.069)       0:00:06.077 *******
2026-08-22 10:29:19.577932 | instance | changed: [instance]
2026-08-22 10:29:19.578057 | instance |
2026-08-22 10:29:19.578412 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 10:29:19.578485 | instance | Saturday 22 August 2026  10:29:19 +0000 (0:00:00.673)       0:00:06.751 *******
2026-08-22 10:29:22.444882 | instance | changed: [instance]
2026-08-22 10:29:22.445595 | instance |
2026-08-22 10:29:22.445651 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-22 10:29:22.445662 | instance | Saturday 22 August 2026  10:29:22 +0000 (0:00:02.867)       0:00:09.618 *******
2026-08-22 10:29:22.485283 | instance | skipping: [instance]
2026-08-22 10:29:22.486013 | instance |
2026-08-22 10:29:22.486051 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-22 10:29:22.486059 | instance | Saturday 22 August 2026  10:29:22 +0000 (0:00:00.040)       0:00:09.659 *******
2026-08-22 10:29:22.520487 | instance | skipping: [instance]
2026-08-22 10:29:22.520595 | instance |
2026-08-22 10:29:22.520919 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-22 10:29:22.520963 | instance | Saturday 22 August 2026  10:29:22 +0000 (0:00:00.035)       0:00:09.694 *******
2026-08-22 10:29:22.549023 | instance | skipping: [instance]
2026-08-22 10:29:22.549061 | instance |
2026-08-22 10:29:22.549066 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-22 10:29:22.549071 | instance | Saturday 22 August 2026  10:29:22 +0000 (0:00:00.028)       0:00:09.722 *******
2026-08-22 10:29:27.130727 | instance | changed: [instance]
2026-08-22 10:29:27.130879 | instance |
2026-08-22 10:29:27.130891 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-22 10:29:27.131014 | instance | Saturday 22 August 2026  10:29:27 +0000 (0:00:04.582)       0:00:14.304 *******
2026-08-22 10:29:27.702790 | instance | changed: [instance]
2026-08-22 10:29:27.702828 | instance |
2026-08-22 10:29:27.702833 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-22 10:29:27.702838 | instance | Saturday 22 August 2026  10:29:27 +0000 (0:00:00.571)       0:00:14.876 *******
2026-08-22 10:29:28.578419 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-22 10:29:28.579296 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-22 10:29:28.579312 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-22 10:29:28.579324 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-22 10:29:28.579331 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-22 10:29:28.579337 | instance |
2026-08-22 10:29:28.579343 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-22 10:29:28.579347 | instance | Saturday 22 August 2026  10:29:28 +0000 (0:00:00.875)       0:00:15.752 *******
2026-08-22 10:29:29.157732 | instance | changed: [instance]
2026-08-22 10:29:29.157799 | instance |
2026-08-22 10:29:29.158418 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-22 10:29:29.158458 | instance | Saturday 22 August 2026  10:29:29 +0000 (0:00:00.561)       0:00:16.314 *******
2026-08-22 10:29:29.158464 | instance |
2026-08-22 10:29:29.158468 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 10:29:29.158472 | instance | Saturday 22 August 2026  10:29:29 +0000 (0:00:00.017)       0:00:16.331 *******
2026-08-22 10:29:30.110055 | instance | ok: [instance]
2026-08-22 10:29:30.110101 | instance |
2026-08-22 10:29:30.110108 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-22 10:29:30.110112 | instance | Saturday 22 August 2026  10:29:30 +0000 (0:00:00.951)       0:00:17.283 *******
2026-08-22 10:29:30.584054 | instance | changed: [instance]
2026-08-22 10:29:30.584140 | instance |
2026-08-22 10:29:30.584485 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-22 10:29:30.584524 | instance | Saturday 22 August 2026  10:29:30 +0000 (0:00:00.474)       0:00:17.757 *******
2026-08-22 10:29:31.137637 | instance | changed: [instance]
2026-08-22 10:29:31.137735 | instance |
2026-08-22 10:29:31.138050 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 10:29:31.138200 | instance | Saturday 22 August 2026  10:29:31 +0000 (0:00:00.553)       0:00:18.311 *******
2026-08-22 10:29:31.336569 | instance | ok: [instance]
2026-08-22 10:29:31.336713 | instance |
2026-08-22 10:29:31.336895 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 10:29:31.337069 | instance | Saturday 22 August 2026  10:29:31 +0000 (0:00:00.198)       0:00:18.510 *******
2026-08-22 10:29:31.399249 | instance | ok: [instance] => {
2026-08-22 10:29:31.399412 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-22 10:29:31.399582 | instance | }
2026-08-22 10:29:31.399744 | instance |
2026-08-22 10:29:31.399915 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 10:29:31.400089 | instance | Saturday 22 August 2026  10:29:31 +0000 (0:00:00.062)       0:00:18.573 *******
2026-08-22 10:29:32.210461 | instance | changed: [instance]
2026-08-22 10:29:32.210684 | instance |
2026-08-22 10:29:32.211033 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 10:29:32.211321 | instance | Saturday 22 August 2026  10:29:32 +0000 (0:00:00.811)       0:00:19.384 *******
2026-08-22 10:29:36.522343 | instance | changed: [instance]
2026-08-22 10:29:36.522401 | instance |
2026-08-22 10:29:36.522412 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-22 10:29:36.522423 | instance | Saturday 22 August 2026  10:29:36 +0000 (0:00:04.310)       0:00:23.695 *******
2026-08-22 10:29:37.530179 | instance | ok: [instance]
2026-08-22 10:29:37.530250 | instance |
2026-08-22 10:29:37.530529 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-22 10:29:37.530569 | instance | Saturday 22 August 2026  10:29:37 +0000 (0:00:01.009)       0:00:24.704 *******
2026-08-22 10:29:37.949998 | instance | changed: [instance]
2026-08-22 10:29:37.950058 | instance |
2026-08-22 10:29:37.950346 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-22 10:29:37.950381 | instance | Saturday 22 August 2026  10:29:37 +0000 (0:00:00.419)       0:00:25.124 *******
2026-08-22 10:29:38.404785 | instance | changed: [instance]
2026-08-22 10:29:38.405276 | instance |
2026-08-22 10:29:38.405312 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-22 10:29:38.405317 | instance | Saturday 22 August 2026  10:29:38 +0000 (0:00:00.454)       0:00:25.578 *******
2026-08-22 10:29:38.963667 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-22 10:29:38.964279 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-22 10:29:38.964320 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-22 10:29:38.964325 | instance |
2026-08-22 10:29:38.964330 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-22 10:29:38.964337 | instance | Saturday 22 August 2026  10:29:38 +0000 (0:00:00.559)       0:00:26.137 *******
2026-08-22 10:29:39.416866 | instance | changed: [instance]
2026-08-22 10:29:39.416900 | instance |
2026-08-22 10:29:39.416906 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-22 10:29:39.416911 | instance | Saturday 22 August 2026  10:29:39 +0000 (0:00:00.452)       0:00:26.590 *******
2026-08-22 10:29:39.892505 | instance | changed: [instance]
2026-08-22 10:29:39.893492 | instance |
2026-08-22 10:29:39.893514 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-22 10:29:39.893534 | instance | Saturday 22 August 2026  10:29:39 +0000 (0:00:00.459)       0:00:27.050 *******
2026-08-22 10:29:39.893541 | instance |
2026-08-22 10:29:39.893547 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 10:29:39.893558 | instance | Saturday 22 August 2026  10:29:39 +0000 (0:00:00.016)       0:00:27.066 *******
2026-08-22 10:29:40.570927 | instance | ok: [instance]
2026-08-22 10:29:40.570999 | instance |
2026-08-22 10:29:40.571284 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-22 10:29:40.571321 | instance | Saturday 22 August 2026  10:29:40 +0000 (0:00:00.678)       0:00:27.744 *******
2026-08-22 10:29:41.435671 | instance | changed: [instance]
2026-08-22 10:29:41.435737 | instance |
2026-08-22 10:29:41.436025 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-22 10:29:41.436206 | instance | Saturday 22 August 2026  10:29:41 +0000 (0:00:00.864)       0:00:28.609 *******
2026-08-22 10:29:41.959400 | instance | changed: [instance]
2026-08-22 10:29:41.959491 | instance |
2026-08-22 10:29:41.959794 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-22 10:29:41.959830 | instance | Saturday 22 August 2026  10:29:41 +0000 (0:00:00.523)       0:00:29.133 *******
2026-08-22 10:29:42.009084 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-22 10:29:42.009490 | instance |
2026-08-22 10:29:42.009529 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-22 10:29:42.009536 | instance | Saturday 22 August 2026  10:29:42 +0000 (0:00:00.049)       0:00:29.183 *******
2026-08-22 10:29:46.595959 | instance | changed: [instance]
2026-08-22 10:29:46.596043 | instance |
2026-08-22 10:29:46.596318 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-22 10:29:46.596371 | instance | Saturday 22 August 2026  10:29:46 +0000 (0:00:04.587)       0:00:33.770 *******
2026-08-22 10:29:47.298044 | instance | ok: [instance] => (item=chronyd)
2026-08-22 10:29:47.298114 | instance | ok: [instance] => (item=sshd)
2026-08-22 10:29:47.298533 | instance |
2026-08-22 10:29:47.298669 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-22 10:29:47.298675 | instance | Saturday 22 August 2026  10:29:47 +0000 (0:00:00.702)       0:00:34.472 *******
2026-08-22 10:29:49.229736 | instance | changed: [instance]
2026-08-22 10:29:49.230271 | instance |
2026-08-22 10:29:49.230322 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-22 10:29:49.230333 | instance | Saturday 22 August 2026  10:29:49 +0000 (0:00:01.931)       0:00:36.403 *******
2026-08-22 10:29:49.426773 | instance | ok: [instance]
2026-08-22 10:29:49.426849 | instance |
2026-08-22 10:29:49.427056 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-22 10:29:49.427095 | instance | Saturday 22 August 2026  10:29:49 +0000 (0:00:00.197)       0:00:36.600 *******
2026-08-22 10:29:49.862329 | instance | changed: [instance]
2026-08-22 10:29:49.862366 | instance |
2026-08-22 10:29:49.862371 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-22 10:29:49.862376 | instance | Saturday 22 August 2026  10:29:49 +0000 (0:00:00.435)       0:00:37.036 *******
2026-08-22 10:29:50.191175 | instance | changed: [instance]
2026-08-22 10:29:50.191244 | instance |
2026-08-22 10:29:50.191547 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-22 10:29:50.191585 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.329)       0:00:37.365 *******
2026-08-22 10:29:50.374394 | instance | ok: [instance]
2026-08-22 10:29:50.374469 | instance |
2026-08-22 10:29:50.374733 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-22 10:29:50.374772 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.183)       0:00:37.548 *******
2026-08-22 10:29:50.586355 | instance | ok: [instance] => (item=instance)
2026-08-22 10:29:50.586432 | instance |
2026-08-22 10:29:50.586802 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-22 10:29:50.586846 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.212)       0:00:37.760 *******
2026-08-22 10:29:50.639767 | instance | ok: [instance]
2026-08-22 10:29:50.639888 | instance |
2026-08-22 10:29:50.640318 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-22 10:29:50.640524 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.052)       0:00:37.813 *******
2026-08-22 10:29:50.706055 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-22 10:29:50.706590 | instance |
2026-08-22 10:29:50.706630 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-22 10:29:50.706637 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.066)       0:00:37.879 *******
2026-08-22 10:29:50.985636 | instance | changed: [instance]
2026-08-22 10:29:50.986270 | instance |
2026-08-22 10:29:50.986308 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-22 10:29:50.986316 | instance | Saturday 22 August 2026  10:29:50 +0000 (0:00:00.279)       0:00:38.159 *******
2026-08-22 10:29:51.683370 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-22 10:29:51.684077 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-22 10:29:51.684116 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-22 10:29:51.684122 | instance |
2026-08-22 10:29:51.684127 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-22 10:29:51.684131 | instance | Saturday 22 August 2026  10:29:51 +0000 (0:00:00.697)       0:00:38.857 *******
2026-08-22 10:31:17.569643 | instance | ok: [instance]
2026-08-22 10:31:17.569727 | instance |
2026-08-22 10:31:17.569903 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-22 10:31:17.570143 | instance | Saturday 22 August 2026  10:31:17 +0000 (0:01:25.886)       0:02:04.743 *******
2026-08-22 10:31:17.785155 | instance | changed: [instance]
2026-08-22 10:31:17.785210 | instance |
2026-08-22 10:31:17.785217 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-22 10:31:17.785224 | instance | Saturday 22 August 2026  10:31:17 +0000 (0:00:00.214)       0:02:04.958 *******
2026-08-22 10:31:17.827543 | instance | ok: [instance]
2026-08-22 10:31:17.827595 | instance |
2026-08-22 10:31:17.827607 | instance | TASK [Install Ceph host] *******************************************************
2026-08-22 10:31:17.827617 | instance | Saturday 22 August 2026  10:31:17 +0000 (0:00:00.042)       0:02:05.000 *******
2026-08-22 10:31:17.910048 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-22 10:31:17.910082 | instance |
2026-08-22 10:31:17.910087 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-22 10:31:17.910091 | instance | Saturday 22 August 2026  10:31:17 +0000 (0:00:00.083)       0:02:05.083 *******
2026-08-22 10:31:19.874631 | instance | ok: [instance]
2026-08-22 10:31:19.874701 | instance |
2026-08-22 10:31:19.874723 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-22 10:31:19.874735 | instance | Saturday 22 August 2026  10:31:19 +0000 (0:00:01.963)       0:02:07.047 *******
2026-08-22 10:31:19.932517 | instance | ok: [instance] => (item=instance)
2026-08-22 10:31:19.932564 | instance |
2026-08-22 10:31:19.932602 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-22 10:31:19.932728 | instance | Saturday 22 August 2026  10:31:19 +0000 (0:00:00.058)       0:02:07.105 *******
2026-08-22 10:31:20.325910 | instance | ok: [instance]
2026-08-22 10:31:20.326200 | instance |
2026-08-22 10:31:20.326454 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-22 10:31:20.326735 | instance | Saturday 22 August 2026  10:31:20 +0000 (0:00:00.393)       0:02:07.499 *******
2026-08-22 10:31:22.668015 | instance | ok: [instance]
2026-08-22 10:31:22.668132 | instance |
2026-08-22 10:31:22.668141 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-22 10:31:22.668147 | instance | Saturday 22 August 2026  10:31:22 +0000 (0:00:02.341)       0:02:09.841 *******
2026-08-22 10:32:09.344245 | 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-22 10:32:09.344976 | 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_hd39q_zs/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_hd39q_zs/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_hd39q_zs/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_hd39q_zs/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-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBLeolqlwkvMSAAGZdPS8y5EZfQdY3c9daB3oc+yv87pDgan9gtN2DRGN4=: Malformed input [buffer:3]\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBLeolqlwkvMSAAGZdPS8y5EZfQdY3c9daB3oc+yv87pDgan9gtN2DRGN4=: Malformed input [buffer:3]\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBLeolqlwkvMSAAGZdPS8y5EZfQdY3c9daB3oc+yv87pDgan9gtN2DRGN4=: Malformed input [buffer:3]\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:32:09.194+0000 7fc95ccd7640 -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-22 10:32:09.346976 | instance |
2026-08-22 10:32:09.347146 | instance | PLAY RECAP *********************************************************************
2026-08-22 10:32:09.348258 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-22 10:32:09.348282 | instance |
2026-08-22 10:32:09.348289 | instance | Saturday 22 August 2026  10:32:09 +0000 (0:00:46.680)       0:02:56.521 *******
2026-08-22 10:32:09.348295 | instance | ===============================================================================
2026-08-22 10:32:09.348300 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 85.89s
2026-08-22 10:32:09.348306 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 46.68s
2026-08-22 10:32:09.351143 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.59s
2026-08-22 10:32:09.351192 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.58s
2026-08-22 10:32:09.351198 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.31s
2026-08-22 10:32:09.351204 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-08-22 10:32:09.351223 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.34s
2026-08-22 10:32:09.351229 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.96s
2026-08-22 10:32:09.351234 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.93s
2026-08-22 10:32:09.351239 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.63s
2026-08-22 10:32:09.351245 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.23s
2026-08-22 10:32:09.351250 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.01s
2026-08-22 10:32:09.351256 | instance | Gathering Facts --------------------------------------------------------- 0.93s
2026-08-22 10:32:09.351261 | instance | Gathering Facts --------------------------------------------------------- 0.91s
2026-08-22 10:32:09.351267 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s
2026-08-22 10:32:09.351272 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.86s
2026-08-22 10:32:09.351278 | instance | Gathering Facts --------------------------------------------------------- 0.85s
2026-08-22 10:32:09.351283 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.81s
2026-08-22 10:32:09.351289 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.70s
2026-08-22 10:32:09.351294 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.70s
2026-08-22 10:32:09.438833 | 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-22 10:32:09.439124 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-22 10:32:09.439315 | 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-22 10:32:09.877500 | instance | ERROR
2026-08-22 10:32:09.877798 | instance | {
2026-08-22 10:32:09.877860 | instance |   "delta": "0:03:44.162112",
2026-08-22 10:32:09.877904 | instance |   "end": "2026-08-22 10:32:09.494146",
2026-08-22 10:32:09.877945 | instance |   "msg": "non-zero return code",
2026-08-22 10:32:09.877984 | instance |   "rc": 2,
2026-08-22 10:32:09.878022 | instance |   "start": "2026-08-22 10:28:25.332034"
2026-08-22 10:32:09.878062 | instance | }
failure
2026-08-22 10:32:09.885869 | 
2026-08-22 10:32:09.885916 | PLAY RECAP
2026-08-22 10:32:09.885961 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-22 10:32:09.885983 | 
2026-08-22 10:32:10.051410 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 10:32:10.057911 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 10:32:10.781616 | 
2026-08-22 10:32:10.781738 | PLAY [all]
2026-08-22 10:32:10.801274 | 
2026-08-22 10:32:10.801395 | TASK [gather-host-logs : creating directory for system status]
2026-08-22 10:32:11.178467 | instance | changed
2026-08-22 10:32:11.186023 | 
2026-08-22 10:32:11.186137 | TASK [gather-host-logs : Get logs for each host]
2026-08-22 10:32:11.530788 | instance | + systemd-cgls --full --all --no-pager
2026-08-22 10:32:11.546210 | instance | + ip addr
2026-08-22 10:32:11.549507 | instance | + ip route
2026-08-22 10:32:11.551297 | instance | + lsblk
2026-08-22 10:32:11.556862 | instance | + mount
2026-08-22 10:32:11.560087 | instance | + docker images
2026-08-22 10:32:11.580882 | instance | + brctl show
2026-08-22 10:32:11.581319 | instance | /bin/bash: line 8: brctl: command not found
2026-08-22 10:32:11.581548 | instance | + ps aux --sort=-%mem
2026-08-22 10:32:11.603029 | instance | + dpkg -l
2026-08-22 10:32:11.613357 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-22 10:32:11.613927 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-22 10:32:11.631248 | instance | + '[' '!' -z '' ']'
2026-08-22 10:32:11.723716 | instance | ok: Runtime: 0:00:00.104988
2026-08-22 10:32:11.731900 | 
2026-08-22 10:32:11.731994 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-22 10:32:12.372679 | instance | changed:
2026-08-22 10:32:12.391907 | instance | created directory /var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/logs/instance
2026-08-22 10:32:12.392025 | instance | cd+++++++++ system/
2026-08-22 10:32:12.392085 | instance | >f+++++++++ system/brctl-show.txt
2026-08-22 10:32:12.392134 | instance | >f+++++++++ system/docker-images.txt
2026-08-22 10:32:12.392190 | instance | >f+++++++++ system/ip-addr.txt
2026-08-22 10:32:12.392251 | instance | >f+++++++++ system/ip-route.txt
2026-08-22 10:32:12.392300 | instance | >f+++++++++ system/lsblk.txt
2026-08-22 10:32:12.392347 | instance | >f+++++++++ system/mount.txt
2026-08-22 10:32:12.392401 | instance | >f+++++++++ system/packages.txt
2026-08-22 10:32:12.392458 | instance | >f+++++++++ system/ps.txt
2026-08-22 10:32:12.392510 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-22 10:32:12.409070 | 
2026-08-22 10:32:12.409169 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 10:32:12.599663 | instance | changed: "values"
2026-08-22 10:32:12.768737 | instance | changed: "releases"
2026-08-22 10:32:12.775554 | 
2026-08-22 10:32:12.775695 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 10:32:12.984032 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-22 10:32:13.313771 | instance | ok: Runtime: 0:00:00.005547
2026-08-22 10:32:13.321046 | 
2026-08-22 10:32:13.321150 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 10:32:13.796136 | instance | changed:
2026-08-22 10:32:13.796287 | instance | cd+++++++++ helm/
2026-08-22 10:32:13.796315 | instance | cd+++++++++ helm/releases/
2026-08-22 10:32:13.796337 | instance | cd+++++++++ helm/values/
2026-08-22 10:32:13.805282 | 
2026-08-22 10:32:13.805348 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 10:32:14.009546 | instance | changed
2026-08-22 10:32:14.016019 | 
2026-08-22 10:32:14.016109 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 10:32:14.256358 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 10:32:14.256433 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 10:32:14.262118 | instance | environment: line 1: kubectl: command not found
2026-08-22 10:32:14.262943 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 10:32:14.263867 | instance | environment: line 1: kubectl: command not found
2026-08-22 10:32:14.264726 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 10:32:14.267121 | instance | environment: line 1: kubectl: command not found
2026-08-22 10:32:14.267908 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 10:32:14.268470 | instance | environment: line 1: kubectl: command not found
2026-08-22 10:32:14.269890 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 10:32:14.270269 | instance | environment: line 1: kubectl: command not found
2026-08-22 10:32:14.271226 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 10:32:14.552740 | instance | ok: Runtime: 0:00:00.023053
2026-08-22 10:32:14.562436 | 
2026-08-22 10:32:14.562695 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 10:32:14.759645 | instance | changed
2026-08-22 10:32:14.767886 | 
2026-08-22 10:32:14.768026 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 10:32:14.973551 | instance | environment: line 5: kubectl: command not found
2026-08-22 10:32:14.974172 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 10:32:14.974204 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 10:32:14.974857 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 10:32:15.302052 | instance | ok: Runtime: 0:00:00.007517
2026-08-22 10:32:15.309122 | 
2026-08-22 10:32:15.309215 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 10:32:15.807634 | instance | changed:
2026-08-22 10:32:15.807833 | instance | cd+++++++++ objects/
2026-08-22 10:32:15.807876 | instance | cd+++++++++ objects/cluster/
2026-08-22 10:32:15.807910 | instance | cd+++++++++ objects/namespaced/
2026-08-22 10:32:15.820427 | 
2026-08-22 10:32:15.820544 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 10:32:16.034194 | instance | changed
2026-08-22 10:32:16.040744 | 
2026-08-22 10:32:16.040855 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 10:32:16.247711 | instance | changed
2026-08-22 10:32:16.255406 | 
2026-08-22 10:32:16.255534 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 10:32:16.482996 | instance | environment: line 3: kubectl: command not found
2026-08-22 10:32:16.792077 | instance | ok: Runtime: 0:00:00.009408
2026-08-22 10:32:16.797939 | 
2026-08-22 10:32:16.798003 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 10:32:17.276496 | instance | changed:
2026-08-22 10:32:17.276698 | instance | cd+++++++++ pod-logs/
2026-08-22 10:32:17.276740 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-22 10:32:17.289462 | 
2026-08-22 10:32:17.289529 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-22 10:32:17.496696 | instance | changed
2026-08-22 10:32:17.501920 | 
2026-08-22 10:32:17.501986 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-22 10:32:17.722330 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 10:32:18.133055 | instance | ok: Runtime: 0:00:00.030779
2026-08-22 10:32:18.140150 | 
2026-08-22 10:32:18.140246 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-22 10:32:18.354097 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 10:32:18.385966 | instance | ceph-mgr endpoints:
2026-08-22 10:32:18.705332 | instance | ok: Runtime: 0:00:00.039199
2026-08-22 10:32:18.712772 | 
2026-08-22 10:32:18.712863 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-22 10:32:18.931944 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-22 10:32:19.247634 | instance | ok: Runtime: 0:00:00.036547
2026-08-22 10:32:19.254832 | 
2026-08-22 10:32:19.254923 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-22 10:32:19.742815 | instance | changed: cd+++++++++ prometheus/
2026-08-22 10:32:19.753355 | 
2026-08-22 10:32:19.753467 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-22 10:32:19.993606 | instance | changed
2026-08-22 10:32:20.002492 | 
2026-08-22 10:32:20.002586 | TASK [gather-selenium-data : Get selenium data]
2026-08-22 10:32:20.264206 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-22 10:32:20.265272 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-22 10:32:20.541256 | instance | ERROR
2026-08-22 10:32:20.541559 | instance | {
2026-08-22 10:32:20.541626 | instance |   "delta": "0:00:00.006286",
2026-08-22 10:32:20.541672 | instance |   "end": "2026-08-22 10:32:20.265661",
2026-08-22 10:32:20.541721 | instance |   "msg": "non-zero return code",
2026-08-22 10:32:20.541765 | instance |   "rc": 1,
2026-08-22 10:32:20.541807 | instance |   "start": "2026-08-22 10:32:20.259375"
2026-08-22 10:32:20.541848 | instance | }
2026-08-22 10:32:20.541900 | instance | ERROR: Ignoring Errors
2026-08-22 10:32:20.546992 | 
2026-08-22 10:32:20.547061 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-22 10:32:21.042465 | instance | changed: cd+++++++++ selenium/
2026-08-22 10:32:21.050318 | 
2026-08-22 10:32:21.050386 | PLAY RECAP
2026-08-22 10:32:21.050444 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-22 10:32:21.050466 | 
2026-08-22 10:32:21.203399 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 10:32:21.213329 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 10:32:22.051522 | 
2026-08-22 10:32:22.051657 | PLAY [all]
2026-08-22 10:32:22.063613 | 
2026-08-22 10:32:22.063692 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 10:32:22.109930 | instance | skipping: Conditional result was False
2026-08-22 10:32:22.118375 | 
2026-08-22 10:32:22.118512 | TASK [fetch-output : Set log path for single node]
2026-08-22 10:32:22.158502 | instance | ok
2026-08-22 10:32:22.163151 | 
2026-08-22 10:32:22.163223 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 10:32:22.763131 | instance -> localhost | ok: "/var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/logs"
2026-08-22 10:32:24.148026 | instance -> localhost | changed: "/var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/artifacts"
2026-08-22 10:32:25.040348 | instance -> localhost | changed: "/var/lib/zuul/builds/964e934fde5a40f8b164b0a495bac163/work/docs"
2026-08-22 10:32:25.052837 | 
2026-08-22 10:32:25.053031 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 10:32:26.415726 | instance | changed: .d..t...... ./
2026-08-22 10:32:26.415988 | instance | changed: All items complete
2026-08-22 10:32:26.416035 | 
2026-08-22 10:32:26.908313 | instance | changed: .d..t...... ./
2026-08-22 10:32:27.371187 | instance | changed: .d..t...... ./
2026-08-22 10:32:27.400120 | 
2026-08-22 10:32:27.400317 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 10:32:27.841991 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.027761
2026-08-22 10:32:28.337124 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007472
2026-08-22 10:32:28.352484 | 
2026-08-22 10:32:28.352622 | PLAY [all]
2026-08-22 10:32:28.359115 | 
2026-08-22 10:32:28.359189 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 10:32:28.971542 | instance | changed
2026-08-22 10:32:28.979209 | 
2026-08-22 10:32:28.979280 | PLAY RECAP
2026-08-22 10:32:28.979333 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 10:32:28.979355 | 
2026-08-22 10:32:29.094998 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 10:32:29.099568 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 10:32:32.030519 | 
2026-08-22 10:32:32.292087 | PLAY [localhost]
2026-08-22 10:32:32.311810 | 
2026-08-22 10:32:32.312223 | TASK [Generate Zuul manifest]
2026-08-22 10:32:32.332542 | localhost | ok
2026-08-22 10:32:32.681709 | 
2026-08-22 10:32:32.681902 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 10:32:33.801641 | localhost | changed
2026-08-22 10:32:33.818373 | 
2026-08-22 10:32:33.818466 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 10:32:33.852197 | localhost | ok
2026-08-22 10:32:33.862523 | 
2026-08-22 10:32:33.862611 | TASK [Upload logs]
2026-08-22 10:32:33.885450 | localhost | ok
2026-08-22 10:32:34.306746 | 
2026-08-22 10:32:34.306880 | TASK [Set zuul-log-path fact]
2026-08-22 10:32:34.326922 | localhost | ok
2026-08-22 10:32:34.354055 | 
2026-08-22 10:32:34.354179 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 10:32:34.386805 | localhost | ok
2026-08-22 10:32:34.397794 | 
2026-08-22 10:32:34.397925 | TASK [upload-logs : Create log directories]
2026-08-22 10:32:34.979536 | localhost | changed
2026-08-22 10:32:34.986074 | 
2026-08-22 10:32:34.986144 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 10:32:35.447158 | localhost -> localhost | ok: Runtime: 0:00:00.027022
2026-08-22 10:32:35.452993 | 
2026-08-22 10:32:35.453075 | TASK [upload-logs : Upload logs to log server]
2026-08-22 10:32:36.945636 | localhost | Output suppressed because no_log was given
2026-08-22 10:32:37.013862 | 
2026-08-22 10:32:37.014044 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 10:32:37.061561 | localhost | skipping: Conditional result was False
2026-08-22 10:32:37.068660 | localhost | skipping: Conditional result was False
2026-08-22 10:32:37.078541 | 
2026-08-22 10:32:37.078736 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 10:32:37.119649 | localhost | skipping: Conditional result was False
2026-08-22 10:32:37.120086 | 
2026-08-22 10:32:37.123896 | localhost | skipping: Conditional result was False
2026-08-22 10:32:37.134525 | 
2026-08-22 10:32:37.134683 | LOOP [upload-logs : Upload console log and json output]