2026-08-28 04:00:25.964161 | Job console starting
2026-08-28 04:00:25.974279 | Updating git repos
2026-08-28 04:00:28.199212 | Cloning repos into workspace
2026-08-28 04:00:45.418807 | Restoring repo states
2026-08-28 04:00:54.012642 | Merging changes
2026-08-28 04:00:55.324507 | Checking out repos
2026-08-28 04:00:56.990710 | Preparing playbooks
2026-08-28 04:00:58.601243 | Running Ansible setup
2026-08-28 04:01:02.231059 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-28 04:01:02.839740 | 
2026-08-28 04:01:02.839883 | PLAY [localhost]
2026-08-28 04:01:02.847706 | 
2026-08-28 04:01:02.847784 | TASK [Gathering Facts]
2026-08-28 04:01:03.761092 | localhost | ok
2026-08-28 04:01:03.772699 | 
2026-08-28 04:01:03.787092 | TASK [Setup log path fact]
2026-08-28 04:01:03.812922 | localhost | ok
2026-08-28 04:01:03.825990 | 
2026-08-28 04:01:03.826070 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-28 04:01:03.868208 | localhost | ok
2026-08-28 04:01:03.891286 | 
2026-08-28 04:01:03.892174 | TASK [emit-job-header : Print job information]
2026-08-28 04:01:03.934157 | # Job Information
2026-08-28 04:01:03.935468 | Ansible Version: 2.16.18
2026-08-28 04:01:03.935539 | Job: atmosphere-molecule-csi-rbd
2026-08-28 04:01:03.935576 | Pipeline: check
2026-08-28 04:01:03.935607 | Executor: 2d72f0692154
2026-08-28 04:01:03.935637 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4353
2026-08-28 04:01:03.935691 | Event ID: aacd4eb0-a293-11f1-9d4d-833eca273ace
2026-08-28 04:01:03.940624 | 
2026-08-28 04:01:03.940726 | LOOP [emit-job-header : Print node information]
2026-08-28 04:01:04.039517 | localhost | ok:
2026-08-28 04:01:04.039742 | localhost | # Node Information
2026-08-28 04:01:04.039773 | localhost | Inventory Hostname: instance
2026-08-28 04:01:04.039796 | localhost | Hostname: np0000191392
2026-08-28 04:01:04.039816 | localhost | Username: zuul
2026-08-28 04:01:04.039838 | localhost | Distro: Ubuntu 22.04
2026-08-28 04:01:04.039858 | localhost | Provider: yul1
2026-08-28 04:01:04.039877 | localhost | Region: ca-ymq-1
2026-08-28 04:01:04.039895 | localhost | Label: ubuntu-jammy
2026-08-28 04:01:04.039913 | localhost | Product Name: OpenStack Nova
2026-08-28 04:01:04.039932 | localhost | Interface IP: 162.253.55.161
2026-08-28 04:01:04.046581 | 
2026-08-28 04:01:04.046922 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-28 04:01:04.498447 | localhost -> localhost | changed
2026-08-28 04:01:04.505675 | 
2026-08-28 04:01:04.505773 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-28 04:01:05.481478 | localhost -> localhost | changed
2026-08-28 04:01:05.488374 | 
2026-08-28 04:01:05.488428 | PLAY [all]
2026-08-28 04:01:05.497447 | 
2026-08-28 04:01:05.497515 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-28 04:01:05.829036 | instance -> localhost | ok
2026-08-28 04:01:05.838582 | 
2026-08-28 04:01:05.838685 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-28 04:01:05.868227 | instance | ok
2026-08-28 04:01:05.881495 | instance | included: /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-28 04:01:05.886888 | 
2026-08-28 04:01:05.886948 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-28 04:01:06.931382 | instance -> localhost | Generating public/private rsa key pair.
2026-08-28 04:01:06.931566 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/1182ef764eca467586c6f8f1a5b92e64_id_rsa
2026-08-28 04:01:06.931596 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/1182ef764eca467586c6f8f1a5b92e64_id_rsa.pub
2026-08-28 04:01:06.931620 | instance -> localhost | The key fingerprint is:
2026-08-28 04:01:06.931643 | instance -> localhost | SHA256:RpEjj/ICGrA5T2nGwXBecWS06ByiU7E4KONALlK3HwY zuul-build-sshkey
2026-08-28 04:01:06.931676 | instance -> localhost | The key's randomart image is:
2026-08-28 04:01:06.931698 | instance -> localhost | +---[RSA 3072]----+
2026-08-28 04:01:06.931724 | instance -> localhost | |.++ E+= ..       |
2026-08-28 04:01:06.931746 | instance -> localhost | |==o= *..o.       |
2026-08-28 04:01:06.931767 | instance -> localhost | |@==o+ ++..       |
2026-08-28 04:01:06.931788 | instance -> localhost | |@=B+.+.o.        |
2026-08-28 04:01:06.931809 | instance -> localhost | |oX .oo. S        |
2026-08-28 04:01:06.931829 | instance -> localhost | |... . ..         |
2026-08-28 04:01:06.931881 | instance -> localhost | |     .           |
2026-08-28 04:01:06.931903 | instance -> localhost | |                 |
2026-08-28 04:01:06.931926 | instance -> localhost | |                 |
2026-08-28 04:01:06.931948 | instance -> localhost | +----[SHA256]-----+
2026-08-28 04:01:06.931998 | instance -> localhost | ok: Runtime: 0:00:00.639112
2026-08-28 04:01:06.942325 | 
2026-08-28 04:01:06.942400 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-28 04:01:06.976115 | instance | ok
2026-08-28 04:01:06.987189 | instance | included: /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-28 04:01:06.995037 | 
2026-08-28 04:01:06.995104 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-28 04:01:07.030649 | instance | skipping: Conditional result was False
2026-08-28 04:01:07.040805 | 
2026-08-28 04:01:07.040908 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-28 04:01:07.474907 | instance | changed
2026-08-28 04:01:07.484038 | 
2026-08-28 04:01:07.484488 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-28 04:01:07.675288 | instance | ok
2026-08-28 04:01:07.688574 | 
2026-08-28 04:01:07.690006 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-28 04:01:08.186070 | instance | changed
2026-08-28 04:01:08.199384 | 
2026-08-28 04:01:08.199465 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-28 04:01:08.690399 | instance | changed
2026-08-28 04:01:08.698836 | 
2026-08-28 04:01:08.698929 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-28 04:01:08.725789 | instance | skipping: Conditional result was False
2026-08-28 04:01:08.736589 | 
2026-08-28 04:01:08.736656 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-28 04:01:09.111211 | instance -> localhost | changed
2026-08-28 04:01:09.129138 | 
2026-08-28 04:01:09.129221 | TASK [add-build-sshkey : Add back temp key]
2026-08-28 04:01:09.463100 | instance -> localhost | Identity added: /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/1182ef764eca467586c6f8f1a5b92e64_id_rsa (zuul-build-sshkey)
2026-08-28 04:01:09.463316 | instance -> localhost | ok: Runtime: 0:00:00.013703
2026-08-28 04:01:09.468381 | 
2026-08-28 04:01:09.468507 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-28 04:01:09.829688 | instance | ok
2026-08-28 04:01:09.889771 | 
2026-08-28 04:01:09.889872 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-28 04:01:09.917265 | instance | skipping: Conditional result was False
2026-08-28 04:01:09.933056 | 
2026-08-28 04:01:09.933127 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-28 04:01:10.280608 | instance | ok
2026-08-28 04:01:10.288543 | 
2026-08-28 04:01:10.288642 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-28 04:01:13.884803 | instance | Output suppressed because no_log was given
2026-08-28 04:01:13.895813 | 
2026-08-28 04:01:13.895884 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-28 04:01:14.104827 | instance | ok: "logs"
2026-08-28 04:01:14.105077 | instance | ok: All items complete
2026-08-28 04:01:14.105107 | 
2026-08-28 04:01:14.251582 | instance | ok: "artifacts"
2026-08-28 04:01:14.395261 | instance | ok: "docs"
2026-08-28 04:01:14.412941 | 
2026-08-28 04:01:14.413075 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-28 04:01:14.583401 | instance | changed: "logs"
2026-08-28 04:01:14.796705 | instance | changed: "artifacts"
2026-08-28 04:01:14.986942 | instance | changed: "docs"
2026-08-28 04:01:14.996649 | 
2026-08-28 04:01:14.996697 | PLAY RECAP
2026-08-28 04:01:14.996740 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-28 04:01:14.996771 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-28 04:01:14.996793 | 
2026-08-28 04:01:15.134951 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-28 04:01:15.165193 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-28 04:01:15.838861 | 
2026-08-28 04:01:15.838988 | PLAY [all]
2026-08-28 04:01:15.849792 | 
2026-08-28 04:01:15.849869 | TASK [setup-uv : Extract archive]
2026-08-28 04:01:18.168683 | instance | changed
2026-08-28 04:01:18.177428 | 
2026-08-28 04:01:18.177562 | TASK [setup-uv : Print version]
2026-08-28 04:01:18.573912 | instance | uv 0.8.13
2026-08-28 04:01:18.825739 | instance | ok: Runtime: 0:00:00.010606
2026-08-28 04:01:18.834778 | 
2026-08-28 04:01:18.834907 | TASK [Install Ansible collection siblings]
2026-08-28 04:01:27.925747 | instance | changed:
2026-08-28 04:01:27.925937 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-28 04:01:27.925978 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-28 04:01:27.926009 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-28 04:01:27.926037 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-28 04:01:27.926065 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-28 04:01:27.926097 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-28 04:01:27.926127 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-28 04:01:27.926158 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-28 04:01:27.926186 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-28 04:01:27.926213 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-28 04:01:27.926240 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-28 04:01:27.926267 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-28 04:01:27.926293 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-28 04:01:27.926319 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-28 04:01:27.926345 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-28 04:01:27.926371 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-28 04:01:27.926398 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-28 04:01:27.926424 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-28 04:01:27.926449 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-28 04:01:27.926475 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-28 04:01:27.926500 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-28 04:01:27.926525 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-28 04:01:27.926553 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-28 04:01:27.926591 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-28 04:01:27.926618 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-28 04:01:27.926644 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-28 04:01:27.926669 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-28 04:01:27.926695 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-28 04:01:27.926721 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-28 04:01:27.926746 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-28 04:01:27.926771 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-28 04:01:27.926797 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-28 04:01:27.926822 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-28 04:01:27.926848 | 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-28 04:01:27.926882 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.926908 | instance | Process install dependency map
2026-08-28 04:01:27.926934 | instance | Starting collection install process
2026-08-28 04:01:27.926959 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-28 04:01:27.926985 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-28 04:01:27.927010 | instance | ansible.netcommon:* was installed successfully
2026-08-28 04:01:27.927035 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-28 04:01:27.927061 | instance | Creating virtual environment at: .venv
2026-08-28 04:01:27.927086 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-28 04:01:27.927112 | instance | Downloading cryptography (4.2MiB)
2026-08-28 04:01:27.927137 | instance | Downloading ansible-core (2.1MiB)
2026-08-28 04:01:27.927167 | instance | Downloading pygments (1.2MiB)
2026-08-28 04:01:27.927193 | instance | Downloading rjsonnet (1.2MiB)
2026-08-28 04:01:27.927219 | instance | Downloading openstacksdk (1.7MiB)
2026-08-28 04:01:27.927245 | instance | Downloading kubernetes (1.9MiB)
2026-08-28 04:01:27.927270 | instance | Downloading setuptools (1.1MiB)
2026-08-28 04:01:27.927295 | instance | Downloading netaddr (2.2MiB)
2026-08-28 04:01:27.927321 | instance |    Building pyperclip==1.9.0
2026-08-28 04:01:27.927346 | instance |  Downloading rjsonnet
2026-08-28 04:01:27.927374 | instance |  Downloading netaddr
2026-08-28 04:01:27.927400 | instance |  Downloading pygments
2026-08-28 04:01:27.927426 | instance |  Downloading cryptography
2026-08-28 04:01:27.927451 | instance |  Downloading setuptools
2026-08-28 04:01:27.927477 | instance |  Downloading kubernetes
2026-08-28 04:01:27.927501 | instance |  Downloading ansible-core
2026-08-28 04:01:27.927526 | instance |  Downloading openstacksdk
2026-08-28 04:01:27.927552 | instance |       Built pyperclip==1.9.0
2026-08-28 04:01:27.927577 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-28 04:01:27.927603 | instance | Installed 79 packages in 52ms
2026-08-28 04:01:27.927628 | instance | Checked out ansible.posix to 1.6.0
2026-08-28 04:01:27.927654 | 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-28 04:01:27.927680 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.927705 | instance | Process install dependency map
2026-08-28 04:01:27.927730 | instance | Starting collection install process
2026-08-28 04:01:27.927755 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-28 04:01:27.927787 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-28 04:01:27.927814 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-28 04:01:27.927840 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.927865 | instance | 2.17.12
2026-08-28 04:01:27.927892 | instance | Checked out ansible.utils to v6.1.0
2026-08-28 04:01:27.927921 | 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-28 04:01:27.927947 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.927972 | instance | Process install dependency map
2026-08-28 04:01:27.927997 | instance | Starting collection install process
2026-08-28 04:01:27.928022 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-28 04:01:27.928046 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-28 04:01:27.928072 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-28 04:01:27.928098 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.928123 | instance | 2.17.12
2026-08-28 04:01:27.928149 | instance | Checked out atmosphere.common to v0.7.0
2026-08-28 04:01:27.928175 | 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-28 04:01:27.928200 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.928225 | instance | Process install dependency map
2026-08-28 04:01:27.928250 | instance | Starting collection install process
2026-08-28 04:01:27.928275 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-28 04:01:27.928300 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-28 04:01:27.928325 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-28 04:01:27.928351 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.928376 | instance | 2.17.12
2026-08-28 04:01:27.928401 | instance | Checked out community.crypto to 2.2.3
2026-08-28 04:01:27.928426 | 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-28 04:01:27.928452 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.928476 | instance | Process install dependency map
2026-08-28 04:01:27.928501 | instance | Starting collection install process
2026-08-28 04:01:27.928525 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-28 04:01:27.928550 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-28 04:01:27.928575 | instance | community.crypto:2.2.3 was installed successfully
2026-08-28 04:01:27.928600 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.928624 | instance | 2.17.12
2026-08-28 04:01:27.928649 | instance | Checked out community.general to 7.3.0
2026-08-28 04:01:27.928673 | 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-28 04:01:27.928698 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.928729 | instance | Process install dependency map
2026-08-28 04:01:27.928755 | instance | Starting collection install process
2026-08-28 04:01:27.928780 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-28 04:01:27.928805 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-28 04:01:27.928830 | instance | community.general:7.3.0 was installed successfully
2026-08-28 04:01:27.928855 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.928880 | instance | 2.17.12
2026-08-28 04:01:27.928909 | instance | Checked out community.mysql to 3.6.0
2026-08-28 04:01:27.928935 | 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-28 04:01:27.928984 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.929015 | instance | Process install dependency map
2026-08-28 04:01:27.929041 | instance | Starting collection install process
2026-08-28 04:01:27.929067 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-28 04:01:27.929093 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-28 04:01:27.929118 | instance | community.mysql:3.6.0 was installed successfully
2026-08-28 04:01:27.929143 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.929168 | instance | 2.17.12
2026-08-28 04:01:27.929193 | instance | Checked out kubernetes.core to 2.4.0
2026-08-28 04:01:27.929218 | 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-28 04:01:27.929244 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.929269 | instance | Process install dependency map
2026-08-28 04:01:27.929295 | instance | Starting collection install process
2026-08-28 04:01:27.929320 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-28 04:01:27.929346 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-28 04:01:27.929371 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-28 04:01:27.929396 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.929422 | instance | 2.17.12
2026-08-28 04:01:27.929447 | instance | Checked out openstack.cloud to 2.6.0
2026-08-28 04:01:27.929473 | 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-28 04:01:27.929510 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.929537 | instance | Process install dependency map
2026-08-28 04:01:27.929563 | instance | Starting collection install process
2026-08-28 04:01:27.929588 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-28 04:01:27.929613 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-28 04:01:27.929639 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-28 04:01:27.929664 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.929689 | instance | 2.17.12
2026-08-28 04:01:27.929714 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-28 04:01:27.929739 | 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-28 04:01:27.929770 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.929796 | instance | Process install dependency map
2026-08-28 04:01:27.929821 | instance | Starting collection install process
2026-08-28 04:01:27.929846 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-28 04:01:27.929871 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-28 04:01:27.929896 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-28 04:01:27.929921 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.929946 | instance | 2.17.12
2026-08-28 04:01:27.929970 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-28 04:01:27.929995 | 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-28 04:01:27.930021 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.930046 | instance | Process install dependency map
2026-08-28 04:01:27.930140 | instance | Starting collection install process
2026-08-28 04:01:27.930189 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-28 04:01:27.930219 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-28 04:01:27.930246 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-28 04:01:27.930272 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.930298 | instance | 2.17.12
2026-08-28 04:01:27.930324 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-28 04:01:27.930349 | 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-28 04:01:27.930375 | instance | Starting galaxy collection install process
2026-08-28 04:01:27.930401 | instance | Process install dependency map
2026-08-28 04:01:27.930426 | instance | Starting collection install process
2026-08-28 04:01:27.930451 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-28 04:01:27.930476 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-28 04:01:27.930501 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-28 04:01:27.930526 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-28 04:01:27.930552 | instance | 2.17.12
2026-08-28 04:01:27.937311 | 
2026-08-28 04:01:27.937358 | PLAY RECAP
2026-08-28 04:01:27.937402 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-28 04:01:27.937423 | 
2026-08-28 04:01:28.105061 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-28 04:01:28.109532 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-28 04:01:28.677772 | 
2026-08-28 04:01:28.677909 | PLAY [all]
2026-08-28 04:01:28.688459 | 
2026-08-28 04:01:28.688529 | TASK [Install "jq" for log collection]
2026-08-28 04:01:38.531898 | instance | changed
2026-08-28 04:01:38.533783 | 
2026-08-28 04:01:38.533839 | PLAY RECAP
2026-08-28 04:01:38.533891 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-28 04:01:38.533939 | 
2026-08-28 04:01:38.665530 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-28 04:01:38.669005 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-28 04:01:39.265704 | 
2026-08-28 04:01:39.265848 | PLAY [all]
2026-08-28 04:01:39.277238 | 
2026-08-28 04:01:39.277325 | LOOP [Check inventory directories]
2026-08-28 04:01:39.680540 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-28 04:01:39.835789 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-28 04:01:39.985628 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-28 04:01:40.005554 | 
2026-08-28 04:01:40.005769 | LOOP [Copy inventory file for Zuul]
2026-08-28 04:01:40.792703 | instance | changed:
2026-08-28 04:01:40.792904 | instance | {
2026-08-28 04:01:40.792933 | instance |   "ansible_loop_var": "item",
2026-08-28 04:01:40.792977 | instance |   "changed": false,
2026-08-28 04:01:40.793000 | instance |   "failed": false,
2026-08-28 04:01:40.793022 | instance |   "invocation": {
2026-08-28 04:01:40.793041 | instance |     "module_args": {
2026-08-28 04:01:40.793060 | instance |       "checksum_algorithm": "sha1",
2026-08-28 04:01:40.793078 | instance |       "follow": true,
2026-08-28 04:01:40.793097 | instance |       "get_attributes": true,
2026-08-28 04:01:40.793116 | instance |       "get_checksum": true,
2026-08-28 04:01:40.793135 | instance |       "get_mime": true,
2026-08-28 04:01:40.793153 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-28 04:01:40.793171 | instance |     }
2026-08-28 04:01:40.793190 | instance |   },
2026-08-28 04:01:40.793208 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-28 04:01:40.793226 | instance |   "stat": {
2026-08-28 04:01:40.793243 | instance |     "atime": 1787889680.7104123,
2026-08-28 04:01:40.793261 | instance |     "attr_flags": "e",
2026-08-28 04:01:40.793280 | instance |     "attributes": [
2026-08-28 04:01:40.793297 | instance |       "extents"
2026-08-28 04:01:40.793315 | instance |     ],
2026-08-28 04:01:40.793333 | instance |     "block_size": 4096,
2026-08-28 04:01:40.793351 | instance |     "blocks": 8,
2026-08-28 04:01:40.793369 | instance |     "charset": "unknown",
2026-08-28 04:01:40.793388 | instance |     "ctime": 1787889679.6984034,
2026-08-28 04:01:40.793458 | instance |     "dev": 64513,
2026-08-28 04:01:40.793479 | instance |     "device_type": 0,
2026-08-28 04:01:40.793498 | instance |     "executable": true,
2026-08-28 04:01:40.793515 | instance |     "exists": true,
2026-08-28 04:01:40.793533 | instance |     "gid": 1000,
2026-08-28 04:01:40.793551 | instance |     "gr_name": "zuul",
2026-08-28 04:01:40.793568 | instance |     "inode": 1047523,
2026-08-28 04:01:40.793586 | instance |     "isblk": false,
2026-08-28 04:01:40.793604 | instance |     "ischr": false,
2026-08-28 04:01:40.793622 | instance |     "isdir": true,
2026-08-28 04:01:40.793640 | instance |     "isfifo": false,
2026-08-28 04:01:40.793657 | instance |     "isgid": false,
2026-08-28 04:01:40.793674 | instance |     "islnk": false,
2026-08-28 04:01:40.793692 | instance |     "isreg": false,
2026-08-28 04:01:40.793709 | instance |     "issock": false,
2026-08-28 04:01:40.793726 | instance |     "isuid": false,
2026-08-28 04:01:40.793742 | instance |     "mimetype": "unknown",
2026-08-28 04:01:40.793760 | instance |     "mode": "0755",
2026-08-28 04:01:40.793777 | instance |     "mtime": 1787889679.6984034,
2026-08-28 04:01:40.793795 | instance |     "nlink": 22,
2026-08-28 04:01:40.793812 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-28 04:01:40.793830 | instance |     "pw_name": "zuul",
2026-08-28 04:01:40.793852 | instance |     "readable": true,
2026-08-28 04:01:40.793869 | instance |     "rgrp": true,
2026-08-28 04:01:40.793887 | instance |     "roth": true,
2026-08-28 04:01:40.793905 | instance |     "rusr": true,
2026-08-28 04:01:40.793922 | instance |     "size": 4096,
2026-08-28 04:01:40.793939 | instance |     "uid": 1000,
2026-08-28 04:01:40.793970 | instance |     "version": "3157604392",
2026-08-28 04:01:40.793990 | instance |     "wgrp": false,
2026-08-28 04:01:40.794009 | instance |     "woth": false,
2026-08-28 04:01:40.794027 | instance |     "writeable": true,
2026-08-28 04:01:40.794045 | instance |     "wusr": true,
2026-08-28 04:01:40.794062 | instance |     "xgrp": true,
2026-08-28 04:01:40.794079 | instance |     "xoth": true,
2026-08-28 04:01:40.794097 | instance |     "xusr": true
2026-08-28 04:01:40.794114 | instance |   }
2026-08-28 04:01:40.794132 | instance | }
2026-08-28 04:01:40.794167 | instance | ok: All items complete
2026-08-28 04:01:40.794188 | 
2026-08-28 04:01:40.795437 | instance | skipping: Conditional result was False
2026-08-28 04:01:40.796025 | instance | skipping: Conditional result was False
2026-08-28 04:01:40.807114 | 
2026-08-28 04:01:40.807255 | LOOP [Switch "ansible_host" to private IP]
2026-08-28 04:01:41.190709 | instance | changed: 1 replacements made
2026-08-28 04:01:41.192035 | instance | skipping: Conditional result was False
2026-08-28 04:01:41.192784 | instance | skipping: Conditional result was False
2026-08-28 04:01:41.211564 | 
2026-08-28 04:01:41.211787 | TASK [Run Molecule scenario]
2026-08-28 04:01:42.156810 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-28 04:01:42.550619 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-28 04:01:42.550706 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-28 04:01:52.949142 | instance | INFO     [csi > dependency] Executing
2026-08-28 04:01:52.949488 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-28 04:01:52.949901 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-28 04:01:52.950145 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-28 04:01:52.965795 | instance | INFO     [csi > cleanup] Executing
2026-08-28 04:01:52.966410 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-28 04:01:52.979286 | instance | INFO     [csi > destroy] Executing
2026-08-28 04:01:52.979412 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-28 04:01:52.979516 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-28 04:01:52.989569 | instance | INFO     [csi > syntax] Executing
2026-08-28 04:01:54.430859 | instance |
2026-08-28 04:01:54.431119 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-28 04:01:54.491848 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-28 04:01:54.507001 | instance | INFO     [csi > create] Executing
2026-08-28 04:01:54.510497 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-28 04:01:54.524808 | instance | INFO     [csi > prepare] Executing
2026-08-28 04:01:55.364058 | instance |
2026-08-28 04:01:55.364298 | instance | PLAY [Prepare] *****************************************************************
2026-08-28 04:01:55.364519 | instance |
2026-08-28 04:01:55.364749 | instance | TASK [Gathering Facts] *********************************************************
2026-08-28 04:01:55.364979 | instance | Friday 28 August 2026  04:01:55 +0000 (0:00:00.027)       0:00:00.027 *********
2026-08-28 04:01:56.564061 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-28 04:01:56.564169 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-28 04:01:56.564177 | instance | interpreter could change the meaning of that path. See
2026-08-28 04:01:56.564281 | instance | https://docs.ansible.com/ansible-
2026-08-28 04:01:56.564386 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-28 04:01:56.572610 | instance | ok: [instance]
2026-08-28 04:01:56.572662 | instance |
2026-08-28 04:01:56.572770 | instance | TASK [Configure short hostname] ************************************************
2026-08-28 04:01:56.572871 | instance | Friday 28 August 2026  04:01:56 +0000 (0:00:01.209)       0:00:01.236 *********
2026-08-28 04:01:57.234684 | instance | changed: [instance]
2026-08-28 04:01:57.234873 | instance |
2026-08-28 04:01:57.235118 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-28 04:01:57.235461 | instance | Friday 28 August 2026  04:01:57 +0000 (0:00:00.661)       0:00:01.897 *********
2026-08-28 04:01:57.522923 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-28 04:01:57.523229 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-28 04:01:57.523586 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-28 04:01:57.531979 | instance | changed: [instance]
2026-08-28 04:01:57.532198 | instance |
2026-08-28 04:01:57.532459 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-28 04:01:57.532681 | instance | Friday 28 August 2026  04:01:57 +0000 (0:00:00.297)       0:00:02.195 *********
2026-08-28 04:01:58.274295 | instance | ok: [instance]
2026-08-28 04:01:58.274409 | instance |
2026-08-28 04:01:58.274737 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-28 04:01:58.274877 | instance |
2026-08-28 04:01:58.275130 | instance | TASK [Gathering Facts] *********************************************************
2026-08-28 04:01:58.275414 | instance | Friday 28 August 2026  04:01:58 +0000 (0:00:00.742)       0:00:02.937 *********
2026-08-28 04:01:59.012431 | instance | ok: [instance]
2026-08-28 04:01:59.012639 | instance |
2026-08-28 04:01:59.012889 | instance | TASK [Install depedencies] *****************************************************
2026-08-28 04:01:59.013244 | instance | Friday 28 August 2026  04:01:59 +0000 (0:00:00.737)       0:00:03.675 *********
2026-08-28 04:02:20.425394 | instance | changed: [instance]
2026-08-28 04:02:20.425578 | instance |
2026-08-28 04:02:20.425827 | instance | TASK [Start up service] ********************************************************
2026-08-28 04:02:20.426086 | instance | Friday 28 August 2026  04:02:20 +0000 (0:00:21.412)       0:00:25.088 *********
2026-08-28 04:02:20.921861 | instance | ok: [instance]
2026-08-28 04:02:20.921993 | instance |
2026-08-28 04:02:20.922149 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-28 04:02:20.922305 | instance | Friday 28 August 2026  04:02:20 +0000 (0:00:00.496)       0:00:25.585 *********
2026-08-28 04:02:21.185283 | instance | ok: [instance]
2026-08-28 04:02:21.185402 | instance |
2026-08-28 04:02:21.185561 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-28 04:02:21.185710 | instance | Friday 28 August 2026  04:02:21 +0000 (0:00:00.262)       0:00:25.848 *********
2026-08-28 04:02:21.824660 | instance | changed: [instance]
2026-08-28 04:02:21.824818 | instance |
2026-08-28 04:02:21.825019 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-28 04:02:21.825189 | instance | Friday 28 August 2026  04:02:21 +0000 (0:00:00.639)       0:00:26.487 *********
2026-08-28 04:02:22.004488 | instance | ok: [instance]
2026-08-28 04:02:22.004556 | instance |
2026-08-28 04:02:22.004738 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-28 04:02:22.004906 | instance | Friday 28 August 2026  04:02:21 +0000 (0:00:00.180)       0:00:26.667 *********
2026-08-28 04:02:22.028238 | instance | skipping: [instance]
2026-08-28 04:02:22.028363 | instance |
2026-08-28 04:02:22.028516 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-28 04:02:22.028675 | instance | Friday 28 August 2026  04:02:22 +0000 (0:00:00.023)       0:00:26.691 *********
2026-08-28 04:02:22.589874 | instance | changed: [instance] => (item=osd0)
2026-08-28 04:02:22.589937 | instance | changed: [instance] => (item=osd1)
2026-08-28 04:02:22.590072 | instance | changed: [instance] => (item=osd2)
2026-08-28 04:02:22.590172 | instance |
2026-08-28 04:02:22.590297 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-28 04:02:22.590406 | instance | Friday 28 August 2026  04:02:22 +0000 (0:00:00.561)       0:00:27.253 *********
2026-08-28 04:02:23.221377 | instance | changed: [instance] => (item=osd0)
2026-08-28 04:02:23.221463 | instance | changed: [instance] => (item=osd1)
2026-08-28 04:02:23.221474 | instance | changed: [instance] => (item=osd2)
2026-08-28 04:02:23.221483 | instance |
2026-08-28 04:02:23.221493 | instance | TASK [Start loop devices] ******************************************************
2026-08-28 04:02:23.221503 | instance | Friday 28 August 2026  04:02:23 +0000 (0:00:00.629)       0:00:27.883 *********
2026-08-28 04:02:23.987141 | instance | changed: [instance] => (item=osd0)
2026-08-28 04:02:23.987248 | instance | changed: [instance] => (item=osd1)
2026-08-28 04:02:23.987814 | instance | changed: [instance] => (item=osd2)
2026-08-28 04:02:23.987939 | instance |
2026-08-28 04:02:23.988221 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-28 04:02:23.988293 | instance | Friday 28 August 2026  04:02:23 +0000 (0:00:00.766)       0:00:28.650 *********
2026-08-28 04:02:27.226422 | instance | changed: [instance] => (item=osd0)
2026-08-28 04:02:27.226473 | instance | changed: [instance] => (item=osd1)
2026-08-28 04:02:27.226479 | instance | changed: [instance] => (item=osd2)
2026-08-28 04:02:27.226485 | instance |
2026-08-28 04:02:27.226491 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-28 04:02:27.226497 | instance | Friday 28 August 2026  04:02:27 +0000 (0:00:03.239)       0:00:31.889 *********
2026-08-28 04:02:29.163570 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-28 04:02:29.163777 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-28 04:02:29.164039 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-28 04:02:29.164249 | instance |
2026-08-28 04:02:29.164470 | instance | PLAY RECAP *********************************************************************
2026-08-28 04:02:29.164714 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-28 04:02:29.164921 | instance |
2026-08-28 04:02:29.165170 | instance | Friday 28 August 2026  04:02:29 +0000 (0:00:01.938)       0:00:33.827 *********
2026-08-28 04:02:29.165387 | instance | ===============================================================================
2026-08-28 04:02:29.165615 | instance | Install depedencies ---------------------------------------------------- 21.41s
2026-08-28 04:02:29.165841 | instance | Create a volume group for each loop device ------------------------------ 3.24s
2026-08-28 04:02:29.166096 | instance | Create a logical volume for each loop device ---------------------------- 1.94s
2026-08-28 04:02:29.166315 | instance | Gathering Facts --------------------------------------------------------- 1.21s
2026-08-28 04:02:29.166535 | instance | Start loop devices ------------------------------------------------------ 0.77s
2026-08-28 04:02:29.166743 | instance | Purge "snapd" package --------------------------------------------------- 0.74s
2026-08-28 04:02:29.166959 | instance | Gathering Facts --------------------------------------------------------- 0.74s
2026-08-28 04:02:29.167197 | instance | Configure short hostname ------------------------------------------------ 0.66s
2026-08-28 04:02:29.167486 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.64s
2026-08-28 04:02:29.167713 | instance | Set permissions on loopback devices ------------------------------------- 0.63s
2026-08-28 04:02:29.167930 | instance | Create devices for Ceph ------------------------------------------------- 0.56s
2026-08-28 04:02:29.168188 | instance | Start up service -------------------------------------------------------- 0.50s
2026-08-28 04:02:29.168412 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-08-28 04:02:29.168618 | instance | Generate lvm.conf ------------------------------------------------------- 0.26s
2026-08-28 04:02:29.168839 | instance | Get list of all loopback devices ---------------------------------------- 0.18s
2026-08-28 04:02:29.169092 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-28 04:02:29.239233 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-28 04:02:29.248980 | instance | INFO     [csi > converge] Executing
2026-08-28 04:02:30.712873 | instance |
2026-08-28 04:02:30.713124 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-28 04:02:30.713343 | instance |
2026-08-28 04:02:30.713576 | instance | TASK [Gathering Facts] *********************************************************
2026-08-28 04:02:30.713803 | instance | Friday 28 August 2026  04:02:30 +0000 (0:00:00.007)       0:00:00.007 *********
2026-08-28 04:02:31.716469 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-28 04:02:31.716704 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-28 04:02:31.716999 | instance | interpreter could change the meaning of that path. See
2026-08-28 04:02:31.717291 | instance | https://docs.ansible.com/ansible-
2026-08-28 04:02:31.717530 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-28 04:02:31.726780 | instance | ok: [instance]
2026-08-28 04:02:31.727115 | instance |
2026-08-28 04:02:31.727540 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-28 04:02:31.727901 | instance | Friday 28 August 2026  04:02:31 +0000 (0:00:01.013)       0:00:01.021 *********
2026-08-28 04:02:31.773589 | instance | ok: [instance] => {
2026-08-28 04:02:31.773826 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-28 04:02:31.774093 | instance | }
2026-08-28 04:02:31.774319 | instance |
2026-08-28 04:02:31.774551 | instance | PLAY [all] *********************************************************************
2026-08-28 04:02:31.774797 | instance |
2026-08-28 04:02:31.775155 | instance | TASK [Gathering Facts] *********************************************************
2026-08-28 04:02:31.775536 | instance | Friday 28 August 2026  04:02:31 +0000 (0:00:00.046)       0:00:01.067 *********
2026-08-28 04:02:32.699661 | instance | ok: [instance]
2026-08-28 04:02:32.699823 | instance |
2026-08-28 04:02:32.700124 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-28 04:02:32.700365 | instance | Friday 28 August 2026  04:02:32 +0000 (0:00:00.926)       0:00:01.993 *********
2026-08-28 04:02:32.886181 | instance | ok: [instance]
2026-08-28 04:02:32.886396 | instance |
2026-08-28 04:02:32.886683 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-28 04:02:32.886905 | instance |
2026-08-28 04:02:32.887176 | instance | TASK [Gathering Facts] *********************************************************
2026-08-28 04:02:32.887472 | instance | Friday 28 August 2026  04:02:32 +0000 (0:00:00.187)       0:00:02.181 *********
2026-08-28 04:02:33.803536 | instance | ok: [instance]
2026-08-28 04:02:33.803617 | instance |
2026-08-28 04:02:33.803825 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-28 04:02:33.803957 | instance | Friday 28 August 2026  04:02:33 +0000 (0:00:00.916)       0:00:03.098 *********
2026-08-28 04:02:34.138064 | instance | ok: [instance]
2026-08-28 04:02:34.138296 | instance |
2026-08-28 04:02:34.138484 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-28 04:02:34.138666 | instance | Friday 28 August 2026  04:02:34 +0000 (0:00:00.334)       0:00:03.432 *********
2026-08-28 04:02:34.188139 | instance | skipping: [instance]
2026-08-28 04:02:34.188209 | instance |
2026-08-28 04:02:34.188372 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-28 04:02:34.188633 | instance | Friday 28 August 2026  04:02:34 +0000 (0:00:00.049)       0:00:03.482 *********
2026-08-28 04:02:34.531912 | instance | changed: [instance]
2026-08-28 04:02:34.532022 | instance |
2026-08-28 04:02:34.532193 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-28 04:02:34.532448 | instance | Friday 28 August 2026  04:02:34 +0000 (0:00:00.344)       0:00:03.826 *********
2026-08-28 04:02:34.628227 | instance | ok: [instance] => {
2026-08-28 04:02:34.628470 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-28 04:02:34.628812 | instance | }
2026-08-28 04:02:34.629100 | instance |
2026-08-28 04:02:34.629388 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-28 04:02:34.629670 | instance | Friday 28 August 2026  04:02:34 +0000 (0:00:00.095)       0:00:03.922 *********
2026-08-28 04:02:35.395851 | instance | changed: [instance]
2026-08-28 04:02:35.395965 | instance |
2026-08-28 04:02:35.396231 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-28 04:02:35.396418 | instance | Friday 28 August 2026  04:02:35 +0000 (0:00:00.765)       0:00:04.687 *********
2026-08-28 04:02:35.446127 | instance | skipping: [instance]
2026-08-28 04:02:35.446361 | instance |
2026-08-28 04:02:35.446569 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-28 04:02:35.446783 | instance | Friday 28 August 2026  04:02:35 +0000 (0:00:00.051)       0:00:04.738 *********
2026-08-28 04:02:35.495412 | instance | skipping: [instance]
2026-08-28 04:02:35.495553 | instance |
2026-08-28 04:02:35.495608 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-28 04:02:35.495701 | instance | Friday 28 August 2026  04:02:35 +0000 (0:00:00.051)       0:00:04.790 *********
2026-08-28 04:02:35.736472 | instance | ok: [instance]
2026-08-28 04:02:35.736676 | instance |
2026-08-28 04:02:35.736915 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-28 04:02:35.737178 | instance | Friday 28 August 2026  04:02:35 +0000 (0:00:00.240)       0:00:05.030 *********
2026-08-28 04:02:37.245106 | instance | ok: [instance]
2026-08-28 04:02:37.245190 | instance |
2026-08-28 04:02:37.245265 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-28 04:02:37.245369 | instance | Friday 28 August 2026  04:02:37 +0000 (0:00:01.509)       0:00:06.540 *********
2026-08-28 04:02:37.334804 | instance | ok: [instance] => {
2026-08-28 04:02:37.334960 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-28 04:02:37.335210 | instance | }
2026-08-28 04:02:37.335502 | instance |
2026-08-28 04:02:37.335734 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-28 04:02:37.335963 | instance | Friday 28 August 2026  04:02:37 +0000 (0:00:00.089)       0:00:06.629 *********
2026-08-28 04:02:38.080618 | instance | changed: [instance]
2026-08-28 04:02:38.080704 | instance |
2026-08-28 04:02:38.080875 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-28 04:02:38.081031 | instance | Friday 28 August 2026  04:02:38 +0000 (0:00:00.745)       0:00:07.375 *********
2026-08-28 04:02:40.950344 | instance | changed: [instance]
2026-08-28 04:02:40.950406 | instance |
2026-08-28 04:02:40.950418 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-28 04:02:40.950429 | instance | Friday 28 August 2026  04:02:40 +0000 (0:00:02.869)       0:00:10.244 *********
2026-08-28 04:02:40.987866 | instance | skipping: [instance]
2026-08-28 04:02:40.988582 | instance |
2026-08-28 04:02:40.988615 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-28 04:02:40.988628 | instance | Friday 28 August 2026  04:02:40 +0000 (0:00:00.038)       0:00:10.282 *********
2026-08-28 04:02:41.019034 | instance | skipping: [instance]
2026-08-28 04:02:41.019746 | instance |
2026-08-28 04:02:41.019796 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-28 04:02:41.019804 | instance | Friday 28 August 2026  04:02:41 +0000 (0:00:00.031)       0:00:10.313 *********
2026-08-28 04:02:41.057431 | instance | skipping: [instance]
2026-08-28 04:02:41.058052 | instance |
2026-08-28 04:02:41.058091 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-28 04:02:41.058103 | instance | Friday 28 August 2026  04:02:41 +0000 (0:00:00.038)       0:00:10.352 *********
2026-08-28 04:02:47.560933 | instance | changed: [instance]
2026-08-28 04:02:47.561221 | instance |
2026-08-28 04:02:47.561451 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-28 04:02:47.561802 | instance | Friday 28 August 2026  04:02:47 +0000 (0:00:06.502)       0:00:16.854 *********
2026-08-28 04:02:48.158898 | instance | changed: [instance]
2026-08-28 04:02:48.158974 | instance |
2026-08-28 04:02:48.159179 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-28 04:02:48.159229 | instance | Friday 28 August 2026  04:02:48 +0000 (0:00:00.598)       0:00:17.453 *********
2026-08-28 04:02:49.145523 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-28 04:02:49.146769 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-28 04:02:49.146816 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-28 04:02:49.146824 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-28 04:02:49.146831 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-28 04:02:49.146837 | instance |
2026-08-28 04:02:49.146849 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-28 04:02:49.146855 | instance | Friday 28 August 2026  04:02:49 +0000 (0:00:00.986)       0:00:18.440 *********
2026-08-28 04:02:49.813097 | instance | changed: [instance]
2026-08-28 04:02:49.813187 | instance |
2026-08-28 04:02:49.813945 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-28 04:02:49.813989 | instance | Friday 28 August 2026  04:02:49 +0000 (0:00:00.638)       0:00:19.078 *********
2026-08-28 04:02:49.813998 | instance |
2026-08-28 04:02:49.814005 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-28 04:02:49.814012 | instance | Friday 28 August 2026  04:02:49 +0000 (0:00:00.029)       0:00:19.107 *********
2026-08-28 04:02:50.781163 | instance | ok: [instance]
2026-08-28 04:02:50.781891 | instance |
2026-08-28 04:02:50.781956 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-28 04:02:50.781968 | instance | Friday 28 August 2026  04:02:50 +0000 (0:00:00.967)       0:00:20.075 *********
2026-08-28 04:02:51.302132 | instance | changed: [instance]
2026-08-28 04:02:51.303013 | instance |
2026-08-28 04:02:51.303090 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-28 04:02:51.303102 | instance | Friday 28 August 2026  04:02:51 +0000 (0:00:00.520)       0:00:20.596 *********
2026-08-28 04:02:51.912291 | instance | changed: [instance]
2026-08-28 04:02:51.912957 | instance |
2026-08-28 04:02:51.913009 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-28 04:02:51.913022 | instance | Friday 28 August 2026  04:02:51 +0000 (0:00:00.610)       0:00:21.206 *********
2026-08-28 04:02:52.139241 | instance | ok: [instance]
2026-08-28 04:02:52.139297 | instance |
2026-08-28 04:02:52.139353 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-28 04:02:52.139368 | instance | Friday 28 August 2026  04:02:52 +0000 (0:00:00.226)       0:00:21.433 *********
2026-08-28 04:02:52.215198 | instance | ok: [instance] => {
2026-08-28 04:02:52.215293 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-28 04:02:52.216023 | instance | }
2026-08-28 04:02:52.216102 | instance |
2026-08-28 04:02:52.216111 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-28 04:02:52.216119 | instance | Friday 28 August 2026  04:02:52 +0000 (0:00:00.076)       0:00:21.510 *********
2026-08-28 04:02:54.137801 | instance | changed: [instance]
2026-08-28 04:02:54.138502 | instance |
2026-08-28 04:02:54.138568 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-28 04:02:54.138581 | instance | Friday 28 August 2026  04:02:54 +0000 (0:00:01.922)       0:00:23.432 *********
2026-08-28 04:02:58.522771 | instance | changed: [instance]
2026-08-28 04:02:58.523415 | instance |
2026-08-28 04:02:58.523468 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-28 04:02:58.523484 | instance | Friday 28 August 2026  04:02:58 +0000 (0:00:04.384)       0:00:27.817 *********
2026-08-28 04:02:59.852356 | instance | ok: [instance]
2026-08-28 04:02:59.853093 | instance |
2026-08-28 04:02:59.853159 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-28 04:02:59.853172 | instance | Friday 28 August 2026  04:02:59 +0000 (0:00:01.329)       0:00:29.146 *********
2026-08-28 04:03:00.253457 | instance | changed: [instance]
2026-08-28 04:03:00.253564 | instance |
2026-08-28 04:03:00.253897 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-28 04:03:00.254102 | instance | Friday 28 August 2026  04:03:00 +0000 (0:00:00.401)       0:00:29.548 *********
2026-08-28 04:03:00.765320 | instance | changed: [instance]
2026-08-28 04:03:00.766059 | instance |
2026-08-28 04:03:00.766143 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-28 04:03:00.766155 | instance | Friday 28 August 2026  04:03:00 +0000 (0:00:00.511)       0:00:30.059 *********
2026-08-28 04:03:01.416864 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-28 04:03:01.416938 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-28 04:03:01.416950 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-28 04:03:01.416960 | instance |
2026-08-28 04:03:01.416969 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-28 04:03:01.416978 | instance | Friday 28 August 2026  04:03:01 +0000 (0:00:00.650)       0:00:30.709 *********
2026-08-28 04:03:01.911888 | instance | changed: [instance]
2026-08-28 04:03:01.911990 | instance |
2026-08-28 04:03:01.912122 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-28 04:03:01.912294 | instance | Friday 28 August 2026  04:03:01 +0000 (0:00:00.496)       0:00:31.206 *********
2026-08-28 04:03:02.449591 | instance | changed: [instance]
2026-08-28 04:03:02.449702 | instance |
2026-08-28 04:03:02.449961 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-28 04:03:02.450196 | instance | Friday 28 August 2026  04:03:02 +0000 (0:00:00.508)       0:00:31.714 *********
2026-08-28 04:03:02.450431 | instance |
2026-08-28 04:03:02.450675 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-28 04:03:02.450904 | instance | Friday 28 August 2026  04:03:02 +0000 (0:00:00.029)       0:00:31.744 *********
2026-08-28 04:03:03.210520 | instance | ok: [instance]
2026-08-28 04:03:03.210639 | instance |
2026-08-28 04:03:03.211086 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-28 04:03:03.211363 | instance | Friday 28 August 2026  04:03:03 +0000 (0:00:00.760)       0:00:32.505 *********
2026-08-28 04:03:04.091448 | instance | changed: [instance]
2026-08-28 04:03:04.091551 | instance |
2026-08-28 04:03:04.091564 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-28 04:03:04.091574 | instance | Friday 28 August 2026  04:03:04 +0000 (0:00:00.879)       0:00:33.384 *********
2026-08-28 04:03:04.727239 | instance | changed: [instance]
2026-08-28 04:03:04.727440 | instance |
2026-08-28 04:03:04.727699 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-28 04:03:04.727929 | instance | Friday 28 August 2026  04:03:04 +0000 (0:00:00.636)       0:00:34.021 *********
2026-08-28 04:03:04.797437 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-28 04:03:04.797643 | instance |
2026-08-28 04:03:04.797874 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-28 04:03:04.798106 | instance | Friday 28 August 2026  04:03:04 +0000 (0:00:00.070)       0:00:34.092 *********
2026-08-28 04:03:10.810949 | instance | changed: [instance]
2026-08-28 04:03:10.811073 | instance |
2026-08-28 04:03:10.811171 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-28 04:03:10.811366 | instance | Friday 28 August 2026  04:03:10 +0000 (0:00:06.013)       0:00:40.105 *********
2026-08-28 04:03:11.516696 | instance | ok: [instance] => (item=chronyd)
2026-08-28 04:03:11.516920 | instance | ok: [instance] => (item=sshd)
2026-08-28 04:03:11.517150 | instance |
2026-08-28 04:03:11.517416 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-28 04:03:11.517656 | instance | Friday 28 August 2026  04:03:11 +0000 (0:00:00.705)       0:00:40.810 *********
2026-08-28 04:03:14.925751 | instance | changed: [instance]
2026-08-28 04:03:14.925864 | instance |
2026-08-28 04:03:14.926034 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-28 04:03:14.926161 | instance | Friday 28 August 2026  04:03:14 +0000 (0:00:03.409)       0:00:44.220 *********
2026-08-28 04:03:15.157996 | instance | ok: [instance]
2026-08-28 04:03:15.158186 | instance |
2026-08-28 04:03:15.158462 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-28 04:03:15.158693 | instance | Friday 28 August 2026  04:03:15 +0000 (0:00:00.232)       0:00:44.452 *********
2026-08-28 04:03:15.607659 | instance | changed: [instance]
2026-08-28 04:03:15.607838 | instance |
2026-08-28 04:03:15.608085 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-28 04:03:15.608359 | instance | Friday 28 August 2026  04:03:15 +0000 (0:00:00.449)       0:00:44.901 *********
2026-08-28 04:03:16.007349 | instance | changed: [instance]
2026-08-28 04:03:16.007546 | instance |
2026-08-28 04:03:16.007560 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-28 04:03:16.007570 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.399)       0:00:45.301 *********
2026-08-28 04:03:16.147428 | instance | ok: [instance]
2026-08-28 04:03:16.148112 | instance |
2026-08-28 04:03:16.148144 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-28 04:03:16.148154 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.140)       0:00:45.441 *********
2026-08-28 04:03:16.416004 | instance | ok: [instance] => (item=instance)
2026-08-28 04:03:16.416641 | instance |
2026-08-28 04:03:16.416693 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-28 04:03:16.416705 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.268)       0:00:45.710 *********
2026-08-28 04:03:16.480063 | instance | ok: [instance]
2026-08-28 04:03:16.480565 | instance |
2026-08-28 04:03:16.480620 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-28 04:03:16.480629 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.064)       0:00:45.774 *********
2026-08-28 04:03:16.566461 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-28 04:03:16.566560 | instance |
2026-08-28 04:03:16.566821 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-28 04:03:16.566968 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.086)       0:00:45.861 *********
2026-08-28 04:03:16.904876 | instance | changed: [instance]
2026-08-28 04:03:16.904930 | instance |
2026-08-28 04:03:16.904956 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-28 04:03:16.904966 | instance | Friday 28 August 2026  04:03:16 +0000 (0:00:00.336)       0:00:46.197 *********
2026-08-28 04:03:17.637844 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-28 04:03:17.637949 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-28 04:03:17.638601 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-28 04:03:17.638661 | instance |
2026-08-28 04:03:17.638670 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-28 04:03:17.638676 | instance | Friday 28 August 2026  04:03:17 +0000 (0:00:00.734)       0:00:46.932 *********
2026-08-28 04:04:53.922235 | instance | ok: [instance]
2026-08-28 04:04:53.922303 | instance |
2026-08-28 04:04:53.922315 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-28 04:04:53.922330 | instance | Friday 28 August 2026  04:04:53 +0000 (0:01:36.283)       0:02:23.216 *********
2026-08-28 04:04:54.189912 | instance | changed: [instance]
2026-08-28 04:04:54.189972 | instance |
2026-08-28 04:04:54.189983 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-28 04:04:54.189993 | instance | Friday 28 August 2026  04:04:54 +0000 (0:00:00.267)       0:02:23.483 *********
2026-08-28 04:04:54.269229 | instance | ok: [instance]
2026-08-28 04:04:54.269267 | instance |
2026-08-28 04:04:54.269272 | instance | TASK [Install Ceph host] *******************************************************
2026-08-28 04:04:54.269277 | instance | Friday 28 August 2026  04:04:54 +0000 (0:00:00.080)       0:02:23.564 *********
2026-08-28 04:04:54.354105 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-28 04:04:54.354191 | instance |
2026-08-28 04:04:54.354426 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-28 04:04:54.354729 | instance | Friday 28 August 2026  04:04:54 +0000 (0:00:00.085)       0:02:23.649 *********
2026-08-28 04:04:55.991485 | instance | ok: [instance]
2026-08-28 04:04:55.991618 | instance |
2026-08-28 04:04:55.991790 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-28 04:04:55.991942 | instance | Friday 28 August 2026  04:04:55 +0000 (0:00:01.637)       0:02:25.286 *********
2026-08-28 04:04:56.068600 | instance | ok: [instance] => (item=instance)
2026-08-28 04:04:56.068836 | instance |
2026-08-28 04:04:56.069088 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-28 04:04:56.069337 | instance | Friday 28 August 2026  04:04:56 +0000 (0:00:00.076)       0:02:25.363 *********
2026-08-28 04:04:56.428834 | instance | ok: [instance]
2026-08-28 04:04:56.428895 | instance |
2026-08-28 04:04:56.428906 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-28 04:04:56.428916 | instance | Friday 28 August 2026  04:04:56 +0000 (0:00:00.359)       0:02:25.722 *********
2026-08-28 04:04:58.643872 | instance | ok: [instance]
2026-08-28 04:04:58.644550 | instance |
2026-08-28 04:04:58.644621 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-28 04:04:58.644632 | instance | Friday 28 August 2026  04:04:58 +0000 (0:00:02.215)       0:02:27.938 *********
2026-08-28 04:05:48.871010 | 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-28 04:05:48.872112 | 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_zaa_xx7g/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_zaa_xx7g/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_zaa_xx7g/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_zaa_xx7g/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-28T04:05:48.702+0000 7fe4a6263640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC9CJFq9eA7LiAA4CK4LsD2DmjNNAW0IYci1jGTtIZjslfNEEHVIj/RFBA=: Malformed input [buffer:3]\n2026-08-28T04:05:48.702+0000 7fe4a6263640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-28T04:05:48.706+0000 7fe4a6263640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC9CJFq9eA7LiAA4CK4LsD2DmjNNAW0IYci1jGTtIZjslfNEEHVIj/RFBA=: Malformed input [buffer:3]\n2026-08-28T04:05:48.706+0000 7fe4a6263640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-28T04:05:48.706+0000 7fe4a6263640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC9CJFq9eA7LiAA4CK4LsD2DmjNNAW0IYci1jGTtIZjslfNEEHVIj/RFBA=: Malformed input [buffer:3]\n2026-08-28T04:05:48.706+0000 7fe4a6263640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-28T04:05:48.706+0000 7fe4a6263640 -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-28 04:05:48.875447 | instance |
2026-08-28 04:05:48.875718 | instance | PLAY RECAP *********************************************************************
2026-08-28 04:05:48.875962 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-28 04:05:48.876171 | instance |
2026-08-28 04:05:48.876396 | instance | Friday 28 August 2026  04:05:48 +0000 (0:00:50.232)       0:03:18.170 *********
2026-08-28 04:05:48.876623 | instance | ===============================================================================
2026-08-28 04:05:48.876844 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 96.28s
2026-08-28 04:05:48.877059 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.23s
2026-08-28 04:05:48.877291 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.50s
2026-08-28 04:05:48.877510 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 6.01s
2026-08-28 04:05:48.877749 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.38s
2026-08-28 04:05:48.877972 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 3.41s
2026-08-28 04:05:48.878178 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-08-28 04:05:48.878392 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.22s
2026-08-28 04:05:48.878624 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.92s
2026-08-28 04:05:48.878840 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.73s
2026-08-28 04:05:48.879055 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.64s
2026-08-28 04:05:48.879363 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.51s
2026-08-28 04:05:48.879664 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.33s
2026-08-28 04:05:48.879880 | instance | Gathering Facts --------------------------------------------------------- 1.01s
2026-08-28 04:05:48.880092 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.99s
2026-08-28 04:05:48.880305 | instance | Gathering Facts --------------------------------------------------------- 0.93s
2026-08-28 04:05:48.880514 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-28 04:05:48.880748 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.88s
2026-08-28 04:05:48.880970 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.77s
2026-08-28 04:05:48.881189 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.75s
2026-08-28 04:05:48.969032 | 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-28 04:05:48.969167 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-28 04:05:48.969310 | 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-28 04:05:49.081445 | instance | ERROR
2026-08-28 04:05:49.081717 | instance | {
2026-08-28 04:05:49.081777 | instance |   "delta": "0:04:07.448600",
2026-08-28 04:05:49.081835 | instance |   "end": "2026-08-28 04:05:49.032127",
2026-08-28 04:05:49.081861 | instance |   "msg": "non-zero return code",
2026-08-28 04:05:49.081880 | instance |   "rc": 2,
2026-08-28 04:05:49.081900 | instance |   "start": "2026-08-28 04:01:41.583527"
2026-08-28 04:05:49.081942 | instance | }
failure
2026-08-28 04:05:49.088498 | 
2026-08-28 04:05:49.088583 | PLAY RECAP
2026-08-28 04:05:49.088636 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-28 04:05:49.088659 | 
2026-08-28 04:05:49.265704 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-28 04:05:49.271453 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-28 04:05:50.128522 | 
2026-08-28 04:05:50.128651 | PLAY [all]
2026-08-28 04:05:50.143683 | 
2026-08-28 04:05:50.143767 | TASK [gather-host-logs : creating directory for system status]
2026-08-28 04:05:50.545248 | instance | changed
2026-08-28 04:05:50.550724 | 
2026-08-28 04:05:50.550813 | TASK [gather-host-logs : Get logs for each host]
2026-08-28 04:05:50.923752 | instance | + systemd-cgls --full --all --no-pager
2026-08-28 04:05:50.937945 | instance | + ip addr
2026-08-28 04:05:50.940860 | instance | + ip route
2026-08-28 04:05:50.942961 | instance | + lsblk
2026-08-28 04:05:50.947932 | instance | + mount
2026-08-28 04:05:50.950483 | instance | + docker images
2026-08-28 04:05:50.977545 | instance | + brctl show
2026-08-28 04:05:50.978106 | instance | /bin/bash: line 8: brctl: command not found
2026-08-28 04:05:50.978449 | instance | + ps aux --sort=-%mem
2026-08-28 04:05:50.997301 | instance | + dpkg -l
2026-08-28 04:05:51.007960 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-28 04:05:51.008683 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-28 04:05:51.032099 | instance | + '[' '!' -z '' ']'
2026-08-28 04:05:51.086468 | instance | ok: Runtime: 0:00:00.112957
2026-08-28 04:05:51.094936 | 
2026-08-28 04:05:51.095030 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-28 04:05:51.810682 | instance | changed:
2026-08-28 04:05:51.810864 | instance | created directory /var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/logs/instance
2026-08-28 04:05:51.810893 | instance | cd+++++++++ system/
2026-08-28 04:05:51.810927 | instance | >f+++++++++ system/brctl-show.txt
2026-08-28 04:05:51.810984 | instance | >f+++++++++ system/docker-images.txt
2026-08-28 04:05:51.811085 | instance | >f+++++++++ system/ip-addr.txt
2026-08-28 04:05:51.811119 | instance | >f+++++++++ system/ip-route.txt
2026-08-28 04:05:51.811143 | instance | >f+++++++++ system/lsblk.txt
2026-08-28 04:05:51.811169 | instance | >f+++++++++ system/mount.txt
2026-08-28 04:05:51.811190 | instance | >f+++++++++ system/packages.txt
2026-08-28 04:05:51.811210 | instance | >f+++++++++ system/ps.txt
2026-08-28 04:05:51.811232 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-28 04:05:51.821170 | 
2026-08-28 04:05:51.821243 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-28 04:05:52.032864 | instance | changed: "values"
2026-08-28 04:05:52.198500 | instance | changed: "releases"
2026-08-28 04:05:52.219842 | 
2026-08-28 04:05:52.220132 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-28 04:05:52.446237 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-28 04:05:52.760557 | instance | ok: Runtime: 0:00:00.006377
2026-08-28 04:05:52.768354 | 
2026-08-28 04:05:52.768455 | TASK [helm-release-status : Downloads logs to executor]
2026-08-28 04:05:53.283937 | instance | changed:
2026-08-28 04:05:53.284145 | instance | cd+++++++++ helm/
2026-08-28 04:05:53.284174 | instance | cd+++++++++ helm/releases/
2026-08-28 04:05:53.284196 | instance | cd+++++++++ helm/values/
2026-08-28 04:05:53.296339 | 
2026-08-28 04:05:53.296421 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-28 04:05:53.519405 | instance | changed
2026-08-28 04:05:53.525600 | 
2026-08-28 04:05:53.525678 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-28 04:05:53.791620 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-28 04:05:53.791954 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-28 04:05:53.798278 | instance | environment: line 1: kubectl: command not found
2026-08-28 04:05:53.798850 | instance | environment: line 1: kubectl: command not found
2026-08-28 04:05:53.799460 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-28 04:05:53.799921 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-28 04:05:53.803078 | instance | environment: line 1: kubectl: command not found
2026-08-28 04:05:53.804044 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-28 04:05:53.805269 | instance | environment: line 1: kubectl: command not found
2026-08-28 04:05:53.807054 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-28 04:05:53.808833 | instance | environment: line 1: kubectl: command not found
2026-08-28 04:05:53.810250 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-28 04:05:54.063619 | instance | ok: Runtime: 0:00:00.026310
2026-08-28 04:05:54.070344 | 
2026-08-28 04:05:54.070434 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-28 04:05:54.289140 | instance | changed
2026-08-28 04:05:54.294233 | 
2026-08-28 04:05:54.294316 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-28 04:05:54.519805 | instance | environment: line 5: kubectl: command not found
2026-08-28 04:05:54.520990 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-28 04:05:54.521014 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-28 04:05:54.521104 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-28 04:05:54.835970 | instance | ok: Runtime: 0:00:00.007798
2026-08-28 04:05:54.844280 | 
2026-08-28 04:05:54.844350 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-28 04:05:55.358019 | instance | changed:
2026-08-28 04:05:55.358230 | instance | cd+++++++++ objects/
2026-08-28 04:05:55.358267 | instance | cd+++++++++ objects/cluster/
2026-08-28 04:05:55.358298 | instance | cd+++++++++ objects/namespaced/
2026-08-28 04:05:55.370063 | 
2026-08-28 04:05:55.370127 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-28 04:05:55.577192 | instance | changed
2026-08-28 04:05:55.583788 | 
2026-08-28 04:05:55.583873 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-28 04:05:55.801754 | instance | changed
2026-08-28 04:05:55.808600 | 
2026-08-28 04:05:55.808736 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-28 04:05:56.027416 | instance | environment: line 3: kubectl: command not found
2026-08-28 04:05:56.376546 | instance | ok: Runtime: 0:00:00.007607
2026-08-28 04:05:56.383730 | 
2026-08-28 04:05:56.383793 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-28 04:05:56.885410 | instance | changed:
2026-08-28 04:05:56.885600 | instance | cd+++++++++ pod-logs/
2026-08-28 04:05:56.885637 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-28 04:05:56.895406 | 
2026-08-28 04:05:56.895473 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-28 04:05:57.104563 | instance | changed
2026-08-28 04:05:57.109438 | 
2026-08-28 04:05:57.109505 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-28 04:05:57.330888 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-28 04:05:57.650509 | instance | ok: Runtime: 0:00:00.051574
2026-08-28 04:05:57.656898 | 
2026-08-28 04:05:57.656980 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-28 04:05:57.883917 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-28 04:05:57.931459 | instance | ceph-mgr endpoints:
2026-08-28 04:05:58.201284 | instance | ok: Runtime: 0:00:00.052663
2026-08-28 04:05:58.207458 | 
2026-08-28 04:05:58.207549 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-28 04:05:58.447791 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-28 04:05:58.743315 | instance | ok: Runtime: 0:00:00.049345
2026-08-28 04:05:58.748896 | 
2026-08-28 04:05:58.748981 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-28 04:05:59.265085 | instance | changed: cd+++++++++ prometheus/
2026-08-28 04:05:59.276151 | 
2026-08-28 04:05:59.276227 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-28 04:05:59.503703 | instance | changed
2026-08-28 04:05:59.508850 | 
2026-08-28 04:05:59.508918 | TASK [gather-selenium-data : Get selenium data]
2026-08-28 04:05:59.785771 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-28 04:05:59.787487 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-28 04:06:00.051736 | instance | ERROR
2026-08-28 04:06:00.051979 | instance | {
2026-08-28 04:06:00.052024 | instance |   "delta": "0:00:00.006957",
2026-08-28 04:06:00.052055 | instance |   "end": "2026-08-28 04:05:59.787873",
2026-08-28 04:06:00.052096 | instance |   "msg": "non-zero return code",
2026-08-28 04:06:00.052125 | instance |   "rc": 1,
2026-08-28 04:06:00.052152 | instance |   "start": "2026-08-28 04:05:59.780916"
2026-08-28 04:06:00.052178 | instance | }
2026-08-28 04:06:00.052214 | instance | ERROR: Ignoring Errors
2026-08-28 04:06:00.058562 | 
2026-08-28 04:06:00.058627 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-28 04:06:00.583895 | instance | changed: cd+++++++++ selenium/
2026-08-28 04:06:00.590236 | 
2026-08-28 04:06:00.590289 | PLAY RECAP
2026-08-28 04:06:00.590339 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-28 04:06:00.590362 | 
2026-08-28 04:06:00.725480 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-28 04:06:00.734312 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-28 04:06:01.342356 | 
2026-08-28 04:06:01.342502 | PLAY [all]
2026-08-28 04:06:01.354347 | 
2026-08-28 04:06:01.354430 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-28 04:06:01.399948 | instance | skipping: Conditional result was False
2026-08-28 04:06:01.410538 | 
2026-08-28 04:06:01.410619 | TASK [fetch-output : Set log path for single node]
2026-08-28 04:06:01.457397 | instance | ok
2026-08-28 04:06:01.466052 | 
2026-08-28 04:06:01.466126 | LOOP [fetch-output : Ensure local output dirs]
2026-08-28 04:06:01.848591 | instance -> localhost | ok: "/var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/logs"
2026-08-28 04:06:02.075015 | instance -> localhost | changed: "/var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/artifacts"
2026-08-28 04:06:02.290997 | instance -> localhost | changed: "/var/lib/zuul/builds/1182ef764eca467586c6f8f1a5b92e64/work/docs"
2026-08-28 04:06:02.306876 | 
2026-08-28 04:06:02.307079 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-28 04:06:02.948938 | instance | changed: .d..t...... ./
2026-08-28 04:06:02.949281 | instance | changed: All items complete
2026-08-28 04:06:02.949320 | 
2026-08-28 04:06:03.426482 | instance | changed: .d..t...... ./
2026-08-28 04:06:03.880188 | instance | changed: .d..t...... ./
2026-08-28 04:06:03.904687 | 
2026-08-28 04:06:03.904837 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-28 04:06:04.307977 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008073
2026-08-28 04:06:04.531325 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008130
2026-08-28 04:06:04.545997 | 
2026-08-28 04:06:04.546113 | PLAY [all]
2026-08-28 04:06:04.551938 | 
2026-08-28 04:06:04.552002 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-28 04:06:04.979933 | instance | changed
2026-08-28 04:06:04.987155 | 
2026-08-28 04:06:04.987207 | PLAY RECAP
2026-08-28 04:06:04.987254 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-28 04:06:04.987277 | 
2026-08-28 04:06:05.134630 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-28 04:06:05.139092 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-28 04:06:05.713400 | 
2026-08-28 04:06:05.713533 | PLAY [localhost]
2026-08-28 04:06:05.723191 | 
2026-08-28 04:06:05.723261 | TASK [Generate Zuul manifest]
2026-08-28 04:06:05.745067 | localhost | ok
2026-08-28 04:06:05.761209 | 
2026-08-28 04:06:05.761290 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-28 04:06:06.127552 | localhost | changed
2026-08-28 04:06:06.144075 | 
2026-08-28 04:06:06.144185 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-28 04:06:06.176791 | localhost | ok
2026-08-28 04:06:06.183437 | 
2026-08-28 04:06:06.183503 | TASK [Upload logs]
2026-08-28 04:06:06.207589 | localhost | ok
2026-08-28 04:06:06.264361 | 
2026-08-28 04:06:06.264496 | TASK [Set zuul-log-path fact]
2026-08-28 04:06:06.284872 | localhost | ok
2026-08-28 04:06:06.298849 | 
2026-08-28 04:06:06.298916 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-28 04:06:06.329601 | localhost | ok
2026-08-28 04:06:06.338613 | 
2026-08-28 04:06:06.338701 | TASK [upload-logs : Create log directories]
2026-08-28 04:06:06.836429 | localhost | changed
2026-08-28 04:06:06.843701 | 
2026-08-28 04:06:06.843772 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-28 04:06:07.290091 | localhost -> localhost | ok: Runtime: 0:00:00.005701
2026-08-28 04:06:07.296125 | 
2026-08-28 04:06:07.296194 | TASK [upload-logs : Upload logs to log server]
2026-08-28 04:06:07.794614 | localhost | Output suppressed because no_log was given
2026-08-28 04:06:07.839870 | 
2026-08-28 04:06:07.840035 | LOOP [upload-logs : Compress console log and json output]
2026-08-28 04:06:07.885441 | localhost | skipping: Conditional result was False
2026-08-28 04:06:07.892275 | localhost | skipping: Conditional result was False
2026-08-28 04:06:07.905365 | 
2026-08-28 04:06:07.905506 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-28 04:06:07.949489 | localhost | skipping: Conditional result was False
2026-08-28 04:06:07.949978 | 
2026-08-28 04:06:07.954157 | localhost | skipping: Conditional result was False
2026-08-28 04:06:07.970195 | 
2026-08-28 04:06:07.970351 | LOOP [upload-logs : Upload console log and json output]