2026-09-08 15:33:21.487712 | Job console starting
2026-09-08 15:33:21.501674 | Updating git repos
2026-09-08 15:33:24.221569 | Cloning repos into workspace
2026-09-08 15:33:41.495176 | Restoring repo states
2026-09-08 15:33:45.624979 | Merging changes
2026-09-08 15:33:46.421393 | Checking out repos
2026-09-08 15:33:48.366927 | Preparing playbooks
2026-09-08 15:33:50.654428 | Running Ansible setup
2026-09-08 15:33:54.096571 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-08 15:33:54.666147 | 
2026-09-08 15:33:54.666261 | PLAY [localhost]
2026-09-08 15:33:54.673702 | 
2026-09-08 15:33:54.673782 | TASK [Gathering Facts]
2026-09-08 15:33:56.673430 | localhost | ok
2026-09-08 15:33:56.688144 | 
2026-09-08 15:33:56.688378 | TASK [Setup log path fact]
2026-09-08 15:33:56.710836 | localhost | ok
2026-09-08 15:33:56.733108 | 
2026-09-08 15:33:56.859595 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-08 15:33:56.903187 | localhost | ok
2026-09-08 15:33:56.915401 | 
2026-09-08 15:33:56.915695 | TASK [emit-job-header : Print job information]
2026-09-08 15:33:56.966322 | # Job Information
2026-09-08 15:33:56.966539 | Ansible Version: 2.16.18
2026-09-08 15:33:56.966582 | Job: atmosphere-molecule-csi-rbd
2026-09-08 15:33:56.966611 | Pipeline: check
2026-09-08 15:33:56.966637 | Executor: 2d72f0692154
2026-09-08 15:33:56.966662 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501
2026-09-08 15:33:56.966693 | Event ID: 1b453630-ab9a-11f1-9550-4471599db123
2026-09-08 15:33:56.970509 | 
2026-09-08 15:33:56.970601 | LOOP [emit-job-header : Print node information]
2026-09-08 15:33:57.081115 | localhost | ok:
2026-09-08 15:33:57.081419 | localhost | # Node Information
2026-09-08 15:33:57.081481 | localhost | Inventory Hostname: instance
2026-09-08 15:33:57.081526 | localhost | Hostname: np0000192213
2026-09-08 15:33:57.081566 | localhost | Username: zuul
2026-09-08 15:33:57.081658 | localhost | Distro: Ubuntu 22.04
2026-09-08 15:33:57.081742 | localhost | Provider: yul1
2026-09-08 15:33:57.081802 | localhost | Region: ca-ymq-1
2026-09-08 15:33:57.081888 | localhost | Label: ubuntu-jammy
2026-09-08 15:33:57.081948 | localhost | Product Name: OpenStack Nova
2026-09-08 15:33:57.081992 | localhost | Interface IP: 162.253.55.160
2026-09-08 15:33:57.102421 | 
2026-09-08 15:33:57.102661 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-08 15:33:57.520556 | localhost -> localhost | changed
2026-09-08 15:33:57.545524 | 
2026-09-08 15:33:57.546185 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-08 15:33:58.423546 | localhost -> localhost | changed
2026-09-08 15:33:58.434913 | 
2026-09-08 15:33:58.435045 | PLAY [all]
2026-09-08 15:33:58.450479 | 
2026-09-08 15:33:58.450640 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-08 15:33:58.700976 | instance -> localhost | ok
2026-09-08 15:33:58.708865 | 
2026-09-08 15:33:58.709008 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-08 15:33:58.739146 | instance | ok
2026-09-08 15:33:58.757613 | instance | included: /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-08 15:33:58.765699 | 
2026-09-08 15:33:58.765841 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-08 15:33:59.922352 | instance -> localhost | Generating public/private rsa key pair.
2026-09-08 15:33:59.922595 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/7bdc456e957d463791a55b065a7e44b2_id_rsa
2026-09-08 15:33:59.922657 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/7bdc456e957d463791a55b065a7e44b2_id_rsa.pub
2026-09-08 15:33:59.922703 | instance -> localhost | The key fingerprint is:
2026-09-08 15:33:59.922745 | instance -> localhost | SHA256:PVqKllV0dk4943M1ntQxQRjt6gQBV06VIajjDl6m4vY zuul-build-sshkey
2026-09-08 15:33:59.922805 | instance -> localhost | The key's randomart image is:
2026-09-08 15:33:59.922848 | instance -> localhost | +---[RSA 3072]----+
2026-09-08 15:33:59.922892 | instance -> localhost | |         .o.==OO*|
2026-09-08 15:33:59.922935 | instance -> localhost | |         ..=o=.B=|
2026-09-08 15:33:59.922975 | instance -> localhost | |          o ..* *|
2026-09-08 15:33:59.923014 | instance -> localhost | |         = .   *.|
2026-09-08 15:33:59.923053 | instance -> localhost | |        S = . . o|
2026-09-08 15:33:59.923091 | instance -> localhost | |       = B . o   |
2026-09-08 15:33:59.923130 | instance -> localhost | |      = O   o    |
2026-09-08 15:33:59.923169 | instance -> localhost | |     + o .   .   |
2026-09-08 15:33:59.923213 | instance -> localhost | |    o.oE         |
2026-09-08 15:33:59.923252 | instance -> localhost | +----[SHA256]-----+
2026-09-08 15:33:59.923365 | instance -> localhost | ok: Runtime: 0:00:00.735852
2026-09-08 15:33:59.935238 | 
2026-09-08 15:33:59.935383 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-08 15:33:59.960321 | instance | ok
2026-09-08 15:33:59.976635 | instance | included: /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-08 15:33:59.987163 | 
2026-09-08 15:33:59.987241 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-08 15:34:00.010623 | instance | skipping: Conditional result was False
2026-09-08 15:34:00.022852 | 
2026-09-08 15:34:00.023006 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-08 15:34:00.468756 | instance | changed
2026-09-08 15:34:00.487407 | 
2026-09-08 15:34:00.487602 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-08 15:34:00.730793 | instance | ok
2026-09-08 15:34:00.737745 | 
2026-09-08 15:34:00.737875 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-08 15:34:01.230516 | instance | changed
2026-09-08 15:34:01.237257 | 
2026-09-08 15:34:01.237399 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-08 15:34:01.691214 | instance | changed
2026-09-08 15:34:01.699088 | 
2026-09-08 15:34:01.699183 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-08 15:34:01.723103 | instance | skipping: Conditional result was False
2026-09-08 15:34:01.731137 | 
2026-09-08 15:34:01.731218 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-08 15:34:02.089850 | instance -> localhost | changed
2026-09-08 15:34:02.098263 | 
2026-09-08 15:34:02.098359 | TASK [add-build-sshkey : Add back temp key]
2026-09-08 15:34:02.381117 | instance -> localhost | Identity added: /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/7bdc456e957d463791a55b065a7e44b2_id_rsa (zuul-build-sshkey)
2026-09-08 15:34:02.381339 | instance -> localhost | ok: Runtime: 0:00:00.013857
2026-09-08 15:34:02.387458 | 
2026-09-08 15:34:02.387529 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-08 15:34:02.695803 | instance | ok
2026-09-08 15:34:02.704659 | 
2026-09-08 15:34:02.704893 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-08 15:34:02.729269 | instance | skipping: Conditional result was False
2026-09-08 15:34:02.746839 | 
2026-09-08 15:34:02.746969 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-08 15:34:03.086072 | instance | ok
2026-09-08 15:34:03.097435 | 
2026-09-08 15:34:03.097578 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-08 15:34:06.521676 | instance | Output suppressed because no_log was given
2026-09-08 15:34:06.535311 | 
2026-09-08 15:34:06.535407 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-08 15:34:06.723063 | instance | ok: "logs"
2026-09-08 15:34:06.723410 | instance | ok: All items complete
2026-09-08 15:34:06.723473 | 
2026-09-08 15:34:06.870473 | instance | ok: "artifacts"
2026-09-08 15:34:07.014804 | instance | ok: "docs"
2026-09-08 15:34:07.035623 | 
2026-09-08 15:34:07.035769 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-08 15:34:07.221808 | instance | changed: "logs"
2026-09-08 15:34:07.364092 | instance | changed: "artifacts"
2026-09-08 15:34:07.510759 | instance | changed: "docs"
2026-09-08 15:34:07.530652 | 
2026-09-08 15:34:07.530753 | PLAY RECAP
2026-09-08 15:34:07.530847 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-08 15:34:07.530926 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:34:07.530974 | 
2026-09-08 15:34:07.650993 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-08 15:34:07.655596 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-08 15:34:08.326940 | 
2026-09-08 15:34:08.327067 | PLAY [all]
2026-09-08 15:34:08.337086 | 
2026-09-08 15:34:08.337168 | TASK [setup-uv : Extract archive]
2026-09-08 15:34:10.566303 | instance | changed
2026-09-08 15:34:10.574121 | 
2026-09-08 15:34:10.574263 | TASK [setup-uv : Print version]
2026-09-08 15:34:10.949654 | instance | uv 0.8.13
2026-09-08 15:34:11.116608 | instance | ok: Runtime: 0:00:00.013168
2026-09-08 15:34:11.133972 | 
2026-09-08 15:34:11.134105 | TASK [Install Ansible collection siblings]
2026-09-08 15:34:20.962365 | instance | changed:
2026-09-08 15:34:20.963106 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-08 15:34:20.963173 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-08 15:34:20.963217 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-08 15:34:20.963255 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-08 15:34:20.963293 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-08 15:34:20.963361 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-08 15:34:20.963402 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-08 15:34:20.963443 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-08 15:34:20.963480 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-08 15:34:20.963516 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-08 15:34:20.963551 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-08 15:34:20.963586 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-08 15:34:20.963620 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-08 15:34:20.963654 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-08 15:34:20.963689 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-08 15:34:20.963724 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-08 15:34:20.963758 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-08 15:34:20.963792 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-08 15:34:20.963825 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-08 15:34:20.963858 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-08 15:34:20.963891 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-08 15:34:20.963924 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-08 15:34:20.963962 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-08 15:34:20.964012 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-08 15:34:20.964048 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-08 15:34:20.964082 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-08 15:34:20.964116 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-08 15:34:20.964149 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-08 15:34:20.964182 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-08 15:34:20.964215 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-08 15:34:20.964248 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-08 15:34:20.964283 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-08 15:34:20.964340 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-08 15:34:20.964375 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-08 15:34:20.964420 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.964455 | instance | Process install dependency map
2026-09-08 15:34:20.964489 | instance | Starting collection install process
2026-09-08 15:34:20.964561 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-08 15:34:20.964596 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-08 15:34:20.964629 | instance | ansible.netcommon:* was installed successfully
2026-09-08 15:34:20.964662 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-08 15:34:20.964695 | instance | Creating virtual environment at: .venv
2026-09-08 15:34:20.964728 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-08 15:34:20.964760 | instance | Downloading ansible-core (2.1MiB)
2026-09-08 15:34:20.964794 | instance | Downloading pygments (1.2MiB)
2026-09-08 15:34:20.964834 | instance | Downloading openstacksdk (1.7MiB)
2026-09-08 15:34:20.964868 | instance | Downloading pydantic-core (2.0MiB)
2026-09-08 15:34:20.964901 | instance | Downloading rjsonnet (1.2MiB)
2026-09-08 15:34:20.964934 | instance | Downloading kubernetes (1.9MiB)
2026-09-08 15:34:20.964968 | instance | Downloading setuptools (1.1MiB)
2026-09-08 15:34:20.965002 | instance | Downloading cryptography (4.2MiB)
2026-09-08 15:34:20.965035 | instance | Downloading netaddr (2.2MiB)
2026-09-08 15:34:20.965069 | instance |    Building pyperclip==1.9.0
2026-09-08 15:34:20.965107 | instance |  Downloading rjsonnet
2026-09-08 15:34:20.965142 | instance |  Downloading pydantic-core
2026-09-08 15:34:20.965176 | instance |  Downloading netaddr
2026-09-08 15:34:20.965211 | instance |  Downloading pygments
2026-09-08 15:34:20.965245 | instance |  Downloading cryptography
2026-09-08 15:34:20.965278 | instance |  Downloading setuptools
2026-09-08 15:34:20.965335 | instance |  Downloading kubernetes
2026-09-08 15:34:20.965371 | instance |  Downloading ansible-core
2026-09-08 15:34:20.965406 | instance |  Downloading openstacksdk
2026-09-08 15:34:20.965441 | instance |       Built pyperclip==1.9.0
2026-09-08 15:34:20.965475 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-08 15:34:20.965510 | instance | Installed 83 packages in 117ms
2026-09-08 15:34:20.965544 | instance | Checked out ansible.posix to 1.6.0
2026-09-08 15:34:20.965577 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-08 15:34:20.965612 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.965646 | instance | Process install dependency map
2026-09-08 15:34:20.965691 | instance | Starting collection install process
2026-09-08 15:34:20.965726 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-08 15:34:20.965760 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-08 15:34:20.965794 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-08 15:34:20.965828 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.965861 | instance | 2.17.12
2026-09-08 15:34:20.965895 | instance | Checked out ansible.utils to v6.1.0
2026-09-08 15:34:20.965929 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-08 15:34:20.965962 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.966017 | instance | Process install dependency map
2026-09-08 15:34:20.966094 | instance | Starting collection install process
2026-09-08 15:34:20.966154 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-08 15:34:20.966195 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-08 15:34:20.966231 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-08 15:34:20.966266 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.966323 | instance | 2.17.12
2026-09-08 15:34:20.966362 | instance | Checked out atmosphere.common to v0.7.0
2026-09-08 15:34:20.966395 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-08 15:34:20.966429 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.966463 | instance | Process install dependency map
2026-09-08 15:34:20.966495 | instance | Starting collection install process
2026-09-08 15:34:20.966528 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-08 15:34:20.966562 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-08 15:34:20.966595 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-08 15:34:20.966628 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.966666 | instance | 2.17.12
2026-09-08 15:34:20.966700 | instance | Checked out community.crypto to 2.2.3
2026-09-08 15:34:20.966733 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-08 15:34:20.966767 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.966800 | instance | Process install dependency map
2026-09-08 15:34:20.966833 | instance | Starting collection install process
2026-09-08 15:34:20.966865 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-08 15:34:20.966898 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-08 15:34:20.966931 | instance | community.crypto:2.2.3 was installed successfully
2026-09-08 15:34:20.966964 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.966998 | instance | 2.17.12
2026-09-08 15:34:20.967031 | instance | Checked out community.general to 7.3.0
2026-09-08 15:34:20.967064 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-08 15:34:20.967112 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.967147 | instance | Process install dependency map
2026-09-08 15:34:20.967180 | instance | Starting collection install process
2026-09-08 15:34:20.967213 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-08 15:34:20.967245 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-08 15:34:20.967278 | instance | community.general:7.3.0 was installed successfully
2026-09-08 15:34:20.967329 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.967364 | instance | 2.17.12
2026-09-08 15:34:20.967397 | instance | Checked out community.mysql to 3.6.0
2026-09-08 15:34:20.967435 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-08 15:34:20.967471 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.967505 | instance | Process install dependency map
2026-09-08 15:34:20.967539 | instance | Starting collection install process
2026-09-08 15:34:20.967572 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-08 15:34:20.967605 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-08 15:34:20.967639 | instance | community.mysql:3.6.0 was installed successfully
2026-09-08 15:34:20.967673 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.967705 | instance | 2.17.12
2026-09-08 15:34:20.967738 | instance | Checked out kubernetes.core to 2.4.0
2026-09-08 15:34:20.967772 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-08 15:34:20.967805 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.967837 | instance | Process install dependency map
2026-09-08 15:34:20.967869 | instance | Starting collection install process
2026-09-08 15:34:20.967902 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-08 15:34:20.967935 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-08 15:34:20.967967 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-08 15:34:20.967999 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.968033 | instance | 2.17.12
2026-09-08 15:34:20.968066 | instance | Checked out openstack.cloud to 2.6.0
2026-09-08 15:34:20.968100 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-08 15:34:20.968134 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.968166 | instance | Process install dependency map
2026-09-08 15:34:20.968200 | instance | Starting collection install process
2026-09-08 15:34:20.968233 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-08 15:34:20.968267 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-08 15:34:20.968299 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-08 15:34:20.968352 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.968386 | instance | 2.17.12
2026-09-08 15:34:20.968427 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-08 15:34:20.968462 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-08 15:34:20.968519 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.968559 | instance | Process install dependency map
2026-09-08 15:34:20.968593 | instance | Starting collection install process
2026-09-08 15:34:20.968641 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-08 15:34:20.968694 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-08 15:34:20.968732 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-08 15:34:20.968766 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.968799 | instance | 2.17.12
2026-09-08 15:34:20.968833 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-08 15:34:20.968866 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-08 15:34:20.968900 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.968933 | instance | Process install dependency map
2026-09-08 15:34:20.968967 | instance | Starting collection install process
2026-09-08 15:34:20.969000 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-08 15:34:20.969032 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-08 15:34:20.969066 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-08 15:34:20.969102 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.969136 | instance | 2.17.12
2026-09-08 15:34:20.969169 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-08 15:34:20.969202 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-08 15:34:20.969235 | instance | Starting galaxy collection install process
2026-09-08 15:34:20.969268 | instance | Process install dependency map
2026-09-08 15:34:20.969321 | instance | Starting collection install process
2026-09-08 15:34:20.969358 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-08 15:34:20.969391 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-08 15:34:20.969424 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-08 15:34:20.969457 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-08 15:34:20.969489 | instance | 2.17.12
2026-09-08 15:34:20.979329 | 
2026-09-08 15:34:20.979422 | PLAY RECAP
2026-09-08 15:34:20.979497 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:34:20.979538 | 
2026-09-08 15:34:21.089768 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-08 15:34:21.094269 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-08 15:34:21.693853 | 
2026-09-08 15:34:21.693981 | PLAY [all]
2026-09-08 15:34:21.704658 | 
2026-09-08 15:34:21.704739 | TASK [Install "jq" for log collection]
2026-09-08 15:34:31.152574 | instance | changed
2026-09-08 15:34:31.155589 | 
2026-09-08 15:34:31.155700 | PLAY RECAP
2026-09-08 15:34:31.155795 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:34:31.155913 | 
2026-09-08 15:34:31.274857 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-08 15:34:31.278840 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-08 15:34:31.826276 | 
2026-09-08 15:34:31.826399 | PLAY [all]
2026-09-08 15:34:31.836825 | 
2026-09-08 15:34:31.836914 | LOOP [Check inventory directories]
2026-09-08 15:34:32.201423 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-08 15:34:32.380014 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-08 15:34:32.554502 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-08 15:34:32.571999 | 
2026-09-08 15:34:32.572298 | LOOP [Copy inventory file for Zuul]
2026-09-08 15:34:33.437730 | instance | changed:
2026-09-08 15:34:33.438052 | instance | {
2026-09-08 15:34:33.438112 | instance |   "ansible_loop_var": "item",
2026-09-08 15:34:33.438169 | instance |   "changed": false,
2026-09-08 15:34:33.438225 | instance |   "failed": false,
2026-09-08 15:34:33.438285 | instance |   "invocation": {
2026-09-08 15:34:33.438349 | instance |     "module_args": {
2026-09-08 15:34:33.438386 | instance |       "checksum_algorithm": "sha1",
2026-09-08 15:34:33.438421 | instance |       "follow": true,
2026-09-08 15:34:33.438455 | instance |       "get_attributes": true,
2026-09-08 15:34:33.438503 | instance |       "get_checksum": true,
2026-09-08 15:34:33.438554 | instance |       "get_mime": true,
2026-09-08 15:34:33.438604 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-08 15:34:33.438653 | instance |     }
2026-09-08 15:34:33.438702 | instance |   },
2026-09-08 15:34:33.438749 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-08 15:34:33.438798 | instance |   "stat": {
2026-09-08 15:34:33.438847 | instance |     "atime": 1788881653.3376992,
2026-09-08 15:34:33.438899 | instance |     "attr_flags": "e",
2026-09-08 15:34:33.438952 | instance |     "attributes": [
2026-09-08 15:34:33.439071 | instance |       "extents"
2026-09-08 15:34:33.439176 | instance |     ],
2026-09-08 15:34:33.439227 | instance |     "block_size": 4096,
2026-09-08 15:34:33.439262 | instance |     "blocks": 8,
2026-09-08 15:34:33.439295 | instance |     "charset": "unknown",
2026-09-08 15:34:33.439358 | instance |     "ctime": 1788881651.9776835,
2026-09-08 15:34:33.439395 | instance |     "dev": 64513,
2026-09-08 15:34:33.439429 | instance |     "device_type": 0,
2026-09-08 15:34:33.439461 | instance |     "executable": true,
2026-09-08 15:34:33.439493 | instance |     "exists": true,
2026-09-08 15:34:33.439524 | instance |     "gid": 1000,
2026-09-08 15:34:33.439555 | instance |     "gr_name": "zuul",
2026-09-08 15:34:33.439587 | instance |     "inode": 1049569,
2026-09-08 15:34:33.439619 | instance |     "isblk": false,
2026-09-08 15:34:33.439652 | instance |     "ischr": false,
2026-09-08 15:34:33.439684 | instance |     "isdir": true,
2026-09-08 15:34:33.439716 | instance |     "isfifo": false,
2026-09-08 15:34:33.439747 | instance |     "isgid": false,
2026-09-08 15:34:33.439778 | instance |     "islnk": false,
2026-09-08 15:34:33.439809 | instance |     "isreg": false,
2026-09-08 15:34:33.439840 | instance |     "issock": false,
2026-09-08 15:34:33.439870 | instance |     "isuid": false,
2026-09-08 15:34:33.439901 | instance |     "mimetype": "unknown",
2026-09-08 15:34:33.439931 | instance |     "mode": "0755",
2026-09-08 15:34:33.439962 | instance |     "mtime": 1788881651.9776835,
2026-09-08 15:34:33.439993 | instance |     "nlink": 23,
2026-09-08 15:34:33.440024 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-08 15:34:33.440057 | instance |     "pw_name": "zuul",
2026-09-08 15:34:33.440090 | instance |     "readable": true,
2026-09-08 15:34:33.440122 | instance |     "rgrp": true,
2026-09-08 15:34:33.440154 | instance |     "roth": true,
2026-09-08 15:34:33.440212 | instance |     "rusr": true,
2026-09-08 15:34:33.440266 | instance |     "size": 4096,
2026-09-08 15:34:33.440337 | instance |     "uid": 1000,
2026-09-08 15:34:33.440392 | instance |     "version": "1720257422",
2026-09-08 15:34:33.440444 | instance |     "wgrp": false,
2026-09-08 15:34:33.440529 | instance |     "woth": false,
2026-09-08 15:34:33.440588 | instance |     "writeable": true,
2026-09-08 15:34:33.440640 | instance |     "wusr": true,
2026-09-08 15:34:33.440690 | instance |     "xgrp": true,
2026-09-08 15:34:33.440739 | instance |     "xoth": true,
2026-09-08 15:34:33.440788 | instance |     "xusr": true
2026-09-08 15:34:33.440839 | instance |   }
2026-09-08 15:34:33.440883 | instance | }
2026-09-08 15:34:33.440956 | instance | ok: All items complete
2026-09-08 15:34:33.440998 | 
2026-09-08 15:34:33.444609 | instance | skipping: Conditional result was False
2026-09-08 15:34:33.445876 | instance | skipping: Conditional result was False
2026-09-08 15:34:33.459587 | 
2026-09-08 15:34:33.459787 | LOOP [Switch "ansible_host" to private IP]
2026-09-08 15:34:33.882879 | instance | changed: 1 replacements made
2026-09-08 15:34:33.886077 | instance | skipping: Conditional result was False
2026-09-08 15:34:33.895387 | instance | skipping: Conditional result was False
2026-09-08 15:34:33.909096 | 
2026-09-08 15:34:33.909707 | TASK [Run Molecule scenario]
2026-09-08 15:34:34.849921 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-08 15:34:35.272687 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-08 15:34:35.272791 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-08 15:34:46.318923 | instance | INFO     [csi > dependency] Executing
2026-09-08 15:34:46.319145 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-08 15:34:46.319357 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-08 15:34:46.319521 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-08 15:34:46.327909 | instance | INFO     [csi > cleanup] Executing
2026-09-08 15:34:46.328318 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-08 15:34:46.336048 | instance | INFO     [csi > destroy] Executing
2026-09-08 15:34:46.336137 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-08 15:34:46.336224 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-08 15:34:46.343302 | instance | INFO     [csi > syntax] Executing
2026-09-08 15:34:47.940635 | instance |
2026-09-08 15:34:47.940978 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:34:48.001484 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-08 15:34:48.019166 | instance | INFO     [csi > create] Executing
2026-09-08 15:34:48.023096 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-08 15:34:48.042360 | instance | INFO     [csi > prepare] Executing
2026-09-08 15:34:48.804997 | instance |
2026-09-08 15:34:48.805321 | instance | PLAY [Prepare] *****************************************************************
2026-09-08 15:34:48.805608 | instance |
2026-09-08 15:34:48.805902 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:34:48.806208 | instance | Tuesday 08 September 2026  15:34:48 +0000 (0:00:00.024)       0:00:00.024 *****
2026-09-08 15:34:50.085649 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-08 15:34:50.085876 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-08 15:34:50.086149 | instance | interpreter could change the meaning of that path. See
2026-09-08 15:34:50.086399 | instance | https://docs.ansible.com/ansible-
2026-09-08 15:34:50.086708 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-08 15:34:50.097961 | instance | ok: [instance]
2026-09-08 15:34:50.098209 | instance |
2026-09-08 15:34:50.098456 | instance | TASK [Configure short hostname] ************************************************
2026-09-08 15:34:50.098737 | instance | Tuesday 08 September 2026  15:34:50 +0000 (0:00:01.293)       0:00:01.317 *****
2026-09-08 15:34:50.935231 | instance | changed: [instance]
2026-09-08 15:34:50.935395 | instance |
2026-09-08 15:34:50.935705 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-08 15:34:50.936019 | instance | Tuesday 08 September 2026  15:34:50 +0000 (0:00:00.836)       0:00:02.154 *****
2026-09-08 15:34:51.225787 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-08 15:34:51.226007 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-08 15:34:51.226265 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-08 15:34:51.235667 | instance | changed: [instance]
2026-09-08 15:34:51.235956 | instance |
2026-09-08 15:34:51.236301 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-08 15:34:51.236644 | instance | Tuesday 08 September 2026  15:34:51 +0000 (0:00:00.301)       0:00:02.455 *****
2026-09-08 15:34:52.091733 | instance | ok: [instance]
2026-09-08 15:34:52.092056 | instance |
2026-09-08 15:34:52.092357 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-08 15:34:52.092632 | instance |
2026-09-08 15:34:52.092916 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:34:52.093234 | instance | Tuesday 08 September 2026  15:34:52 +0000 (0:00:00.855)       0:00:03.310 *****
2026-09-08 15:34:52.853567 | instance | ok: [instance]
2026-09-08 15:34:52.853778 | instance |
2026-09-08 15:34:52.854051 | instance | TASK [Install depedencies] *****************************************************
2026-09-08 15:34:52.854302 | instance | Tuesday 08 September 2026  15:34:52 +0000 (0:00:00.761)       0:00:04.072 *****
2026-09-08 15:35:15.470789 | instance | changed: [instance]
2026-09-08 15:35:15.470941 | instance |
2026-09-08 15:35:15.470950 | instance | TASK [Start up service] ********************************************************
2026-09-08 15:35:15.470958 | instance | Tuesday 08 September 2026  15:35:15 +0000 (0:00:22.617)       0:00:26.690 *****
2026-09-08 15:35:16.040838 | instance | ok: [instance]
2026-09-08 15:35:16.041537 | instance |
2026-09-08 15:35:16.041586 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-08 15:35:16.041598 | instance | Tuesday 08 September 2026  15:35:16 +0000 (0:00:00.569)       0:00:27.260 *****
2026-09-08 15:35:16.353145 | instance | ok: [instance]
2026-09-08 15:35:16.354051 | instance |
2026-09-08 15:35:16.354114 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-08 15:35:16.354127 | instance | Tuesday 08 September 2026  15:35:16 +0000 (0:00:00.311)       0:00:27.572 *****
2026-09-08 15:35:17.070571 | instance | changed: [instance]
2026-09-08 15:35:17.070678 | instance |
2026-09-08 15:35:17.071033 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-08 15:35:17.071092 | instance | Tuesday 08 September 2026  15:35:17 +0000 (0:00:00.718)       0:00:28.290 *****
2026-09-08 15:35:17.314831 | instance | ok: [instance]
2026-09-08 15:35:17.315659 | instance |
2026-09-08 15:35:17.315751 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-08 15:35:17.315765 | instance | Tuesday 08 September 2026  15:35:17 +0000 (0:00:00.243)       0:00:28.533 *****
2026-09-08 15:35:17.343999 | instance | skipping: [instance]
2026-09-08 15:35:17.344113 | instance |
2026-09-08 15:35:17.344676 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-08 15:35:17.344759 | instance | Tuesday 08 September 2026  15:35:17 +0000 (0:00:00.029)       0:00:28.563 *****
2026-09-08 15:35:17.964046 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:35:17.964953 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:35:17.965022 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:35:17.965031 | instance |
2026-09-08 15:35:17.965039 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-08 15:35:17.965046 | instance | Tuesday 08 September 2026  15:35:17 +0000 (0:00:00.620)       0:00:29.183 *****
2026-09-08 15:35:18.611438 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:35:18.611584 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:35:18.611756 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:35:18.611900 | instance |
2026-09-08 15:35:18.612053 | instance | TASK [Start loop devices] ******************************************************
2026-09-08 15:35:18.612204 | instance | Tuesday 08 September 2026  15:35:18 +0000 (0:00:00.648)       0:00:29.831 *****
2026-09-08 15:35:19.413414 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:35:19.413676 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:35:19.413999 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:35:19.414184 | instance |
2026-09-08 15:35:19.414349 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-08 15:35:19.414510 | instance | Tuesday 08 September 2026  15:35:19 +0000 (0:00:00.801)       0:00:30.632 *****
2026-09-08 15:35:22.730450 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:35:22.730525 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:35:22.730658 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:35:22.730765 | instance |
2026-09-08 15:35:22.730874 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-08 15:35:22.730984 | instance | Tuesday 08 September 2026  15:35:22 +0000 (0:00:03.316)       0:00:33.949 *****
2026-09-08 15:35:24.805719 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-08 15:35:24.805776 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-08 15:35:24.805803 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-08 15:35:24.805817 | instance |
2026-09-08 15:35:24.807615 | instance | PLAY RECAP *********************************************************************
2026-09-08 15:35:24.807646 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-08 15:35:24.807656 | instance |
2026-09-08 15:35:24.807664 | instance | Tuesday 08 September 2026  15:35:24 +0000 (0:00:02.075)       0:00:36.025 *****
2026-09-08 15:35:24.807818 | instance | ===============================================================================
2026-09-08 15:35:24.808290 | instance | Install depedencies ---------------------------------------------------- 22.62s
2026-09-08 15:35:24.808748 | instance | Create a volume group for each loop device ------------------------------ 3.32s
2026-09-08 15:35:24.809178 | instance | Create a logical volume for each loop device ---------------------------- 2.08s
2026-09-08 15:35:24.809624 | instance | Gathering Facts --------------------------------------------------------- 1.29s
2026-09-08 15:35:24.810055 | instance | Purge "snapd" package --------------------------------------------------- 0.86s
2026-09-08 15:35:24.810482 | instance | Configure short hostname ------------------------------------------------ 0.84s
2026-09-08 15:35:24.810929 | instance | Start loop devices ------------------------------------------------------ 0.80s
2026-09-08 15:35:24.811355 | instance | Gathering Facts --------------------------------------------------------- 0.76s
2026-09-08 15:35:24.811888 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.72s
2026-09-08 15:35:24.812315 | instance | Set permissions on loopback devices ------------------------------------- 0.65s
2026-09-08 15:35:24.812763 | instance | Create devices for Ceph ------------------------------------------------- 0.62s
2026-09-08 15:35:24.813181 | instance | Start up service -------------------------------------------------------- 0.57s
2026-09-08 15:35:24.813627 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-09-08 15:35:24.814052 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-08 15:35:24.814473 | instance | Get list of all loopback devices ---------------------------------------- 0.24s
2026-09-08 15:35:24.814929 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-08 15:35:24.881502 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-08 15:35:24.888232 | instance | INFO     [csi > converge] Executing
2026-09-08 15:35:26.271103 | instance |
2026-09-08 15:35:26.271321 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-08 15:35:26.271514 | instance |
2026-09-08 15:35:26.271719 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:35:26.271898 | instance | Tuesday 08 September 2026  15:35:26 +0000 (0:00:00.008)       0:00:00.008 *****
2026-09-08 15:35:27.351110 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-08 15:35:27.351566 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-08 15:35:27.351927 | instance | interpreter could change the meaning of that path. See
2026-09-08 15:35:27.352228 | instance | https://docs.ansible.com/ansible-
2026-09-08 15:35:27.352521 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-08 15:35:27.365318 | instance | ok: [instance]
2026-09-08 15:35:27.365646 | instance |
2026-09-08 15:35:27.365943 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-08 15:35:27.366270 | instance | Tuesday 08 September 2026  15:35:27 +0000 (0:00:01.093)       0:00:01.102 *****
2026-09-08 15:35:27.408672 | instance | ok: [instance] => {
2026-09-08 15:35:27.409049 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-08 15:35:27.409420 | instance | }
2026-09-08 15:35:27.409775 | instance |
2026-09-08 15:35:27.410195 | instance | PLAY [all] *********************************************************************
2026-09-08 15:35:27.410509 | instance |
2026-09-08 15:35:27.410840 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:35:27.411246 | instance | Tuesday 08 September 2026  15:35:27 +0000 (0:00:00.043)       0:00:01.145 *****
2026-09-08 15:35:28.342243 | instance | ok: [instance]
2026-09-08 15:35:28.342687 | instance |
2026-09-08 15:35:28.343043 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-09-08 15:35:28.343365 | instance | Tuesday 08 September 2026  15:35:28 +0000 (0:00:00.932)       0:00:02.078 *****
2026-09-08 15:35:28.395276 | instance | skipping: [instance]
2026-09-08 15:35:28.395685 | instance |
2026-09-08 15:35:28.396000 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-08 15:35:28.396303 | instance | Tuesday 08 September 2026  15:35:28 +0000 (0:00:00.053)       0:00:02.131 *****
2026-09-08 15:35:28.641993 | instance | ok: [instance]
2026-09-08 15:35:28.642036 | instance |
2026-09-08 15:35:28.642049 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-08 15:35:28.642412 | instance |
2026-09-08 15:35:28.642886 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:35:28.643310 | instance | Tuesday 08 September 2026  15:35:28 +0000 (0:00:00.245)       0:00:02.377 *****
2026-09-08 15:35:29.620815 | instance | ok: [instance]
2026-09-08 15:35:29.620875 | instance |
2026-09-08 15:35:29.620888 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:35:29.620898 | instance | Tuesday 08 September 2026  15:35:29 +0000 (0:00:00.978)       0:00:03.356 *****
2026-09-08 15:35:29.983640 | instance | ok: [instance]
2026-09-08 15:35:29.983716 | instance |
2026-09-08 15:35:29.983734 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:35:29.983995 | instance | Tuesday 08 September 2026  15:35:29 +0000 (0:00:00.363)       0:00:03.719 *****
2026-09-08 15:35:30.039565 | instance | skipping: [instance]
2026-09-08 15:35:30.040571 | instance |
2026-09-08 15:35:30.040641 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-08 15:35:30.040657 | instance | Tuesday 08 September 2026  15:35:30 +0000 (0:00:00.056)       0:00:03.775 *****
2026-09-08 15:35:30.405217 | instance | changed: [instance]
2026-09-08 15:35:30.405355 | instance |
2026-09-08 15:35:30.405373 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:35:30.405562 | instance | Tuesday 08 September 2026  15:35:30 +0000 (0:00:00.366)       0:00:04.141 *****
2026-09-08 15:35:30.503906 | instance | ok: [instance] => {
2026-09-08 15:35:30.504312 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-08 15:35:30.504650 | instance | }
2026-09-08 15:35:30.504940 | instance |
2026-09-08 15:35:30.505258 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:35:30.505589 | instance | Tuesday 08 September 2026  15:35:30 +0000 (0:00:00.097)       0:00:04.239 *****
2026-09-08 15:35:31.412377 | instance | changed: [instance]
2026-09-08 15:35:31.412559 | instance |
2026-09-08 15:35:31.412820 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:35:31.413187 | instance | Tuesday 08 September 2026  15:35:31 +0000 (0:00:00.908)       0:00:05.148 *****
2026-09-08 15:35:31.487993 | instance | skipping: [instance]
2026-09-08 15:35:31.488064 | instance |
2026-09-08 15:35:31.488188 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:35:31.488374 | instance | Tuesday 08 September 2026  15:35:31 +0000 (0:00:00.074)       0:00:05.223 *****
2026-09-08 15:35:31.551347 | instance | skipping: [instance]
2026-09-08 15:35:31.551644 | instance |
2026-09-08 15:35:31.551846 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:35:31.552069 | instance | Tuesday 08 September 2026  15:35:31 +0000 (0:00:00.062)       0:00:05.286 *****
2026-09-08 15:35:31.790077 | instance | ok: [instance]
2026-09-08 15:35:31.790121 | instance |
2026-09-08 15:35:31.790128 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:35:31.790135 | instance | Tuesday 08 September 2026  15:35:31 +0000 (0:00:00.239)       0:00:05.526 *****
2026-09-08 15:35:33.302573 | instance | ok: [instance]
2026-09-08 15:35:33.302660 | instance |
2026-09-08 15:35:33.302672 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:35:33.302715 | instance | Tuesday 08 September 2026  15:35:33 +0000 (0:00:01.511)       0:00:07.037 *****
2026-09-08 15:35:33.367049 | instance | ok: [instance] => {
2026-09-08 15:35:33.367101 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-08 15:35:33.367112 | instance | }
2026-09-08 15:35:33.367121 | instance |
2026-09-08 15:35:33.367130 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:35:33.367249 | instance | Tuesday 08 September 2026  15:35:33 +0000 (0:00:00.064)       0:00:07.102 *****
2026-09-08 15:35:34.199819 | instance | changed: [instance]
2026-09-08 15:35:34.200043 | instance |
2026-09-08 15:35:34.200329 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:35:34.200701 | instance | Tuesday 08 September 2026  15:35:34 +0000 (0:00:00.832)       0:00:07.935 *****
2026-09-08 15:35:37.223713 | instance | changed: [instance]
2026-09-08 15:35:37.223834 | instance |
2026-09-08 15:35:37.224488 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-08 15:35:37.224554 | instance | Tuesday 08 September 2026  15:35:37 +0000 (0:00:03.024)       0:00:10.959 *****
2026-09-08 15:35:37.259973 | instance | skipping: [instance]
2026-09-08 15:35:37.260251 | instance |
2026-09-08 15:35:37.261022 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-08 15:35:37.261368 | instance | Tuesday 08 September 2026  15:35:37 +0000 (0:00:00.036)       0:00:10.996 *****
2026-09-08 15:35:37.299281 | instance | skipping: [instance]
2026-09-08 15:35:37.299540 | instance |
2026-09-08 15:35:37.299895 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-08 15:35:37.300206 | instance | Tuesday 08 September 2026  15:35:37 +0000 (0:00:00.039)       0:00:11.035 *****
2026-09-08 15:35:37.335514 | instance | skipping: [instance]
2026-09-08 15:35:37.335753 | instance |
2026-09-08 15:35:37.336096 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-08 15:35:37.336469 | instance | Tuesday 08 September 2026  15:35:37 +0000 (0:00:00.036)       0:00:11.071 *****
2026-09-08 15:35:42.868366 | instance | changed: [instance]
2026-09-08 15:35:42.868860 | instance |
2026-09-08 15:35:42.869146 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-08 15:35:42.869450 | instance | Tuesday 08 September 2026  15:35:42 +0000 (0:00:05.530)       0:00:16.602 *****
2026-09-08 15:35:43.608133 | instance | changed: [instance]
2026-09-08 15:35:43.608386 | instance |
2026-09-08 15:35:43.608587 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-08 15:35:43.608790 | instance | Tuesday 08 September 2026  15:35:43 +0000 (0:00:00.739)       0:00:17.342 *****
2026-09-08 15:35:44.558467 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-08 15:35:44.558561 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-08 15:35:44.559302 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-08 15:35:44.559346 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-08 15:35:44.559353 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-08 15:35:44.559357 | instance |
2026-09-08 15:35:44.559363 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-08 15:35:44.559367 | instance | Tuesday 08 September 2026  15:35:44 +0000 (0:00:00.953)       0:00:18.295 *****
2026-09-08 15:35:45.221548 | instance | changed: [instance]
2026-09-08 15:35:45.222702 | instance |
2026-09-08 15:35:45.222726 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-08 15:35:45.222734 | instance | Tuesday 08 September 2026  15:35:45 +0000 (0:00:00.628)       0:00:18.923 *****
2026-09-08 15:35:45.222742 | instance |
2026-09-08 15:35:45.222749 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-08 15:35:45.222756 | instance | Tuesday 08 September 2026  15:35:45 +0000 (0:00:00.034)       0:00:18.958 *****
2026-09-08 15:35:46.174758 | instance | ok: [instance]
2026-09-08 15:35:46.175546 | instance |
2026-09-08 15:35:46.175749 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-08 15:35:46.175763 | instance | Tuesday 08 September 2026  15:35:46 +0000 (0:00:00.952)       0:00:19.910 *****
2026-09-08 15:35:46.634503 | instance | changed: [instance]
2026-09-08 15:35:46.635191 | instance |
2026-09-08 15:35:46.635265 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-08 15:35:46.635277 | instance | Tuesday 08 September 2026  15:35:46 +0000 (0:00:00.460)       0:00:20.371 *****
2026-09-08 15:35:47.240468 | instance | changed: [instance]
2026-09-08 15:35:47.240531 | instance |
2026-09-08 15:35:47.240887 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:35:47.240933 | instance | Tuesday 08 September 2026  15:35:47 +0000 (0:00:00.606)       0:00:20.977 *****
2026-09-08 15:35:47.479974 | instance | ok: [instance]
2026-09-08 15:35:47.480859 | instance |
2026-09-08 15:35:47.480910 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:35:47.480922 | instance | Tuesday 08 September 2026  15:35:47 +0000 (0:00:00.239)       0:00:21.216 *****
2026-09-08 15:35:47.545992 | instance | ok: [instance] => {
2026-09-08 15:35:47.546729 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-08 15:35:47.546773 | instance | }
2026-09-08 15:35:47.546780 | instance |
2026-09-08 15:35:47.546785 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:35:47.546792 | instance | Tuesday 08 September 2026  15:35:47 +0000 (0:00:00.066)       0:00:21.282 *****
2026-09-08 15:35:48.378434 | instance | changed: [instance]
2026-09-08 15:35:48.378534 | instance |
2026-09-08 15:35:48.378778 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:35:48.378813 | instance | Tuesday 08 September 2026  15:35:48 +0000 (0:00:00.832)       0:00:22.115 *****
2026-09-08 15:35:52.764697 | instance | changed: [instance]
2026-09-08 15:35:52.764845 | instance |
2026-09-08 15:35:52.764857 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-08 15:35:52.764868 | instance | Tuesday 08 September 2026  15:35:52 +0000 (0:00:04.384)       0:00:26.500 *****
2026-09-08 15:35:54.469683 | instance | ok: [instance]
2026-09-08 15:35:54.470507 | instance |
2026-09-08 15:35:54.470542 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-08 15:35:54.470553 | instance | Tuesday 08 September 2026  15:35:54 +0000 (0:00:01.705)       0:00:28.205 *****
2026-09-08 15:35:54.829477 | instance | changed: [instance]
2026-09-08 15:35:54.829531 | instance |
2026-09-08 15:35:54.829542 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-08 15:35:54.829552 | instance | Tuesday 08 September 2026  15:35:54 +0000 (0:00:00.359)       0:00:28.565 *****
2026-09-08 15:35:55.330380 | instance | changed: [instance]
2026-09-08 15:35:55.331165 | instance |
2026-09-08 15:35:55.331246 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-08 15:35:55.331259 | instance | Tuesday 08 September 2026  15:35:55 +0000 (0:00:00.500)       0:00:29.066 *****
2026-09-08 15:35:55.966924 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-08 15:35:55.967567 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-08 15:35:55.967746 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-08 15:35:55.968705 | instance |
2026-09-08 15:35:55.968737 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-08 15:35:55.968748 | instance | Tuesday 08 September 2026  15:35:55 +0000 (0:00:00.636)       0:00:29.703 *****
2026-09-08 15:35:56.527713 | instance | changed: [instance]
2026-09-08 15:35:56.527908 | instance |
2026-09-08 15:35:56.528344 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-08 15:35:56.528720 | instance | Tuesday 08 September 2026  15:35:56 +0000 (0:00:00.560)       0:00:30.263 *****
2026-09-08 15:35:57.100796 | instance | changed: [instance]
2026-09-08 15:35:57.100963 | instance |
2026-09-08 15:35:57.101236 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-08 15:35:57.101552 | instance | Tuesday 08 September 2026  15:35:57 +0000 (0:00:00.550)       0:00:30.814 *****
2026-09-08 15:35:57.101782 | instance |
2026-09-08 15:35:57.102094 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-08 15:35:57.102386 | instance | Tuesday 08 September 2026  15:35:57 +0000 (0:00:00.022)       0:00:30.837 *****
2026-09-08 15:35:57.907166 | instance | ok: [instance]
2026-09-08 15:35:57.907387 | instance |
2026-09-08 15:35:57.907693 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-08 15:35:57.907948 | instance | Tuesday 08 September 2026  15:35:57 +0000 (0:00:00.806)       0:00:31.643 *****
2026-09-08 15:35:58.792558 | instance | changed: [instance]
2026-09-08 15:35:58.792614 | instance |
2026-09-08 15:35:58.792626 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-08 15:35:58.792636 | instance | Tuesday 08 September 2026  15:35:58 +0000 (0:00:00.884)       0:00:32.528 *****
2026-09-08 15:35:59.377064 | instance | changed: [instance]
2026-09-08 15:35:59.377519 | instance |
2026-09-08 15:35:59.377540 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-08 15:35:59.377547 | instance | Tuesday 08 September 2026  15:35:59 +0000 (0:00:00.585)       0:00:33.114 *****
2026-09-08 15:35:59.453255 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-08 15:35:59.454285 | instance |
2026-09-08 15:35:59.454321 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-08 15:35:59.454335 | instance | Tuesday 08 September 2026  15:35:59 +0000 (0:00:00.075)       0:00:33.189 *****
2026-09-08 15:36:04.413159 | instance | changed: [instance]
2026-09-08 15:36:04.413893 | instance |
2026-09-08 15:36:04.413965 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-08 15:36:04.413979 | instance | Tuesday 08 September 2026  15:36:04 +0000 (0:00:04.959)       0:00:38.149 *****
2026-09-08 15:36:05.116073 | instance | ok: [instance] => (item=chronyd)
2026-09-08 15:36:05.116959 | instance | ok: [instance] => (item=sshd)
2026-09-08 15:36:05.117002 | instance |
2026-09-08 15:36:05.117009 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-08 15:36:05.117016 | instance | Tuesday 08 September 2026  15:36:05 +0000 (0:00:00.703)       0:00:38.852 *****
2026-09-08 15:36:10.943170 | instance | changed: [instance]
2026-09-08 15:36:10.943913 | instance |
2026-09-08 15:36:10.943965 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-08 15:36:10.943976 | instance | Tuesday 08 September 2026  15:36:10 +0000 (0:00:05.826)       0:00:44.679 *****
2026-09-08 15:36:11.158065 | instance | ok: [instance]
2026-09-08 15:36:11.158856 | instance |
2026-09-08 15:36:11.158916 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-08 15:36:11.158929 | instance | Tuesday 08 September 2026  15:36:11 +0000 (0:00:00.214)       0:00:44.894 *****
2026-09-08 15:36:11.610094 | instance | changed: [instance]
2026-09-08 15:36:11.610556 | instance |
2026-09-08 15:36:11.610599 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-08 15:36:11.610607 | instance | Tuesday 08 September 2026  15:36:11 +0000 (0:00:00.452)       0:00:45.346 *****
2026-09-08 15:36:11.943042 | instance | changed: [instance]
2026-09-08 15:36:11.943109 | instance |
2026-09-08 15:36:11.943331 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-08 15:36:11.943367 | instance | Tuesday 08 September 2026  15:36:11 +0000 (0:00:00.333)       0:00:45.680 *****
2026-09-08 15:36:12.153789 | instance | ok: [instance]
2026-09-08 15:36:12.154315 | instance |
2026-09-08 15:36:12.154368 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-08 15:36:12.154377 | instance | Tuesday 08 September 2026  15:36:12 +0000 (0:00:00.210)       0:00:45.890 *****
2026-09-08 15:36:12.406285 | instance | ok: [instance] => (item=instance)
2026-09-08 15:36:12.406362 | instance |
2026-09-08 15:36:12.406594 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-08 15:36:12.406796 | instance | Tuesday 08 September 2026  15:36:12 +0000 (0:00:00.252)       0:00:46.142 *****
2026-09-08 15:36:12.470263 | instance | ok: [instance]
2026-09-08 15:36:12.470386 | instance |
2026-09-08 15:36:12.470721 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-08 15:36:12.470772 | instance | Tuesday 08 September 2026  15:36:12 +0000 (0:00:00.064)       0:00:46.206 *****
2026-09-08 15:36:12.570786 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-08 15:36:12.570866 | instance |
2026-09-08 15:36:12.570886 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-08 15:36:12.570951 | instance | Tuesday 08 September 2026  15:36:12 +0000 (0:00:00.100)       0:00:46.307 *****
2026-09-08 15:36:12.893412 | instance | changed: [instance]
2026-09-08 15:36:12.893450 | instance |
2026-09-08 15:36:12.893456 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-08 15:36:12.893460 | instance | Tuesday 08 September 2026  15:36:12 +0000 (0:00:00.322)       0:00:46.630 *****
2026-09-08 15:36:13.580145 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-08 15:36:13.580214 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-08 15:36:13.580685 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-08 15:36:13.580724 | instance |
2026-09-08 15:36:13.580730 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-08 15:36:13.580734 | instance | Tuesday 08 September 2026  15:36:13 +0000 (0:00:00.686)       0:00:47.317 *****
2026-09-08 15:37:40.416087 | instance | ok: [instance]
2026-09-08 15:37:40.416302 | instance |
2026-09-08 15:37:40.416586 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-08 15:37:40.416851 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:01:26.835)       0:02:14.152 *****
2026-09-08 15:37:40.639135 | instance | changed: [instance]
2026-09-08 15:37:40.639225 | instance |
2026-09-08 15:37:40.639347 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-08 15:37:40.639454 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.223)       0:02:14.376 *****
2026-09-08 15:37:40.689321 | instance | ok: [instance]
2026-09-08 15:37:40.689397 | instance |
2026-09-08 15:37:40.689535 | instance | TASK [Install Ceph host] *******************************************************
2026-09-08 15:37:40.689650 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.050)       0:02:14.426 *****
2026-09-08 15:37:40.769018 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-08 15:37:40.769087 | instance |
2026-09-08 15:37:40.769187 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-08 15:37:40.769289 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.079)       0:02:14.506 *****
2026-09-08 15:37:42.326385 | instance | ok: [instance]
2026-09-08 15:37:42.326580 | instance |
2026-09-08 15:37:42.326861 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-08 15:37:42.327100 | instance | Tuesday 08 September 2026  15:37:42 +0000 (0:00:01.556)       0:02:16.062 *****
2026-09-08 15:37:42.404522 | instance | ok: [instance] => (item=instance)
2026-09-08 15:37:42.404710 | instance |
2026-09-08 15:37:42.404969 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-08 15:37:42.405193 | instance | Tuesday 08 September 2026  15:37:42 +0000 (0:00:00.077)       0:02:16.140 *****
2026-09-08 15:37:42.816392 | instance | ok: [instance]
2026-09-08 15:37:42.816602 | instance |
2026-09-08 15:37:42.816861 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-08 15:37:42.817120 | instance | Tuesday 08 September 2026  15:37:42 +0000 (0:00:00.411)       0:02:16.552 *****
2026-09-08 15:37:45.208300 | instance | ok: [instance]
2026-09-08 15:37:45.209077 | instance |
2026-09-08 15:37:45.209135 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-08 15:37:45.209152 | instance | Tuesday 08 September 2026  15:37:45 +0000 (0:00:02.391)       0:02:18.944 *****
2026-09-08 15:38:34.117281 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-08 15:38:34.118270 | 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_gmj36ktm/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_gmj36ktm/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_gmj36ktm/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_gmj36ktm/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-08T15:38:33.940+0000 7ff819dea640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCcK6Bqc/SlGyAAEzHWzN3fXbD/fTr+N0EoTKlT8ptPRSAfEx47OI0ffBk=: Malformed input [buffer:3]\n2026-09-08T15:38:33.940+0000 7ff819dea640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:38:33.944+0000 7ff819dea640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCcK6Bqc/SlGyAAEzHWzN3fXbD/fTr+N0EoTKlT8ptPRSAfEx47OI0ffBk=: Malformed input [buffer:3]\n2026-09-08T15:38:33.944+0000 7ff819dea640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:38:33.944+0000 7ff819dea640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCcK6Bqc/SlGyAAEzHWzN3fXbD/fTr+N0EoTKlT8ptPRSAfEx47OI0ffBk=: Malformed input [buffer:3]\n2026-09-08T15:38:33.944+0000 7ff819dea640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:38:33.944+0000 7ff819dea640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-08 15:38:34.121369 | instance |
2026-09-08 15:38:34.123531 | instance | PLAY RECAP *********************************************************************
2026-09-08 15:38:34.123565 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-09-08 15:38:34.123576 | instance |
2026-09-08 15:38:34.123586 | instance | Tuesday 08 September 2026  15:38:34 +0000 (0:00:48.913)       0:03:07.858 *****
2026-09-08 15:38:34.123595 | instance | ===============================================================================
2026-09-08 15:38:34.123608 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 86.84s
2026-09-08 15:38:34.127613 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 48.91s
2026-09-08 15:38:34.127688 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 5.83s
2026-09-08 15:38:34.127700 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.53s
2026-09-08 15:38:34.127710 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.96s
2026-09-08 15:38:34.127719 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.38s
2026-09-08 15:38:34.127752 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.02s
2026-09-08 15:38:34.127762 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.39s
2026-09-08 15:38:34.127771 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.76s
2026-09-08 15:38:34.127780 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.71s
2026-09-08 15:38:34.127789 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.56s
2026-09-08 15:38:34.127798 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.51s
2026-09-08 15:38:34.127815 | instance | Gathering Facts --------------------------------------------------------- 1.09s
2026-09-08 15:38:34.128210 | instance | Gathering Facts --------------------------------------------------------- 0.98s
2026-09-08 15:38:34.128641 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.95s
2026-09-08 15:38:34.129095 | instance | Gathering Facts --------------------------------------------------------- 0.93s
2026-09-08 15:38:34.129586 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.91s
2026-09-08 15:38:34.130077 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.88s
2026-09-08 15:38:34.130451 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-09-08 15:38:34.130774 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-09-08 15:38:34.224862 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:38:34.225217 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-08 15:38:34.225435 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:38:34.749386 | instance | ERROR
2026-09-08 15:38:34.749591 | instance | {
2026-09-08 15:38:34.749623 | instance |   "delta": "0:04:00.006858",
2026-09-08 15:38:34.749742 | instance |   "end": "2026-09-08 15:38:34.299575",
2026-09-08 15:38:34.749780 | instance |   "msg": "non-zero return code",
2026-09-08 15:38:34.749799 | instance |   "rc": 2,
2026-09-08 15:38:34.749816 | instance |   "start": "2026-09-08 15:34:34.292717"
2026-09-08 15:38:34.749832 | instance | }
failure
2026-09-08 15:38:34.754750 | 
2026-09-08 15:38:34.754859 | PLAY RECAP
2026-09-08 15:38:34.754903 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:38:34.754922 | 
2026-09-08 15:38:34.912267 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-08 15:38:34.914448 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-08 15:38:35.620121 | 
2026-09-08 15:38:35.620242 | PLAY [all]
2026-09-08 15:38:35.633806 | 
2026-09-08 15:38:35.633921 | TASK [gather-host-logs : creating directory for system status]
2026-09-08 15:38:36.020241 | instance | changed
2026-09-08 15:38:36.053754 | 
2026-09-08 15:38:36.053944 | TASK [gather-host-logs : Get logs for each host]
2026-09-08 15:38:36.428911 | instance | + systemd-cgls --full --all --no-pager
2026-09-08 15:38:36.437547 | instance | + ip addr
2026-09-08 15:38:36.439925 | instance | + ip route
2026-09-08 15:38:36.441678 | instance | + lsblk
2026-09-08 15:38:36.447964 | instance | + mount
2026-09-08 15:38:36.451790 | instance | + docker images
2026-09-08 15:38:36.476124 | instance | + brctl show
2026-09-08 15:38:36.476622 | instance | /bin/bash: line 8: brctl: command not found
2026-09-08 15:38:36.476941 | instance | + ps aux --sort=-%mem
2026-09-08 15:38:36.496309 | instance | + dpkg -l
2026-09-08 15:38:36.507246 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-08 15:38:36.507751 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-08 15:38:36.529928 | instance | + '[' '!' -z '' ']'
2026-09-08 15:38:36.601536 | instance | ok: Runtime: 0:00:00.105940
2026-09-08 15:38:36.614578 | 
2026-09-08 15:38:36.614724 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-08 15:38:37.435514 | instance | changed:
2026-09-08 15:38:37.435658 | instance | created directory /var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/logs/instance
2026-09-08 15:38:37.435838 | instance | cd+++++++++ system/
2026-09-08 15:38:37.435878 | instance | >f+++++++++ system/brctl-show.txt
2026-09-08 15:38:37.435906 | instance | >f+++++++++ system/docker-images.txt
2026-09-08 15:38:37.435933 | instance | >f+++++++++ system/ip-addr.txt
2026-09-08 15:38:37.435962 | instance | >f+++++++++ system/ip-route.txt
2026-09-08 15:38:37.435986 | instance | >f+++++++++ system/lsblk.txt
2026-09-08 15:38:37.436009 | instance | >f+++++++++ system/mount.txt
2026-09-08 15:38:37.436032 | instance | >f+++++++++ system/packages.txt
2026-09-08 15:38:37.436056 | instance | >f+++++++++ system/ps.txt
2026-09-08 15:38:37.436076 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-08 15:38:37.444618 | 
2026-09-08 15:38:37.444753 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-08 15:38:37.647462 | instance | changed: "values"
2026-09-08 15:38:37.837943 | instance | changed: "releases"
2026-09-08 15:38:37.857217 | 
2026-09-08 15:38:37.857492 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-08 15:38:38.114605 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-08 15:38:38.404177 | instance | ok: Runtime: 0:00:00.004667
2026-09-08 15:38:38.413418 | 
2026-09-08 15:38:38.413588 | TASK [helm-release-status : Downloads logs to executor]
2026-09-08 15:38:38.909183 | instance | changed:
2026-09-08 15:38:38.909807 | instance | cd+++++++++ helm/
2026-09-08 15:38:38.909867 | instance | cd+++++++++ helm/releases/
2026-09-08 15:38:38.909900 | instance | cd+++++++++ helm/values/
2026-09-08 15:38:38.922668 | 
2026-09-08 15:38:38.922814 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-08 15:38:39.149575 | instance | changed
2026-09-08 15:38:39.160640 | 
2026-09-08 15:38:39.161019 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-08 15:38:39.458743 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:38:39.459444 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:38:39.466578 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:38:39.467628 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:38:39.469970 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:38:39.471276 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:38:39.473592 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:38:39.475228 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:38:39.475436 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:38:39.477150 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:38:39.479572 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:38:39.482075 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:38:39.721323 | instance | ok: Runtime: 0:00:00.030454
2026-09-08 15:38:39.730566 | 
2026-09-08 15:38:39.730770 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-08 15:38:39.959707 | instance | changed
2026-09-08 15:38:39.970747 | 
2026-09-08 15:38:39.971027 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-08 15:38:40.218100 | instance | environment: line 5: kubectl: command not found
2026-09-08 15:38:40.219027 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:38:40.219410 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:38:40.219519 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:38:40.517616 | instance | ok: Runtime: 0:00:00.005888
2026-09-08 15:38:40.529681 | 
2026-09-08 15:38:40.529993 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-08 15:38:41.044028 | instance | changed:
2026-09-08 15:38:41.044340 | instance | cd+++++++++ objects/
2026-09-08 15:38:41.044382 | instance | cd+++++++++ objects/cluster/
2026-09-08 15:38:41.044406 | instance | cd+++++++++ objects/namespaced/
2026-09-08 15:38:41.053273 | 
2026-09-08 15:38:41.053390 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-08 15:38:41.274268 | instance | changed
2026-09-08 15:38:41.281752 | 
2026-09-08 15:38:41.281840 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-08 15:38:41.509172 | instance | changed
2026-09-08 15:38:41.519367 | 
2026-09-08 15:38:41.519575 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-08 15:38:41.745166 | instance | environment: line 3: kubectl: command not found
2026-09-08 15:38:42.068826 | instance | ok: Runtime: 0:00:00.007841
2026-09-08 15:38:42.079480 | 
2026-09-08 15:38:42.079643 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-08 15:38:42.575574 | instance | changed:
2026-09-08 15:38:42.575817 | instance | cd+++++++++ pod-logs/
2026-09-08 15:38:42.575872 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-08 15:38:42.589528 | 
2026-09-08 15:38:42.589614 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-08 15:38:42.810080 | instance | changed
2026-09-08 15:38:42.814863 | 
2026-09-08 15:38:42.814935 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-08 15:38:43.038211 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-08 15:38:43.351909 | instance | ok: Runtime: 0:00:00.057730
2026-09-08 15:38:43.364167 | 
2026-09-08 15:38:43.365176 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-08 15:38:43.625948 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-08 15:38:43.672377 | instance | ceph-mgr endpoints:
2026-09-08 15:38:43.920281 | instance | ok: Runtime: 0:00:00.052438
2026-09-08 15:38:43.931525 | 
2026-09-08 15:38:43.931687 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-08 15:38:44.172973 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-08 15:38:44.480411 | instance | ok: Runtime: 0:00:00.036660
2026-09-08 15:38:44.493552 | 
2026-09-08 15:38:44.493691 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-08 15:38:45.031832 | instance | changed: cd+++++++++ prometheus/
2026-09-08 15:38:45.042515 | 
2026-09-08 15:38:45.042602 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-08 15:38:45.255799 | instance | changed
2026-09-08 15:38:45.261807 | 
2026-09-08 15:38:45.261871 | TASK [gather-selenium-data : Get selenium data]
2026-09-08 15:38:45.520793 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-08 15:38:45.522208 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-08 15:38:45.804737 | instance | ERROR
2026-09-08 15:38:45.805068 | instance | {
2026-09-08 15:38:45.805138 | instance |   "delta": "0:00:00.005587",
2026-09-08 15:38:45.805193 | instance |   "end": "2026-09-08 15:38:45.522480",
2026-09-08 15:38:45.805258 | instance |   "msg": "non-zero return code",
2026-09-08 15:38:45.805315 | instance |   "rc": 1,
2026-09-08 15:38:45.805355 | instance |   "start": "2026-09-08 15:38:45.516893"
2026-09-08 15:38:45.805390 | instance | }
2026-09-08 15:38:45.805458 | instance | ERROR: Ignoring Errors
2026-09-08 15:38:45.815099 | 
2026-09-08 15:38:45.815226 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-08 15:38:46.345704 | instance | changed: cd+++++++++ selenium/
2026-09-08 15:38:46.356992 | 
2026-09-08 15:38:46.357097 | PLAY RECAP
2026-09-08 15:38:46.357180 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-08 15:38:46.357223 | 
2026-09-08 15:38:46.486824 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-08 15:38:46.490663 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-08 15:38:47.128677 | 
2026-09-08 15:38:47.128798 | PLAY [all]
2026-09-08 15:38:47.140435 | 
2026-09-08 15:38:47.140563 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-08 15:38:47.194235 | instance | skipping: Conditional result was False
2026-09-08 15:38:47.201229 | 
2026-09-08 15:38:47.201339 | TASK [fetch-output : Set log path for single node]
2026-09-08 15:38:47.254729 | instance | ok
2026-09-08 15:38:47.264634 | 
2026-09-08 15:38:47.264732 | LOOP [fetch-output : Ensure local output dirs]
2026-09-08 15:38:47.696250 | instance -> localhost | ok: "/var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/logs"
2026-09-08 15:38:47.931216 | instance -> localhost | changed: "/var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/artifacts"
2026-09-08 15:38:48.162073 | instance -> localhost | changed: "/var/lib/zuul/builds/7bdc456e957d463791a55b065a7e44b2/work/docs"
2026-09-08 15:38:48.178166 | 
2026-09-08 15:38:48.178346 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-08 15:38:48.848121 | instance | changed: .d..t...... ./
2026-09-08 15:38:48.848520 | instance | changed: All items complete
2026-09-08 15:38:48.848601 | 
2026-09-08 15:38:49.320968 | instance | changed: .d..t...... ./
2026-09-08 15:38:49.832791 | instance | changed: .d..t...... ./
2026-09-08 15:38:49.863653 | 
2026-09-08 15:38:49.863858 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-08 15:38:50.290300 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009289
2026-09-08 15:38:50.567708 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007492
2026-09-08 15:38:50.581752 | 
2026-09-08 15:38:50.581876 | PLAY [all]
2026-09-08 15:38:50.589021 | 
2026-09-08 15:38:50.589102 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-08 15:38:51.048182 | instance | changed
2026-09-08 15:38:51.058018 | 
2026-09-08 15:38:51.058131 | PLAY RECAP
2026-09-08 15:38:51.058207 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-08 15:38:51.058250 | 
2026-09-08 15:38:51.172212 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-08 15:38:51.176326 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-08 15:38:51.748576 | 
2026-09-08 15:38:51.748722 | PLAY [localhost]
2026-09-08 15:38:51.760473 | 
2026-09-08 15:38:51.760628 | TASK [Generate Zuul manifest]
2026-09-08 15:38:51.776957 | localhost | ok
2026-09-08 15:38:51.793085 | 
2026-09-08 15:38:51.793176 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-08 15:38:52.137311 | localhost | changed
2026-09-08 15:38:52.162895 | 
2026-09-08 15:38:52.163101 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-08 15:38:52.194858 | localhost | ok
2026-09-08 15:38:52.208004 | 
2026-09-08 15:38:52.208163 | TASK [Upload logs]
2026-09-08 15:38:52.231744 | localhost | ok
2026-09-08 15:38:52.309707 | 
2026-09-08 15:38:52.309822 | TASK [Set zuul-log-path fact]
2026-09-08 15:38:52.326062 | localhost | ok
2026-09-08 15:38:52.336409 | 
2026-09-08 15:38:52.336552 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-08 15:38:52.374812 | localhost | ok
2026-09-08 15:38:52.382949 | 
2026-09-08 15:38:52.383038 | TASK [upload-logs : Create log directories]
2026-09-08 15:38:52.827914 | localhost | changed
2026-09-08 15:38:52.837328 | 
2026-09-08 15:38:52.837491 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-08 15:38:53.262658 | localhost -> localhost | ok: Runtime: 0:00:00.006152
2026-09-08 15:38:53.271315 | 
2026-09-08 15:38:53.271493 | TASK [upload-logs : Upload logs to log server]
2026-09-08 15:38:53.774316 | localhost | Output suppressed because no_log was given
2026-09-08 15:38:53.817924 | 
2026-09-08 15:38:53.818090 | LOOP [upload-logs : Compress console log and json output]
2026-09-08 15:38:53.876260 | localhost | skipping: Conditional result was False
2026-09-08 15:38:53.885230 | localhost | skipping: Conditional result was False
2026-09-08 15:38:53.900786 | 
2026-09-08 15:38:53.900971 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-08 15:38:53.958142 | localhost | skipping: Conditional result was False
2026-09-08 15:38:53.958618 | 
2026-09-08 15:38:53.964215 | localhost | skipping: Conditional result was False
2026-09-08 15:38:53.973986 | 
2026-09-08 15:38:53.974124 | LOOP [upload-logs : Upload console log and json output]