2026-08-24 19:34:09.614404 | Job console starting
2026-08-24 19:34:09.622587 | Updating git repos
2026-08-24 19:34:12.567683 | Cloning repos into workspace
2026-08-24 19:34:30.123654 | Restoring repo states
2026-08-24 19:34:41.166096 | Merging changes
2026-08-24 19:34:43.470956 | Checking out repos
2026-08-24 19:34:45.315564 | Preparing playbooks
2026-08-24 19:34:47.821365 | Running Ansible setup
2026-08-24 19:34:51.494067 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 19:34:52.152769 | 
2026-08-24 19:34:52.152993 | PLAY [localhost]
2026-08-24 19:34:52.162883 | 
2026-08-24 19:34:52.162958 | TASK [Gathering Facts]
2026-08-24 19:34:53.053373 | localhost | ok
2026-08-24 19:34:53.064194 | 
2026-08-24 19:34:53.064271 | TASK [Setup log path fact]
2026-08-24 19:34:53.085908 | localhost | ok
2026-08-24 19:34:53.099733 | 
2026-08-24 19:34:53.099798 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 19:34:53.130209 | localhost | ok
2026-08-24 19:34:53.139906 | 
2026-08-24 19:34:53.139974 | TASK [emit-job-header : Print job information]
2026-08-24 19:34:53.181319 | # Job Information
2026-08-24 19:34:53.181540 | Ansible Version: 2.16.18
2026-08-24 19:34:53.181610 | Job: atmosphere-molecule-csi-rbd
2026-08-24 19:34:53.181658 | Pipeline: check
2026-08-24 19:34:53.181702 | Executor: 2d72f0692154
2026-08-24 19:34:53.181743 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4343
2026-08-24 19:34:53.181791 | Event ID: aa3407a0-9ff0-11f1-995d-d88ebe1a1492
2026-08-24 19:34:53.185938 | 
2026-08-24 19:34:53.186005 | LOOP [emit-job-header : Print node information]
2026-08-24 19:34:53.278342 | localhost | ok:
2026-08-24 19:34:53.278558 | localhost | # Node Information
2026-08-24 19:34:53.278598 | localhost | Inventory Hostname: instance
2026-08-24 19:34:53.278629 | localhost | Hostname: np0000190989
2026-08-24 19:34:53.278656 | localhost | Username: zuul
2026-08-24 19:34:53.278688 | localhost | Distro: Ubuntu 22.04
2026-08-24 19:34:53.278715 | localhost | Provider: yul1
2026-08-24 19:34:53.278741 | localhost | Region: ca-ymq-1
2026-08-24 19:34:53.278766 | localhost | Label: ubuntu-jammy
2026-08-24 19:34:53.278791 | localhost | Product Name: OpenStack Nova
2026-08-24 19:34:53.278817 | localhost | Interface IP: 199.204.45.113
2026-08-24 19:34:53.296399 | 
2026-08-24 19:34:53.296525 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 19:34:53.681956 | localhost -> localhost | changed
2026-08-24 19:34:53.688758 | 
2026-08-24 19:34:53.688912 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 19:34:54.523988 | localhost -> localhost | changed
2026-08-24 19:34:54.533077 | 
2026-08-24 19:34:54.533150 | PLAY [all]
2026-08-24 19:34:54.542329 | 
2026-08-24 19:34:54.542393 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 19:34:54.778372 | instance -> localhost | ok
2026-08-24 19:34:54.784511 | 
2026-08-24 19:34:54.784579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 19:34:54.818532 | instance | ok
2026-08-24 19:34:54.834770 | instance | included: /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 19:34:54.840245 | 
2026-08-24 19:34:54.840303 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 19:34:55.415652 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 19:34:55.415852 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/fb40865aaece4b06972af28d13861f31_id_rsa
2026-08-24 19:34:55.415894 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/fb40865aaece4b06972af28d13861f31_id_rsa.pub
2026-08-24 19:34:55.415927 | instance -> localhost | The key fingerprint is:
2026-08-24 19:34:55.415957 | instance -> localhost | SHA256:DHyfWYM0wKZDCNDLdLUDfD01rwelcUh/vJXTCMuuUlI zuul-build-sshkey
2026-08-24 19:34:55.416003 | instance -> localhost | The key's randomart image is:
2026-08-24 19:34:55.416034 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 19:34:55.416064 | instance -> localhost | |.o.o.o.o.+B.+    |
2026-08-24 19:34:55.416093 | instance -> localhost | |  o +oo.=..% + .o|
2026-08-24 19:34:55.416121 | instance -> localhost | | o o o=o..E B +oo|
2026-08-24 19:34:55.416149 | instance -> localhost | |  o   o= o B o o.|
2026-08-24 19:34:55.416175 | instance -> localhost | |       .S * o .  |
2026-08-24 19:34:55.416202 | instance -> localhost | |         o o     |
2026-08-24 19:34:55.416228 | instance -> localhost | |        . .      |
2026-08-24 19:34:55.416255 | instance -> localhost | |         .       |
2026-08-24 19:34:55.416286 | instance -> localhost | |                 |
2026-08-24 19:34:55.416313 | instance -> localhost | +----[SHA256]-----+
2026-08-24 19:34:55.416378 | instance -> localhost | ok: Runtime: 0:00:00.197228
2026-08-24 19:34:55.424911 | 
2026-08-24 19:34:55.425029 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 19:34:55.456789 | instance | ok
2026-08-24 19:34:55.467442 | instance | included: /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 19:34:55.474782 | 
2026-08-24 19:34:55.474844 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 19:34:55.489759 | instance | skipping: Conditional result was False
2026-08-24 19:34:55.499486 | 
2026-08-24 19:34:55.499575 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 19:34:56.029193 | instance | changed
2026-08-24 19:34:56.038964 | 
2026-08-24 19:34:56.039069 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 19:34:56.225703 | instance | ok
2026-08-24 19:34:56.230581 | 
2026-08-24 19:34:56.230646 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 19:34:56.678588 | instance | changed
2026-08-24 19:34:56.685801 | 
2026-08-24 19:34:56.685911 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 19:34:57.131672 | instance | changed
2026-08-24 19:34:57.141190 | 
2026-08-24 19:34:57.141292 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 19:34:57.167266 | instance | skipping: Conditional result was False
2026-08-24 19:34:57.174822 | 
2026-08-24 19:34:57.174912 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 19:34:57.532854 | instance -> localhost | changed
2026-08-24 19:34:57.542991 | 
2026-08-24 19:34:57.543053 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 19:34:57.817996 | instance -> localhost | Identity added: /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/fb40865aaece4b06972af28d13861f31_id_rsa (zuul-build-sshkey)
2026-08-24 19:34:57.818226 | instance -> localhost | ok: Runtime: 0:00:00.015068
2026-08-24 19:34:57.825569 | 
2026-08-24 19:34:57.825654 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 19:34:58.165570 | instance | ok
2026-08-24 19:34:58.171375 | 
2026-08-24 19:34:58.171471 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 19:34:58.197984 | instance | skipping: Conditional result was False
2026-08-24 19:34:58.213782 | 
2026-08-24 19:34:58.213884 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 19:34:58.564707 | instance | ok
2026-08-24 19:34:58.571122 | 
2026-08-24 19:34:58.571200 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 19:35:01.984851 | instance | Output suppressed because no_log was given
2026-08-24 19:35:01.996927 | 
2026-08-24 19:35:01.997007 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 19:35:02.174396 | instance | ok: "logs"
2026-08-24 19:35:02.174635 | instance | ok: All items complete
2026-08-24 19:35:02.174662 | 
2026-08-24 19:35:02.326720 | instance | ok: "artifacts"
2026-08-24 19:35:02.472338 | instance | ok: "docs"
2026-08-24 19:35:02.489434 | 
2026-08-24 19:35:02.489564 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 19:35:02.675712 | instance | changed: "logs"
2026-08-24 19:35:02.840898 | instance | changed: "artifacts"
2026-08-24 19:35:02.995515 | instance | changed: "docs"
2026-08-24 19:35:03.012152 | 
2026-08-24 19:35:03.012202 | PLAY RECAP
2026-08-24 19:35:03.012243 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 19:35:03.012271 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 19:35:03.012292 | 
2026-08-24 19:35:03.131027 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 19:35:03.135121 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 19:35:03.700979 | 
2026-08-24 19:35:03.701102 | PLAY [all]
2026-08-24 19:35:03.711415 | 
2026-08-24 19:35:03.711494 | TASK [setup-uv : Extract archive]
2026-08-24 19:35:05.951486 | instance | changed
2026-08-24 19:35:05.960276 | 
2026-08-24 19:35:05.960420 | TASK [setup-uv : Print version]
2026-08-24 19:35:06.301810 | instance | uv 0.8.13
2026-08-24 19:35:06.505650 | instance | ok: Runtime: 0:00:00.011823
2026-08-24 19:35:06.518246 | 
2026-08-24 19:35:06.518315 | TASK [Install Ansible collection siblings]
2026-08-24 19:35:15.276162 | instance | changed:
2026-08-24 19:35:15.276370 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 19:35:15.276411 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 19:35:15.276442 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 19:35:15.276471 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 19:35:15.276499 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 19:35:15.276530 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 19:35:15.276559 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 19:35:15.276590 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 19:35:15.276618 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 19:35:15.276645 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 19:35:15.276673 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 19:35:15.276699 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 19:35:15.276725 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 19:35:15.276752 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 19:35:15.276778 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 19:35:15.276805 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 19:35:15.276831 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 19:35:15.276857 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 19:35:15.276882 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 19:35:15.276910 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 19:35:15.276938 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-24 19:35:15.276988 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 19:35:15.277017 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 19:35:15.277059 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 19:35:15.277087 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 19:35:15.277113 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 19:35:15.277140 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 19:35:15.277166 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 19:35:15.277191 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 19:35:15.277216 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 19:35:15.277241 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 19:35:15.277267 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 19:35:15.277293 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 19:35:15.277318 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 19:35:15.277353 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.277379 | instance | Process install dependency map
2026-08-24 19:35:15.277405 | instance | Starting collection install process
2026-08-24 19:35:15.277430 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 19:35:15.277456 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 19:35:15.277481 | instance | ansible.netcommon:* was installed successfully
2026-08-24 19:35:15.277506 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 19:35:15.277531 | instance | Creating virtual environment at: .venv
2026-08-24 19:35:15.277556 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 19:35:15.277581 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 19:35:15.277606 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 19:35:15.277632 | instance | Downloading netaddr (2.2MiB)
2026-08-24 19:35:15.277657 | instance | Downloading setuptools (1.1MiB)
2026-08-24 19:35:15.277682 | instance | Downloading pygments (1.2MiB)
2026-08-24 19:35:15.277707 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 19:35:15.277732 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 19:35:15.277758 | instance | Downloading pydantic-core (2.0MiB)
2026-08-24 19:35:15.277783 | instance | Downloading cryptography (4.2MiB)
2026-08-24 19:35:15.277808 | instance |    Building pyperclip==1.9.0
2026-08-24 19:35:15.277836 | instance |  Downloading rjsonnet
2026-08-24 19:35:15.277883 | instance |  Downloading pydantic-core
2026-08-24 19:35:15.277909 | instance |  Downloading netaddr
2026-08-24 19:35:15.277935 | instance |  Downloading pygments
2026-08-24 19:35:15.277961 | instance |  Downloading cryptography
2026-08-24 19:35:15.277986 | instance |  Downloading setuptools
2026-08-24 19:35:15.278011 | instance |  Downloading kubernetes
2026-08-24 19:35:15.278036 | instance |  Downloading ansible-core
2026-08-24 19:35:15.278062 | instance |  Downloading openstacksdk
2026-08-24 19:35:15.278087 | instance |       Built pyperclip==1.9.0
2026-08-24 19:35:15.278113 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 19:35:15.278138 | instance | Installed 83 packages in 46ms
2026-08-24 19:35:15.278163 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 19:35:15.278189 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 19:35:15.278214 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.278239 | instance | Process install dependency map
2026-08-24 19:35:15.278273 | instance | Starting collection install process
2026-08-24 19:35:15.278300 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 19:35:15.278325 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 19:35:15.278350 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 19:35:15.278376 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.278401 | instance | 2.17.12
2026-08-24 19:35:15.278426 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 19:35:15.278451 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 19:35:15.278477 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.278503 | instance | Process install dependency map
2026-08-24 19:35:15.278528 | instance | Starting collection install process
2026-08-24 19:35:15.278553 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 19:35:15.278579 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 19:35:15.278605 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 19:35:15.278631 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.278656 | instance | 2.17.12
2026-08-24 19:35:15.278681 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 19:35:15.278706 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 19:35:15.278732 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.278757 | instance | Process install dependency map
2026-08-24 19:35:15.278782 | instance | Starting collection install process
2026-08-24 19:35:15.278807 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 19:35:15.278833 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 19:35:15.278858 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 19:35:15.278884 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.278909 | instance | 2.17.12
2026-08-24 19:35:15.278934 | instance | Checked out community.crypto to 2.2.3
2026-08-24 19:35:15.278963 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 19:35:15.278991 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.279016 | instance | Process install dependency map
2026-08-24 19:35:15.279041 | instance | Starting collection install process
2026-08-24 19:35:15.279066 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 19:35:15.279091 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 19:35:15.279116 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 19:35:15.279141 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.279167 | instance | 2.17.12
2026-08-24 19:35:15.279192 | instance | Checked out community.general to 7.3.0
2026-08-24 19:35:15.279218 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 19:35:15.279249 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.279276 | instance | Process install dependency map
2026-08-24 19:35:15.279303 | instance | Starting collection install process
2026-08-24 19:35:15.279328 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 19:35:15.279354 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 19:35:15.279379 | instance | community.general:7.3.0 was installed successfully
2026-08-24 19:35:15.279404 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.279431 | instance | 2.17.12
2026-08-24 19:35:15.279457 | instance | Checked out community.mysql to 3.6.0
2026-08-24 19:35:15.279486 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 19:35:15.279513 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.279539 | instance | Process install dependency map
2026-08-24 19:35:15.279565 | instance | Starting collection install process
2026-08-24 19:35:15.279591 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 19:35:15.279616 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 19:35:15.279641 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 19:35:15.279667 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.279692 | instance | 2.17.12
2026-08-24 19:35:15.279717 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 19:35:15.279743 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 19:35:15.279769 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.279794 | instance | Process install dependency map
2026-08-24 19:35:15.279820 | instance | Starting collection install process
2026-08-24 19:35:15.279845 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 19:35:15.279871 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 19:35:15.279897 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 19:35:15.279922 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.279947 | instance | 2.17.12
2026-08-24 19:35:15.279976 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 19:35:15.280002 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 19:35:15.280027 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.280052 | instance | Process install dependency map
2026-08-24 19:35:15.280077 | instance | Starting collection install process
2026-08-24 19:35:15.280102 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 19:35:15.280127 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 19:35:15.280152 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 19:35:15.280177 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.280202 | instance | 2.17.12
2026-08-24 19:35:15.280233 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 19:35:15.280260 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 19:35:15.280286 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.280311 | instance | Process install dependency map
2026-08-24 19:35:15.280337 | instance | Starting collection install process
2026-08-24 19:35:15.280362 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 19:35:15.280389 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 19:35:15.280414 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 19:35:15.280440 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.280465 | instance | 2.17.12
2026-08-24 19:35:15.280489 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 19:35:15.280514 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 19:35:15.280539 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.280565 | instance | Process install dependency map
2026-08-24 19:35:15.280591 | instance | Starting collection install process
2026-08-24 19:35:15.280616 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 19:35:15.280642 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 19:35:15.280668 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 19:35:15.280694 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.280720 | instance | 2.17.12
2026-08-24 19:35:15.280746 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 19:35:15.280772 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 19:35:15.280799 | instance | Starting galaxy collection install process
2026-08-24 19:35:15.280824 | instance | Process install dependency map
2026-08-24 19:35:15.280850 | instance | Starting collection install process
2026-08-24 19:35:15.280875 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 19:35:15.280901 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 19:35:15.280926 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 19:35:15.280970 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 19:35:15.281000 | instance | 2.17.12
2026-08-24 19:35:15.288409 | 
2026-08-24 19:35:15.288455 | PLAY RECAP
2026-08-24 19:35:15.288500 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 19:35:15.288522 | 
2026-08-24 19:35:15.397726 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 19:35:15.401782 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 19:35:15.978699 | 
2026-08-24 19:35:15.978819 | PLAY [all]
2026-08-24 19:35:15.989968 | 
2026-08-24 19:35:15.990040 | TASK [Install "jq" for log collection]
2026-08-24 19:35:26.584826 | instance | changed
2026-08-24 19:35:26.586925 | 
2026-08-24 19:35:26.586983 | PLAY RECAP
2026-08-24 19:35:26.587057 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 19:35:26.587118 | 
2026-08-24 19:35:26.696007 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 19:35:26.700553 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 19:35:27.277820 | 
2026-08-24 19:35:27.277932 | PLAY [all]
2026-08-24 19:35:27.289007 | 
2026-08-24 19:35:27.289083 | LOOP [Check inventory directories]
2026-08-24 19:35:27.625559 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 19:35:27.767086 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 19:35:27.920422 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 19:35:27.933116 | 
2026-08-24 19:35:27.933270 | LOOP [Copy inventory file for Zuul]
2026-08-24 19:35:28.742161 | instance | changed:
2026-08-24 19:35:28.742423 | instance | {
2026-08-24 19:35:28.742451 | instance |   "ansible_loop_var": "item",
2026-08-24 19:35:28.742481 | instance |   "changed": false,
2026-08-24 19:35:28.742604 | instance |   "failed": false,
2026-08-24 19:35:28.742642 | instance |   "invocation": {
2026-08-24 19:35:28.742662 | instance |     "module_args": {
2026-08-24 19:35:28.742680 | instance |       "checksum_algorithm": "sha1",
2026-08-24 19:35:28.742699 | instance |       "follow": true,
2026-08-24 19:35:28.742718 | instance |       "get_attributes": true,
2026-08-24 19:35:28.742737 | instance |       "get_checksum": true,
2026-08-24 19:35:28.742755 | instance |       "get_mime": true,
2026-08-24 19:35:28.742773 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 19:35:28.742791 | instance |     }
2026-08-24 19:35:28.742809 | instance |   },
2026-08-24 19:35:28.742827 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 19:35:28.742844 | instance |   "stat": {
2026-08-24 19:35:28.742862 | instance |     "atime": 1787600108.3600326,
2026-08-24 19:35:28.742880 | instance |     "attr_flags": "e",
2026-08-24 19:35:28.742898 | instance |     "attributes": [
2026-08-24 19:35:28.742915 | instance |       "extents"
2026-08-24 19:35:28.742932 | instance |     ],
2026-08-24 19:35:28.742950 | instance |     "block_size": 4096,
2026-08-24 19:35:28.742966 | instance |     "blocks": 8,
2026-08-24 19:35:28.742984 | instance |     "charset": "unknown",
2026-08-24 19:35:28.743003 | instance |     "ctime": 1787600107.3079364,
2026-08-24 19:35:28.743020 | instance |     "dev": 64513,
2026-08-24 19:35:28.743038 | instance |     "device_type": 0,
2026-08-24 19:35:28.743055 | instance |     "executable": true,
2026-08-24 19:35:28.743072 | instance |     "exists": true,
2026-08-24 19:35:28.743089 | instance |     "gid": 1000,
2026-08-24 19:35:28.743106 | instance |     "gr_name": "zuul",
2026-08-24 19:35:28.743123 | instance |     "inode": 1048019,
2026-08-24 19:35:28.743140 | instance |     "isblk": false,
2026-08-24 19:35:28.743157 | instance |     "ischr": false,
2026-08-24 19:35:28.743175 | instance |     "isdir": true,
2026-08-24 19:35:28.743192 | instance |     "isfifo": false,
2026-08-24 19:35:28.743209 | instance |     "isgid": false,
2026-08-24 19:35:28.743226 | instance |     "islnk": false,
2026-08-24 19:35:28.743244 | instance |     "isreg": false,
2026-08-24 19:35:28.743261 | instance |     "issock": false,
2026-08-24 19:35:28.743277 | instance |     "isuid": false,
2026-08-24 19:35:28.743294 | instance |     "mimetype": "unknown",
2026-08-24 19:35:28.743311 | instance |     "mode": "0755",
2026-08-24 19:35:28.743327 | instance |     "mtime": 1787600107.3079364,
2026-08-24 19:35:28.743344 | instance |     "nlink": 22,
2026-08-24 19:35:28.743361 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 19:35:28.743378 | instance |     "pw_name": "zuul",
2026-08-24 19:35:28.743399 | instance |     "readable": true,
2026-08-24 19:35:28.743416 | instance |     "rgrp": true,
2026-08-24 19:35:28.743433 | instance |     "roth": true,
2026-08-24 19:35:28.743465 | instance |     "rusr": true,
2026-08-24 19:35:28.743483 | instance |     "size": 4096,
2026-08-24 19:35:28.743501 | instance |     "uid": 1000,
2026-08-24 19:35:28.743518 | instance |     "version": "3292286009",
2026-08-24 19:35:28.743535 | instance |     "wgrp": false,
2026-08-24 19:35:28.743554 | instance |     "woth": false,
2026-08-24 19:35:28.743572 | instance |     "writeable": true,
2026-08-24 19:35:28.743589 | instance |     "wusr": true,
2026-08-24 19:35:28.743607 | instance |     "xgrp": true,
2026-08-24 19:35:28.743624 | instance |     "xoth": true,
2026-08-24 19:35:28.743641 | instance |     "xusr": true
2026-08-24 19:35:28.743658 | instance |   }
2026-08-24 19:35:28.743676 | instance | }
2026-08-24 19:35:28.743712 | instance | ok: All items complete
2026-08-24 19:35:28.743734 | 
2026-08-24 19:35:28.745165 | instance | skipping: Conditional result was False
2026-08-24 19:35:28.745768 | instance | skipping: Conditional result was False
2026-08-24 19:35:28.765580 | 
2026-08-24 19:35:28.765740 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 19:35:29.095764 | instance | changed: 1 replacements made
2026-08-24 19:35:29.097294 | instance | skipping: Conditional result was False
2026-08-24 19:35:29.097927 | instance | skipping: Conditional result was False
2026-08-24 19:35:29.117155 | 
2026-08-24 19:35:29.117398 | TASK [Run Molecule scenario]
2026-08-24 19:35:30.054114 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 19:35:30.487682 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 19:35:30.487776 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 19:35:41.343543 | instance | INFO     [csi > dependency] Executing
2026-08-24 19:35:41.343670 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 19:35:41.343910 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 19:35:41.343973 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 19:35:41.351559 | instance | INFO     [csi > cleanup] Executing
2026-08-24 19:35:41.351834 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 19:35:41.359267 | instance | INFO     [csi > destroy] Executing
2026-08-24 19:35:41.359306 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 19:35:41.359381 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 19:35:41.366873 | instance | INFO     [csi > syntax] Executing
2026-08-24 19:35:42.914593 | instance |
2026-08-24 19:35:42.914877 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 19:35:42.973620 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 19:35:42.983460 | instance | INFO     [csi > create] Executing
2026-08-24 19:35:42.986019 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 19:35:42.994382 | instance | INFO     [csi > prepare] Executing
2026-08-24 19:35:43.808942 | instance |
2026-08-24 19:35:43.809068 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 19:35:43.809329 | instance |
2026-08-24 19:35:43.809688 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 19:35:43.809963 | instance | Monday 24 August 2026  19:35:43 +0000 (0:00:00.023)       0:00:00.023 *********
2026-08-24 19:35:44.923438 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 19:35:44.923693 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 19:35:44.923994 | instance | interpreter could change the meaning of that path. See
2026-08-24 19:35:44.924290 | instance | https://docs.ansible.com/ansible-
2026-08-24 19:35:44.924715 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 19:35:44.936318 | instance | ok: [instance]
2026-08-24 19:35:44.936472 | instance |
2026-08-24 19:35:44.936660 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 19:35:44.936829 | instance | Monday 24 August 2026  19:35:44 +0000 (0:00:01.128)       0:00:01.151 *********
2026-08-24 19:35:46.445710 | instance | changed: [instance]
2026-08-24 19:35:46.446025 | instance |
2026-08-24 19:35:46.446331 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 19:35:46.446635 | instance | Monday 24 August 2026  19:35:46 +0000 (0:00:01.509)       0:00:02.660 *********
2026-08-24 19:35:46.701712 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 19:35:46.701979 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 19:35:46.702260 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 19:35:46.711682 | instance | changed: [instance]
2026-08-24 19:35:46.711941 | instance |
2026-08-24 19:35:46.712213 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 19:35:46.712485 | instance | Monday 24 August 2026  19:35:46 +0000 (0:00:00.265)       0:00:02.926 *********
2026-08-24 19:35:47.463910 | instance | ok: [instance]
2026-08-24 19:35:47.464174 | instance |
2026-08-24 19:35:47.464469 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 19:35:47.464732 | instance |
2026-08-24 19:35:47.465023 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 19:35:47.465313 | instance | Monday 24 August 2026  19:35:47 +0000 (0:00:00.751)       0:00:03.678 *********
2026-08-24 19:35:48.148561 | instance | ok: [instance]
2026-08-24 19:35:48.148684 | instance |
2026-08-24 19:35:48.148916 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 19:35:48.149098 | instance | Monday 24 August 2026  19:35:48 +0000 (0:00:00.685)       0:00:04.364 *********
2026-08-24 19:36:09.018315 | instance | changed: [instance]
2026-08-24 19:36:09.018533 | instance |
2026-08-24 19:36:09.018793 | instance | TASK [Start up service] ********************************************************
2026-08-24 19:36:09.019058 | instance | Monday 24 August 2026  19:36:09 +0000 (0:00:20.869)       0:00:25.233 *********
2026-08-24 19:36:09.599566 | instance | ok: [instance]
2026-08-24 19:36:09.599816 | instance |
2026-08-24 19:36:09.600093 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 19:36:09.600363 | instance | Monday 24 August 2026  19:36:09 +0000 (0:00:00.581)       0:00:25.814 *********
2026-08-24 19:36:09.904817 | instance | ok: [instance]
2026-08-24 19:36:09.905057 | instance |
2026-08-24 19:36:09.905331 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 19:36:09.905637 | instance | Monday 24 August 2026  19:36:09 +0000 (0:00:00.305)       0:00:26.120 *********
2026-08-24 19:36:10.550813 | instance | changed: [instance]
2026-08-24 19:36:10.551344 | instance |
2026-08-24 19:36:10.551387 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 19:36:10.551396 | instance | Monday 24 August 2026  19:36:10 +0000 (0:00:00.646)       0:00:26.766 *********
2026-08-24 19:36:10.731606 | instance | ok: [instance]
2026-08-24 19:36:10.732108 | instance |
2026-08-24 19:36:10.732155 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 19:36:10.732163 | instance | Monday 24 August 2026  19:36:10 +0000 (0:00:00.180)       0:00:26.947 *********
2026-08-24 19:36:10.758325 | instance | skipping: [instance]
2026-08-24 19:36:10.759125 | instance |
2026-08-24 19:36:10.759168 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 19:36:10.759180 | instance | Monday 24 August 2026  19:36:10 +0000 (0:00:00.026)       0:00:26.973 *********
2026-08-24 19:36:11.281663 | instance | changed: [instance] => (item=osd0)
2026-08-24 19:36:11.281738 | instance | changed: [instance] => (item=osd1)
2026-08-24 19:36:11.281749 | instance | changed: [instance] => (item=osd2)
2026-08-24 19:36:11.281759 | instance |
2026-08-24 19:36:11.281801 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 19:36:11.282141 | instance | Monday 24 August 2026  19:36:11 +0000 (0:00:00.522)       0:00:27.495 *********
2026-08-24 19:36:11.860444 | instance | changed: [instance] => (item=osd0)
2026-08-24 19:36:11.861266 | instance | changed: [instance] => (item=osd1)
2026-08-24 19:36:11.861312 | instance | changed: [instance] => (item=osd2)
2026-08-24 19:36:11.861320 | instance |
2026-08-24 19:36:11.861327 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 19:36:11.861333 | instance | Monday 24 August 2026  19:36:11 +0000 (0:00:00.580)       0:00:28.075 *********
2026-08-24 19:36:12.507414 | instance | changed: [instance] => (item=osd0)
2026-08-24 19:36:12.508266 | instance | changed: [instance] => (item=osd1)
2026-08-24 19:36:12.508286 | instance | changed: [instance] => (item=osd2)
2026-08-24 19:36:12.508293 | instance |
2026-08-24 19:36:12.508300 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 19:36:12.508306 | instance | Monday 24 August 2026  19:36:12 +0000 (0:00:00.646)       0:00:28.722 *********
2026-08-24 19:36:15.604153 | instance | changed: [instance] => (item=osd0)
2026-08-24 19:36:15.604280 | instance | changed: [instance] => (item=osd1)
2026-08-24 19:36:15.604980 | instance | changed: [instance] => (item=osd2)
2026-08-24 19:36:15.605022 | instance |
2026-08-24 19:36:15.605030 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 19:36:15.605037 | instance | Monday 24 August 2026  19:36:15 +0000 (0:00:03.096)       0:00:31.819 *********
2026-08-24 19:36:17.418023 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 19:36:17.418065 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 19:36:17.421542 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 19:36:17.421559 | instance |
2026-08-24 19:36:17.421568 | instance | PLAY RECAP *********************************************************************
2026-08-24 19:36:17.421574 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 19:36:17.421580 | instance |
2026-08-24 19:36:17.421586 | instance | Monday 24 August 2026  19:36:17 +0000 (0:00:01.813)       0:00:33.633 *********
2026-08-24 19:36:17.421592 | instance | ===============================================================================
2026-08-24 19:36:17.421597 | instance | Install depedencies ---------------------------------------------------- 20.87s
2026-08-24 19:36:17.421603 | instance | Create a volume group for each loop device ------------------------------ 3.10s
2026-08-24 19:36:17.421608 | instance | Create a logical volume for each loop device ---------------------------- 1.81s
2026-08-24 19:36:17.421614 | instance | Configure short hostname ------------------------------------------------ 1.51s
2026-08-24 19:36:17.421620 | instance | Gathering Facts --------------------------------------------------------- 1.13s
2026-08-24 19:36:17.421625 | instance | Purge "snapd" package --------------------------------------------------- 0.75s
2026-08-24 19:36:17.421630 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-24 19:36:17.421636 | instance | Start loop devices ------------------------------------------------------ 0.65s
2026-08-24 19:36:17.421705 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-24 19:36:17.421943 | instance | Start up service -------------------------------------------------------- 0.58s
2026-08-24 19:36:17.422148 | instance | Set permissions on loopback devices ------------------------------------- 0.58s
2026-08-24 19:36:17.422348 | instance | Create devices for Ceph ------------------------------------------------- 0.52s
2026-08-24 19:36:17.422549 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-08-24 19:36:17.422752 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s
2026-08-24 19:36:17.422951 | instance | Get list of all loopback devices ---------------------------------------- 0.18s
2026-08-24 19:36:17.423152 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-24 19:36:17.482666 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 19:36:17.498290 | instance | INFO     [csi > converge] Executing
2026-08-24 19:36:18.980907 | instance |
2026-08-24 19:36:18.981338 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 19:36:18.981703 | instance |
2026-08-24 19:36:18.982040 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 19:36:18.982391 | instance | Monday 24 August 2026  19:36:18 +0000 (0:00:00.007)       0:00:00.007 *********
2026-08-24 19:36:19.985163 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 19:36:19.985600 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 19:36:19.985942 | instance | interpreter could change the meaning of that path. See
2026-08-24 19:36:19.986274 | instance | https://docs.ansible.com/ansible-
2026-08-24 19:36:19.986606 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 19:36:19.995685 | instance | ok: [instance]
2026-08-24 19:36:19.996005 | instance |
2026-08-24 19:36:19.996334 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 19:36:19.996661 | instance | Monday 24 August 2026  19:36:19 +0000 (0:00:01.014)       0:00:01.022 *********
2026-08-24 19:36:20.040835 | instance | ok: [instance] => {
2026-08-24 19:36:20.041203 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 19:36:20.041579 | instance | }
2026-08-24 19:36:20.041911 | instance |
2026-08-24 19:36:20.042249 | instance | PLAY [all] *********************************************************************
2026-08-24 19:36:20.042571 | instance |
2026-08-24 19:36:20.042974 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 19:36:20.043351 | instance | Monday 24 August 2026  19:36:20 +0000 (0:00:00.045)       0:00:01.067 *********
2026-08-24 19:36:20.883794 | instance | ok: [instance]
2026-08-24 19:36:20.884166 | instance |
2026-08-24 19:36:20.884506 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-24 19:36:20.884836 | instance | Monday 24 August 2026  19:36:20 +0000 (0:00:00.842)       0:00:01.910 *********
2026-08-24 19:36:20.929194 | instance | skipping: [instance]
2026-08-24 19:36:20.929568 | instance |
2026-08-24 19:36:20.929912 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 19:36:20.930250 | instance | Monday 24 August 2026  19:36:20 +0000 (0:00:00.045)       0:00:01.955 *********
2026-08-24 19:36:21.112030 | instance | ok: [instance]
2026-08-24 19:36:21.112426 | instance |
2026-08-24 19:36:21.112781 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 19:36:21.113105 | instance |
2026-08-24 19:36:21.113449 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 19:36:21.113861 | instance | Monday 24 August 2026  19:36:21 +0000 (0:00:00.182)       0:00:02.138 *********
2026-08-24 19:36:22.011731 | instance | ok: [instance]
2026-08-24 19:36:22.012089 | instance |
2026-08-24 19:36:22.012446 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 19:36:22.012795 | instance | Monday 24 August 2026  19:36:22 +0000 (0:00:00.899)       0:00:03.038 *********
2026-08-24 19:36:22.345233 | instance | ok: [instance]
2026-08-24 19:36:22.345669 | instance |
2026-08-24 19:36:22.346055 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 19:36:22.346480 | instance | Monday 24 August 2026  19:36:22 +0000 (0:00:00.333)       0:00:03.371 *********
2026-08-24 19:36:22.386097 | instance | skipping: [instance]
2026-08-24 19:36:22.386164 | instance |
2026-08-24 19:36:22.386269 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 19:36:22.386448 | instance | Monday 24 August 2026  19:36:22 +0000 (0:00:00.040)       0:00:03.412 *********
2026-08-24 19:36:22.710036 | instance | changed: [instance]
2026-08-24 19:36:22.710144 | instance |
2026-08-24 19:36:22.710282 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 19:36:22.710476 | instance | Monday 24 August 2026  19:36:22 +0000 (0:00:00.323)       0:00:03.735 *********
2026-08-24 19:36:22.774047 | instance | ok: [instance] => {
2026-08-24 19:36:22.774104 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 19:36:22.774237 | instance | }
2026-08-24 19:36:22.774400 | instance |
2026-08-24 19:36:22.774556 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 19:36:22.774710 | instance | Monday 24 August 2026  19:36:22 +0000 (0:00:00.064)       0:00:03.800 *********
2026-08-24 19:36:23.487394 | instance | changed: [instance]
2026-08-24 19:36:23.487421 | instance |
2026-08-24 19:36:23.487427 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 19:36:23.487432 | instance | Monday 24 August 2026  19:36:23 +0000 (0:00:00.713)       0:00:04.513 *********
2026-08-24 19:36:23.536066 | instance | skipping: [instance]
2026-08-24 19:36:23.536087 | instance |
2026-08-24 19:36:23.536093 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 19:36:23.536097 | instance | Monday 24 August 2026  19:36:23 +0000 (0:00:00.048)       0:00:04.562 *********
2026-08-24 19:36:23.584610 | instance | skipping: [instance]
2026-08-24 19:36:23.584630 | instance |
2026-08-24 19:36:23.584635 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 19:36:23.584640 | instance | Monday 24 August 2026  19:36:23 +0000 (0:00:00.048)       0:00:04.611 *********
2026-08-24 19:36:23.785329 | instance | ok: [instance]
2026-08-24 19:36:23.785363 | instance |
2026-08-24 19:36:23.785369 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 19:36:23.785374 | instance | Monday 24 August 2026  19:36:23 +0000 (0:00:00.200)       0:00:04.811 *********
2026-08-24 19:36:24.900324 | instance | ok: [instance]
2026-08-24 19:36:24.900490 | instance |
2026-08-24 19:36:24.900505 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 19:36:24.900664 | instance | Monday 24 August 2026  19:36:24 +0000 (0:00:01.115)       0:00:05.927 *********
2026-08-24 19:36:24.966718 | instance | ok: [instance] => {
2026-08-24 19:36:24.966789 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 19:36:24.967294 | instance | }
2026-08-24 19:36:24.967312 | instance |
2026-08-24 19:36:24.967318 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 19:36:24.967322 | instance | Monday 24 August 2026  19:36:24 +0000 (0:00:00.066)       0:00:05.993 *********
2026-08-24 19:36:25.668165 | instance | changed: [instance]
2026-08-24 19:36:25.668266 | instance |
2026-08-24 19:36:25.668511 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 19:36:25.668579 | instance | Monday 24 August 2026  19:36:25 +0000 (0:00:00.700)       0:00:06.694 *********
2026-08-24 19:36:28.487740 | instance | changed: [instance]
2026-08-24 19:36:28.487824 | instance |
2026-08-24 19:36:28.488090 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 19:36:28.488153 | instance | Monday 24 August 2026  19:36:28 +0000 (0:00:02.819)       0:00:09.514 *********
2026-08-24 19:36:28.523570 | instance | skipping: [instance]
2026-08-24 19:36:28.524300 | instance |
2026-08-24 19:36:28.524351 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 19:36:28.524358 | instance | Monday 24 August 2026  19:36:28 +0000 (0:00:00.035)       0:00:09.549 *********
2026-08-24 19:36:28.557293 | instance | skipping: [instance]
2026-08-24 19:36:28.557386 | instance |
2026-08-24 19:36:28.557509 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 19:36:28.557815 | instance | Monday 24 August 2026  19:36:28 +0000 (0:00:00.033)       0:00:09.583 *********
2026-08-24 19:36:28.588735 | instance | skipping: [instance]
2026-08-24 19:36:28.588858 | instance |
2026-08-24 19:36:28.589088 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 19:36:28.589308 | instance | Monday 24 August 2026  19:36:28 +0000 (0:00:00.031)       0:00:09.615 *********
2026-08-24 19:36:34.332930 | instance | changed: [instance]
2026-08-24 19:36:34.332966 | instance |
2026-08-24 19:36:34.332972 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 19:36:34.332977 | instance | Monday 24 August 2026  19:36:34 +0000 (0:00:05.743)       0:00:15.359 *********
2026-08-24 19:36:34.884885 | instance | changed: [instance]
2026-08-24 19:36:34.885442 | instance |
2026-08-24 19:36:34.885480 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 19:36:34.885488 | instance | Monday 24 August 2026  19:36:34 +0000 (0:00:00.552)       0:00:15.911 *********
2026-08-24 19:36:35.763369 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 19:36:35.763440 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 19:36:35.764274 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 19:36:35.764322 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 19:36:35.764329 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 19:36:35.764334 | instance |
2026-08-24 19:36:35.764339 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 19:36:35.764343 | instance | Monday 24 August 2026  19:36:35 +0000 (0:00:00.878)       0:00:16.789 *********
2026-08-24 19:36:36.331792 | instance | changed: [instance]
2026-08-24 19:36:36.331876 | instance |
2026-08-24 19:36:36.332443 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 19:36:36.332480 | instance | Monday 24 August 2026  19:36:36 +0000 (0:00:00.552)       0:00:17.342 *********
2026-08-24 19:36:36.332486 | instance |
2026-08-24 19:36:36.332491 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 19:36:36.332495 | instance | Monday 24 August 2026  19:36:36 +0000 (0:00:00.016)       0:00:17.358 *********
2026-08-24 19:36:37.255089 | instance | ok: [instance]
2026-08-24 19:36:37.255126 | instance |
2026-08-24 19:36:37.255132 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 19:36:37.255137 | instance | Monday 24 August 2026  19:36:37 +0000 (0:00:00.922)       0:00:18.281 *********
2026-08-24 19:36:37.667630 | instance | changed: [instance]
2026-08-24 19:36:37.667701 | instance |
2026-08-24 19:36:37.668000 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 19:36:37.668037 | instance | Monday 24 August 2026  19:36:37 +0000 (0:00:00.413)       0:00:18.694 *********
2026-08-24 19:36:38.202925 | instance | changed: [instance]
2026-08-24 19:36:38.203002 | instance |
2026-08-24 19:36:38.203233 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 19:36:38.203265 | instance | Monday 24 August 2026  19:36:38 +0000 (0:00:00.535)       0:00:19.229 *********
2026-08-24 19:36:38.407445 | instance | ok: [instance]
2026-08-24 19:36:38.407527 | instance |
2026-08-24 19:36:38.407796 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 19:36:38.407837 | instance | Monday 24 August 2026  19:36:38 +0000 (0:00:00.204)       0:00:19.434 *********
2026-08-24 19:36:38.467576 | instance | ok: [instance] => {
2026-08-24 19:36:38.467674 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 19:36:38.468154 | instance | }
2026-08-24 19:36:38.468175 | instance |
2026-08-24 19:36:38.468181 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 19:36:38.468186 | instance | Monday 24 August 2026  19:36:38 +0000 (0:00:00.060)       0:00:19.494 *********
2026-08-24 19:36:39.231725 | instance | changed: [instance]
2026-08-24 19:36:39.231808 | instance |
2026-08-24 19:36:39.232079 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 19:36:39.232120 | instance | Monday 24 August 2026  19:36:39 +0000 (0:00:00.763)       0:00:20.258 *********
2026-08-24 19:36:43.516410 | instance | changed: [instance]
2026-08-24 19:36:43.516480 | instance |
2026-08-24 19:36:43.516740 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 19:36:43.516778 | instance | Monday 24 August 2026  19:36:43 +0000 (0:00:04.284)       0:00:24.543 *********
2026-08-24 19:36:44.694550 | instance | ok: [instance]
2026-08-24 19:36:44.694632 | instance |
2026-08-24 19:36:44.694877 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 19:36:44.694914 | instance | Monday 24 August 2026  19:36:44 +0000 (0:00:01.177)       0:00:25.721 *********
2026-08-24 19:36:45.032025 | instance | changed: [instance]
2026-08-24 19:36:45.032094 | instance |
2026-08-24 19:36:45.032372 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 19:36:45.032409 | instance | Monday 24 August 2026  19:36:45 +0000 (0:00:00.337)       0:00:26.058 *********
2026-08-24 19:36:45.499890 | instance | changed: [instance]
2026-08-24 19:36:45.500297 | instance |
2026-08-24 19:36:45.500313 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 19:36:45.500318 | instance | Monday 24 August 2026  19:36:45 +0000 (0:00:00.468)       0:00:26.526 *********
2026-08-24 19:36:46.060619 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 19:36:46.060701 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 19:36:46.061234 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 19:36:46.061447 | instance |
2026-08-24 19:36:46.061454 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 19:36:46.061459 | instance | Monday 24 August 2026  19:36:46 +0000 (0:00:00.560)       0:00:27.086 *********
2026-08-24 19:36:46.504741 | instance | changed: [instance]
2026-08-24 19:36:46.504813 | instance |
2026-08-24 19:36:46.505059 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 19:36:46.505090 | instance | Monday 24 August 2026  19:36:46 +0000 (0:00:00.444)       0:00:27.531 *********
2026-08-24 19:36:46.988448 | instance | changed: [instance]
2026-08-24 19:36:46.988483 | instance |
2026-08-24 19:36:46.988488 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 19:36:46.988502 | instance | Monday 24 August 2026  19:36:46 +0000 (0:00:00.465)       0:00:27.997 *********
2026-08-24 19:36:46.988507 | instance |
2026-08-24 19:36:46.988511 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 19:36:46.988519 | instance | Monday 24 August 2026  19:36:46 +0000 (0:00:00.017)       0:00:28.014 *********
2026-08-24 19:36:47.716527 | instance | ok: [instance]
2026-08-24 19:36:47.716591 | instance |
2026-08-24 19:36:47.716861 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 19:36:47.716900 | instance | Monday 24 August 2026  19:36:47 +0000 (0:00:00.728)       0:00:28.743 *********
2026-08-24 19:36:48.523991 | instance | changed: [instance]
2026-08-24 19:36:48.524074 | instance |
2026-08-24 19:36:48.524329 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 19:36:48.524368 | instance | Monday 24 August 2026  19:36:48 +0000 (0:00:00.807)       0:00:29.550 *********
2026-08-24 19:36:49.069674 | instance | changed: [instance]
2026-08-24 19:36:49.069743 | instance |
2026-08-24 19:36:49.070037 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 19:36:49.070089 | instance | Monday 24 August 2026  19:36:49 +0000 (0:00:00.544)       0:00:30.095 *********
2026-08-24 19:36:49.129750 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 19:36:49.129843 | instance |
2026-08-24 19:36:49.129856 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 19:36:49.130017 | instance | Monday 24 August 2026  19:36:49 +0000 (0:00:00.059)       0:00:30.155 *********
2026-08-24 19:36:53.284977 | instance | changed: [instance]
2026-08-24 19:36:53.285524 | instance |
2026-08-24 19:36:53.285646 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 19:36:53.285654 | instance | Monday 24 August 2026  19:36:53 +0000 (0:00:04.155)       0:00:34.311 *********
2026-08-24 19:36:53.920521 | instance | ok: [instance] => (item=chronyd)
2026-08-24 19:36:53.920560 | instance | ok: [instance] => (item=sshd)
2026-08-24 19:36:53.920565 | instance |
2026-08-24 19:36:53.920570 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 19:36:53.920574 | instance | Monday 24 August 2026  19:36:53 +0000 (0:00:00.635)       0:00:34.946 *********
2026-08-24 19:36:54.822652 | instance | changed: [instance]
2026-08-24 19:36:54.822774 | instance |
2026-08-24 19:36:54.823030 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 19:36:54.823069 | instance | Monday 24 August 2026  19:36:54 +0000 (0:00:00.902)       0:00:35.849 *********
2026-08-24 19:36:55.016453 | instance | ok: [instance]
2026-08-24 19:36:55.016569 | instance |
2026-08-24 19:36:55.016818 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 19:36:55.016833 | instance | Monday 24 August 2026  19:36:55 +0000 (0:00:00.194)       0:00:36.043 *********
2026-08-24 19:36:55.454500 | instance | changed: [instance]
2026-08-24 19:36:55.454599 | instance |
2026-08-24 19:36:55.454956 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 19:36:55.455266 | instance | Monday 24 August 2026  19:36:55 +0000 (0:00:00.437)       0:00:36.480 *********
2026-08-24 19:36:55.782821 | instance | changed: [instance]
2026-08-24 19:36:55.782942 | instance |
2026-08-24 19:36:55.782954 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 19:36:55.783143 | instance | Monday 24 August 2026  19:36:55 +0000 (0:00:00.328)       0:00:36.809 *********
2026-08-24 19:36:56.010140 | instance | ok: [instance]
2026-08-24 19:36:56.010210 | instance |
2026-08-24 19:36:56.010219 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 19:36:56.010225 | instance | Monday 24 August 2026  19:36:56 +0000 (0:00:00.226)       0:00:37.035 *********
2026-08-24 19:36:56.222105 | instance | ok: [instance] => (item=instance)
2026-08-24 19:36:56.222202 | instance |
2026-08-24 19:36:56.222467 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 19:36:56.222506 | instance | Monday 24 August 2026  19:36:56 +0000 (0:00:00.212)       0:00:37.248 *********
2026-08-24 19:36:56.276904 | instance | ok: [instance]
2026-08-24 19:36:56.276986 | instance |
2026-08-24 19:36:56.277243 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 19:36:56.277280 | instance | Monday 24 August 2026  19:36:56 +0000 (0:00:00.054)       0:00:37.303 *********
2026-08-24 19:36:56.348189 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 19:36:56.348560 | instance |
2026-08-24 19:36:56.348593 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 19:36:56.348599 | instance | Monday 24 August 2026  19:36:56 +0000 (0:00:00.071)       0:00:37.374 *********
2026-08-24 19:36:56.612884 | instance | changed: [instance]
2026-08-24 19:36:56.612937 | instance |
2026-08-24 19:36:56.613228 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 19:36:56.613269 | instance | Monday 24 August 2026  19:36:56 +0000 (0:00:00.264)       0:00:37.639 *********
2026-08-24 19:36:57.250304 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 19:36:57.250366 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 19:36:57.250389 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 19:36:57.250395 | instance |
2026-08-24 19:36:57.250400 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 19:36:57.250405 | instance | Monday 24 August 2026  19:36:57 +0000 (0:00:00.636)       0:00:38.276 *********
2026-08-24 19:38:27.816805 | instance | ok: [instance]
2026-08-24 19:38:27.816851 | instance |
2026-08-24 19:38:27.816858 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 19:38:27.816862 | instance | Monday 24 August 2026  19:38:27 +0000 (0:01:30.567)       0:02:08.843 *********
2026-08-24 19:38:28.036374 | instance | changed: [instance]
2026-08-24 19:38:28.036452 | instance |
2026-08-24 19:38:28.036553 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 19:38:28.036673 | instance | Monday 24 August 2026  19:38:28 +0000 (0:00:00.219)       0:02:09.063 *********
2026-08-24 19:38:28.081837 | instance | ok: [instance]
2026-08-24 19:38:28.081916 | instance |
2026-08-24 19:38:28.082003 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 19:38:28.082122 | instance | Monday 24 August 2026  19:38:28 +0000 (0:00:00.045)       0:02:09.108 *********
2026-08-24 19:38:28.163665 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 19:38:28.163744 | instance |
2026-08-24 19:38:28.163967 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 19:38:28.164007 | instance | Monday 24 August 2026  19:38:28 +0000 (0:00:00.081)       0:02:09.190 *********
2026-08-24 19:38:29.702698 | instance | ok: [instance]
2026-08-24 19:38:29.702794 | instance |
2026-08-24 19:38:29.702945 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 19:38:29.703055 | instance | Monday 24 August 2026  19:38:29 +0000 (0:00:01.538)       0:02:10.729 *********
2026-08-24 19:38:29.764529 | instance | ok: [instance] => (item=instance)
2026-08-24 19:38:29.764620 | instance |
2026-08-24 19:38:29.764741 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 19:38:29.764862 | instance | Monday 24 August 2026  19:38:29 +0000 (0:00:00.062)       0:02:10.791 *********
2026-08-24 19:38:30.110567 | instance | ok: [instance]
2026-08-24 19:38:30.111166 | instance |
2026-08-24 19:38:30.111207 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 19:38:30.111215 | instance | Monday 24 August 2026  19:38:30 +0000 (0:00:00.345)       0:02:11.136 *********
2026-08-24 19:38:32.396196 | instance | ok: [instance]
2026-08-24 19:38:32.396238 | instance |
2026-08-24 19:38:32.396244 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 19:38:32.396249 | instance | Monday 24 August 2026  19:38:32 +0000 (0:00:02.285)       0:02:13.422 *********
2026-08-24 19:39:17.433924 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-24 19:39:17.434565 | 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_a3ru222v/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_a3ru222v/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_a3ru222v/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_a3ru222v/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-24T19:39:17.255+0000 7fbed95dc640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCJnYxqd2vlBSAAfVekpf5qz0Ft4xewwiiaH9Hkq/ymRgoMKDZbSv16k0A=: Malformed input [buffer:3]\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCJnYxqd2vlBSAAfVekpf5qz0Ft4xewwiiaH9Hkq/ymRgoMKDZbSv16k0A=: Malformed input [buffer:3]\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCJnYxqd2vlBSAAfVekpf5qz0Ft4xewwiiaH9Hkq/ymRgoMKDZbSv16k0A=: Malformed input [buffer:3]\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:39:17.255+0000 7fbed95dc640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-24 19:39:17.436552 | instance |
2026-08-24 19:39:17.436709 | instance | PLAY RECAP *********************************************************************
2026-08-24 19:39:17.437048 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-24 19:39:17.437181 | instance |
2026-08-24 19:39:17.437197 | instance | Monday 24 August 2026  19:39:17 +0000 (0:00:45.041)       0:02:58.463 *********
2026-08-24 19:39:17.437645 | instance | ===============================================================================
2026-08-24 19:39:17.437729 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 90.57s
2026-08-24 19:39:17.437758 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 45.04s
2026-08-24 19:39:17.437987 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.74s
2026-08-24 19:39:17.438009 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.28s
2026-08-24 19:39:17.438226 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.16s
2026-08-24 19:39:17.438384 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.82s
2026-08-24 19:39:17.438545 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.29s
2026-08-24 19:39:17.438703 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.65s
2026-08-24 19:39:17.438866 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.54s
2026-08-24 19:39:17.439018 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.18s
2026-08-24 19:39:17.439190 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.12s
2026-08-24 19:39:17.439355 | instance | Gathering Facts --------------------------------------------------------- 1.02s
2026-08-24 19:39:17.439521 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.90s
2026-08-24 19:39:17.439686 | instance | Gathering Facts --------------------------------------------------------- 0.90s
2026-08-24 19:39:17.439854 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s
2026-08-24 19:39:17.440025 | instance | Gathering Facts --------------------------------------------------------- 0.84s
2026-08-24 19:39:17.440191 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.81s
2026-08-24 19:39:17.440360 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-24 19:39:17.440532 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s
2026-08-24 19:39:17.440699 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.70s
2026-08-24 19:39:17.605916 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 19:39:17.606083 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 19:39:17.606287 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 19:39:17.951514 | instance | ERROR
2026-08-24 19:39:17.951817 | instance | {
2026-08-24 19:39:17.951860 | instance |   "delta": "0:03:48.202787",
2026-08-24 19:39:17.951889 | instance |   "end": "2026-08-24 19:39:17.665845",
2026-08-24 19:39:17.951915 | instance |   "msg": "non-zero return code",
2026-08-24 19:39:17.951940 | instance |   "rc": 2,
2026-08-24 19:39:17.951965 | instance |   "start": "2026-08-24 19:35:29.463058"
2026-08-24 19:39:17.951991 | instance | }
failure
2026-08-24 19:39:17.958655 | 
2026-08-24 19:39:17.958717 | PLAY RECAP
2026-08-24 19:39:17.958780 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 19:39:17.958808 | 
2026-08-24 19:39:18.114418 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 19:39:18.118697 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 19:39:18.796546 | 
2026-08-24 19:39:18.796663 | PLAY [all]
2026-08-24 19:39:18.811523 | 
2026-08-24 19:39:18.811613 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 19:39:19.147691 | instance | changed
2026-08-24 19:39:19.155020 | 
2026-08-24 19:39:19.155128 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 19:39:19.536373 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 19:39:19.550474 | instance | + ip addr
2026-08-24 19:39:19.555069 | instance | + ip route
2026-08-24 19:39:19.557653 | instance | + lsblk
2026-08-24 19:39:19.561020 | instance | + mount
2026-08-24 19:39:19.563660 | instance | + docker images
2026-08-24 19:39:19.584451 | instance | + brctl show
2026-08-24 19:39:19.585118 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 19:39:19.585558 | instance | + ps aux --sort=-%mem
2026-08-24 19:39:19.602216 | instance | + dpkg -l
2026-08-24 19:39:19.613682 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 19:39:19.614179 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 19:39:19.635568 | instance | + '[' '!' -z '' ']'
2026-08-24 19:39:19.692051 | instance | ok: Runtime: 0:00:00.105738
2026-08-24 19:39:19.700312 | 
2026-08-24 19:39:19.700400 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 19:39:20.343606 | instance | changed:
2026-08-24 19:39:20.343845 | instance | created directory /var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/logs/instance
2026-08-24 19:39:20.343888 | instance | cd+++++++++ system/
2026-08-24 19:39:20.343918 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 19:39:20.343947 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 19:39:20.343975 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 19:39:20.344007 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 19:39:20.344038 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 19:39:20.344066 | instance | >f+++++++++ system/mount.txt
2026-08-24 19:39:20.344093 | instance | >f+++++++++ system/packages.txt
2026-08-24 19:39:20.344120 | instance | >f+++++++++ system/ps.txt
2026-08-24 19:39:20.344149 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 19:39:20.356262 | 
2026-08-24 19:39:20.356328 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 19:39:20.555985 | instance | changed: "values"
2026-08-24 19:39:20.738317 | instance | changed: "releases"
2026-08-24 19:39:20.755979 | 
2026-08-24 19:39:20.756131 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 19:39:20.965904 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 19:39:21.299576 | instance | ok: Runtime: 0:00:00.007223
2026-08-24 19:39:21.306365 | 
2026-08-24 19:39:21.306455 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 19:39:21.784925 | instance | changed:
2026-08-24 19:39:21.785153 | instance | cd+++++++++ helm/
2026-08-24 19:39:21.785204 | instance | cd+++++++++ helm/releases/
2026-08-24 19:39:21.785244 | instance | cd+++++++++ helm/values/
2026-08-24 19:39:21.797851 | 
2026-08-24 19:39:21.797943 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 19:39:21.992121 | instance | changed
2026-08-24 19:39:21.999624 | 
2026-08-24 19:39:21.999695 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 19:39:22.267278 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 19:39:22.267511 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 19:39:22.271572 | instance | environment: line 1: kubectl: command not found
2026-08-24 19:39:22.272490 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 19:39:22.274587 | instance | environment: line 1: kubectl: command not found
2026-08-24 19:39:22.275735 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 19:39:22.276702 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 19:39:22.276749 | instance | environment: line 1: kubectl: command not found
2026-08-24 19:39:22.279788 | instance | environment: line 1: kubectl: command not found
2026-08-24 19:39:22.280240 | instance | environment: line 1: kubectl: command not found
2026-08-24 19:39:22.281263 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines valuexargs:
2026-08-24 19:39:22.281276 | instance | warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 19:39:22.535016 | instance | ok: Runtime: 0:00:00.023917
2026-08-24 19:39:22.539787 | 
2026-08-24 19:39:22.539850 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 19:39:22.735834 | instance | changed
2026-08-24 19:39:22.740865 | 
2026-08-24 19:39:22.740936 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 19:39:22.966797 | instance | environment: line 5: kubectl: command not found
2026-08-24 19:39:22.967247 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 19:39:22.967621 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 19:39:22.967909 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 19:39:23.277984 | instance | ok: Runtime: 0:00:00.010686
2026-08-24 19:39:23.284085 | 
2026-08-24 19:39:23.284184 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 19:39:23.780909 | instance | changed:
2026-08-24 19:39:23.781127 | instance | cd+++++++++ objects/
2026-08-24 19:39:23.781170 | instance | cd+++++++++ objects/cluster/
2026-08-24 19:39:23.781205 | instance | cd+++++++++ objects/namespaced/
2026-08-24 19:39:23.794836 | 
2026-08-24 19:39:23.794921 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 19:39:23.997750 | instance | changed
2026-08-24 19:39:24.004020 | 
2026-08-24 19:39:24.004123 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 19:39:24.199051 | instance | changed
2026-08-24 19:39:24.206235 | 
2026-08-24 19:39:24.206381 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 19:39:24.439168 | instance | environment: line 3: kubectl: command not found
2026-08-24 19:39:24.740472 | instance | ok: Runtime: 0:00:00.010469
2026-08-24 19:39:24.747627 | 
2026-08-24 19:39:24.747716 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 19:39:25.223054 | instance | changed:
2026-08-24 19:39:25.223262 | instance | cd+++++++++ pod-logs/
2026-08-24 19:39:25.223301 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 19:39:25.235221 | 
2026-08-24 19:39:25.235291 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 19:39:25.433861 | instance | changed
2026-08-24 19:39:25.443715 | 
2026-08-24 19:39:25.443939 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 19:39:25.667756 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 19:39:25.983182 | instance | ok: Runtime: 0:00:00.039249
2026-08-24 19:39:26.000254 | 
2026-08-24 19:39:26.000468 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 19:39:26.209628 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 19:39:26.241816 | instance | ceph-mgr endpoints:
2026-08-24 19:39:26.536250 | instance | ok: Runtime: 0:00:00.040551
2026-08-24 19:39:26.544348 | 
2026-08-24 19:39:26.544631 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 19:39:26.773455 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 19:39:27.095192 | instance | ok: Runtime: 0:00:00.037300
2026-08-24 19:39:27.102236 | 
2026-08-24 19:39:27.102320 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 19:39:27.585284 | instance | changed: cd+++++++++ prometheus/
2026-08-24 19:39:27.596476 | 
2026-08-24 19:39:27.596538 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 19:39:27.791748 | instance | changed
2026-08-24 19:39:27.977452 | 
2026-08-24 19:39:27.977547 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 19:39:28.204713 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 19:39:28.206230 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 19:39:28.510935 | instance | ERROR
2026-08-24 19:39:28.511150 | instance | {
2026-08-24 19:39:28.511182 | instance |   "delta": "0:00:00.007602",
2026-08-24 19:39:28.511205 | instance |   "end": "2026-08-24 19:39:28.206946",
2026-08-24 19:39:28.511227 | instance |   "msg": "non-zero return code",
2026-08-24 19:39:28.511248 | instance |   "rc": 1,
2026-08-24 19:39:28.511267 | instance |   "start": "2026-08-24 19:39:28.199344"
2026-08-24 19:39:28.511286 | instance | }
2026-08-24 19:39:28.511310 | instance | ERROR: Ignoring Errors
2026-08-24 19:39:28.516214 | 
2026-08-24 19:39:28.516280 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 19:39:29.011109 | instance | changed: cd+++++++++ selenium/
2026-08-24 19:39:29.016983 | 
2026-08-24 19:39:29.017040 | PLAY RECAP
2026-08-24 19:39:29.017110 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 19:39:29.017139 | 
2026-08-24 19:39:29.191867 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 19:39:29.196037 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 19:39:29.988874 | 
2026-08-24 19:39:29.989082 | PLAY [all]
2026-08-24 19:39:30.000766 | 
2026-08-24 19:39:30.000869 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 19:39:30.045871 | instance | skipping: Conditional result was False
2026-08-24 19:39:30.054872 | 
2026-08-24 19:39:30.054989 | TASK [fetch-output : Set log path for single node]
2026-08-24 19:39:30.099108 | instance | ok
2026-08-24 19:39:30.105696 | 
2026-08-24 19:39:30.105806 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 19:39:30.472846 | instance -> localhost | ok: "/var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/logs"
2026-08-24 19:39:30.676309 | instance -> localhost | changed: "/var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/artifacts"
2026-08-24 19:39:30.874061 | instance -> localhost | changed: "/var/lib/zuul/builds/fb40865aaece4b06972af28d13861f31/work/docs"
2026-08-24 19:39:30.894592 | 
2026-08-24 19:39:30.894717 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 19:39:31.510631 | instance | changed: .d..t...... ./
2026-08-24 19:39:31.510993 | instance | changed: All items complete
2026-08-24 19:39:31.511051 | 
2026-08-24 19:39:31.961261 | instance | changed: .d..t...... ./
2026-08-24 19:39:32.413343 | instance | changed: .d..t...... ./
2026-08-24 19:39:32.440712 | 
2026-08-24 19:39:32.440831 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 19:39:32.831926 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007058
2026-08-24 19:39:33.059127 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007715
2026-08-24 19:39:33.079017 | 
2026-08-24 19:39:33.079528 | PLAY [all]
2026-08-24 19:39:33.086049 | 
2026-08-24 19:39:33.086115 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 19:39:33.488496 | instance | changed
2026-08-24 19:39:33.496295 | 
2026-08-24 19:39:33.496343 | PLAY RECAP
2026-08-24 19:39:33.496385 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 19:39:33.496407 | 
2026-08-24 19:39:33.622849 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 19:39:33.626359 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 19:39:34.217647 | 
2026-08-24 19:39:34.217820 | PLAY [localhost]
2026-08-24 19:39:34.228504 | 
2026-08-24 19:39:34.228635 | TASK [Generate Zuul manifest]
2026-08-24 19:39:34.253732 | localhost | ok
2026-08-24 19:39:34.271128 | 
2026-08-24 19:39:34.271296 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 19:39:34.633039 | localhost | changed
2026-08-24 19:39:34.645973 | 
2026-08-24 19:39:34.646054 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 19:39:34.677248 | localhost | ok
2026-08-24 19:39:34.685935 | 
2026-08-24 19:39:34.686006 | TASK [Upload logs]
2026-08-24 19:39:34.704239 | localhost | ok
2026-08-24 19:39:34.760047 | 
2026-08-24 19:39:34.760174 | TASK [Set zuul-log-path fact]
2026-08-24 19:39:34.781295 | localhost | ok
2026-08-24 19:39:34.794506 | 
2026-08-24 19:39:34.794611 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 19:39:34.825795 | localhost | ok
2026-08-24 19:39:34.834651 | 
2026-08-24 19:39:34.834737 | TASK [upload-logs : Create log directories]
2026-08-24 19:39:35.228084 | localhost | changed
2026-08-24 19:39:35.238500 | 
2026-08-24 19:39:35.238574 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 19:39:35.622879 | localhost -> localhost | ok: Runtime: 0:00:00.005442
2026-08-24 19:39:35.629232 | 
2026-08-24 19:39:35.629317 | TASK [upload-logs : Upload logs to log server]
2026-08-24 19:39:36.081910 | localhost | Output suppressed because no_log was given
2026-08-24 19:39:36.113577 | 
2026-08-24 19:39:36.113708 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 19:39:36.157499 | localhost | skipping: Conditional result was False
2026-08-24 19:39:36.164203 | localhost | skipping: Conditional result was False
2026-08-24 19:39:36.177422 | 
2026-08-24 19:39:36.177596 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 19:39:36.218138 | localhost | skipping: Conditional result was False
2026-08-24 19:39:36.218503 | 
2026-08-24 19:39:36.222360 | localhost | skipping: Conditional result was False
2026-08-24 19:39:36.230293 | 
2026-08-24 19:39:36.230446 | LOOP [upload-logs : Upload console log and json output]