2026-09-01 13:13:24.909078 | Job console starting
2026-09-01 13:13:24.918516 | Updating git repos
2026-09-01 13:13:27.582651 | Cloning repos into workspace
2026-09-01 13:13:45.842415 | Restoring repo states
2026-09-01 13:13:57.374158 | Merging changes
2026-09-01 13:13:58.460273 | Checking out repos
2026-09-01 13:13:59.667372 | Preparing playbooks
2026-09-01 13:14:01.694186 | Running Ansible setup
2026-09-01 13:14:05.156647 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-01 13:14:05.750060 | 
2026-09-01 13:14:05.750206 | PLAY [localhost]
2026-09-01 13:14:05.757552 | 
2026-09-01 13:14:05.757621 | TASK [Gathering Facts]
2026-09-01 13:14:06.646548 | localhost | ok
2026-09-01 13:14:06.658371 | 
2026-09-01 13:14:06.658463 | TASK [Setup log path fact]
2026-09-01 13:14:06.682033 | localhost | ok
2026-09-01 13:14:06.704714 | 
2026-09-01 13:14:06.704916 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-01 13:14:06.735404 | localhost | ok
2026-09-01 13:14:06.753224 | 
2026-09-01 13:14:06.753624 | TASK [emit-job-header : Print job information]
2026-09-01 13:14:06.807750 | # Job Information
2026-09-01 13:14:06.807928 | Ansible Version: 2.16.18
2026-09-01 13:14:06.807961 | Job: atmosphere-molecule-csi-rbd
2026-09-01 13:14:06.807984 | Pipeline: check
2026-09-01 13:14:06.808005 | Executor: 2d72f0692154
2026-09-01 13:14:06.808026 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4358
2026-09-01 13:14:06.808049 | Event ID: 53d4b6e0-a606-11f1-8e73-1bb783a0482a
2026-09-01 13:14:06.810894 | 
2026-09-01 13:14:06.810961 | LOOP [emit-job-header : Print node information]
2026-09-01 13:14:06.903055 | localhost | ok:
2026-09-01 13:14:06.903243 | localhost | # Node Information
2026-09-01 13:14:06.903271 | localhost | Inventory Hostname: instance
2026-09-01 13:14:06.903292 | localhost | Hostname: np0000191740
2026-09-01 13:14:06.903312 | localhost | Username: zuul
2026-09-01 13:14:06.903334 | localhost | Distro: Ubuntu 22.04
2026-09-01 13:14:06.903353 | localhost | Provider: yul1
2026-09-01 13:14:06.903373 | localhost | Region: ca-ymq-1
2026-09-01 13:14:06.903391 | localhost | Label: ubuntu-jammy
2026-09-01 13:14:06.903409 | localhost | Product Name: OpenStack Nova
2026-09-01 13:14:06.903428 | localhost | Interface IP: 199.204.45.10
2026-09-01 13:14:06.913304 | 
2026-09-01 13:14:06.913450 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-01 13:14:07.349111 | localhost -> localhost | changed
2026-09-01 13:14:07.361358 | 
2026-09-01 13:14:07.361494 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-01 13:14:08.180189 | localhost -> localhost | changed
2026-09-01 13:14:08.189915 | 
2026-09-01 13:14:08.189996 | PLAY [all]
2026-09-01 13:14:08.200345 | 
2026-09-01 13:14:08.200417 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-01 13:14:08.458091 | instance -> localhost | ok
2026-09-01 13:14:08.468304 | 
2026-09-01 13:14:08.468409 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-01 13:14:08.503746 | instance | ok
2026-09-01 13:14:08.520831 | instance | included: /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-01 13:14:08.526726 | 
2026-09-01 13:14:08.526786 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-01 13:14:09.489766 | instance -> localhost | Generating public/private rsa key pair.
2026-09-01 13:14:09.490055 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/f5331012077240b5bd4a6bdbc65341e3_id_rsa
2026-09-01 13:14:09.490118 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/f5331012077240b5bd4a6bdbc65341e3_id_rsa.pub
2026-09-01 13:14:09.490168 | instance -> localhost | The key fingerprint is:
2026-09-01 13:14:09.490214 | instance -> localhost | SHA256:E54G6kGCCTIf7PqXY8km+NPxIoa6wVg5LSnED39j8do zuul-build-sshkey
2026-09-01 13:14:09.490279 | instance -> localhost | The key's randomart image is:
2026-09-01 13:14:09.490326 | instance -> localhost | +---[RSA 3072]----+
2026-09-01 13:14:09.490378 | instance -> localhost | |+..              |
2026-09-01 13:14:09.490424 | instance -> localhost | |+=..             |
2026-09-01 13:14:09.490469 | instance -> localhost | |o=o ... .        |
2026-09-01 13:14:09.490513 | instance -> localhost | |. =* .oo o       |
2026-09-01 13:14:09.490557 | instance -> localhost | |..*o++ .S        |
2026-09-01 13:14:09.490600 | instance -> localhost | |+o ++.+. .       |
2026-09-01 13:14:09.490643 | instance -> localhost | |o= o.* E         |
2026-09-01 13:14:09.490686 | instance -> localhost | |o.* @ .          |
2026-09-01 13:14:09.490734 | instance -> localhost | |++.B o           |
2026-09-01 13:14:09.490778 | instance -> localhost | +----[SHA256]-----+
2026-09-01 13:14:09.490870 | instance -> localhost | ok: Runtime: 0:00:00.547800
2026-09-01 13:14:09.499006 | 
2026-09-01 13:14:09.499070 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-01 13:14:09.532235 | instance | ok
2026-09-01 13:14:09.544154 | instance | included: /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-01 13:14:09.551268 | 
2026-09-01 13:14:09.551325 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-01 13:14:09.575402 | instance | skipping: Conditional result was False
2026-09-01 13:14:09.584581 | 
2026-09-01 13:14:09.584666 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-01 13:14:10.054198 | instance | changed
2026-09-01 13:14:10.062891 | 
2026-09-01 13:14:10.062982 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-01 13:14:10.292390 | instance | ok
2026-09-01 13:14:10.299799 | 
2026-09-01 13:14:10.299902 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-01 13:14:10.811782 | instance | changed
2026-09-01 13:14:10.816694 | 
2026-09-01 13:14:10.816753 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-01 13:14:12.213041 | instance | changed
2026-09-01 13:14:12.219057 | 
2026-09-01 13:14:12.219117 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-01 13:14:12.247883 | instance | skipping: Conditional result was False
2026-09-01 13:14:12.258634 | 
2026-09-01 13:14:12.258703 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-01 13:14:12.618293 | instance -> localhost | changed
2026-09-01 13:14:12.633406 | 
2026-09-01 13:14:12.633467 | TASK [add-build-sshkey : Add back temp key]
2026-09-01 13:14:12.910269 | instance -> localhost | Identity added: /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/f5331012077240b5bd4a6bdbc65341e3_id_rsa (zuul-build-sshkey)
2026-09-01 13:14:12.910514 | instance -> localhost | ok: Runtime: 0:00:00.016977
2026-09-01 13:14:12.917242 | 
2026-09-01 13:14:12.917326 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-01 13:14:13.278023 | instance | ok
2026-09-01 13:14:13.284308 | 
2026-09-01 13:14:13.284397 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-01 13:14:13.319625 | instance | skipping: Conditional result was False
2026-09-01 13:14:13.334178 | 
2026-09-01 13:14:13.334262 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-01 13:14:13.730973 | instance | ok
2026-09-01 13:14:13.739268 | 
2026-09-01 13:14:13.739353 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-01 13:14:17.488503 | instance | Output suppressed because no_log was given
2026-09-01 13:14:17.497761 | 
2026-09-01 13:14:17.497831 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-01 13:14:17.726085 | instance | ok: "logs"
2026-09-01 13:14:17.726373 | instance | ok: All items complete
2026-09-01 13:14:17.726402 | 
2026-09-01 13:14:17.888371 | instance | ok: "artifacts"
2026-09-01 13:14:18.062685 | instance | ok: "docs"
2026-09-01 13:14:18.075082 | 
2026-09-01 13:14:18.075277 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-01 13:14:18.293656 | instance | changed: "logs"
2026-09-01 13:14:18.463430 | instance | changed: "artifacts"
2026-09-01 13:14:18.618469 | instance | changed: "docs"
2026-09-01 13:14:18.638634 | 
2026-09-01 13:14:18.638767 | PLAY RECAP
2026-09-01 13:14:18.638820 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-01 13:14:18.638848 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-01 13:14:18.638870 | 
2026-09-01 13:14:18.801927 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-01 13:14:18.804178 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-01 13:14:19.384023 | 
2026-09-01 13:14:19.384327 | PLAY [all]
2026-09-01 13:14:19.395182 | 
2026-09-01 13:14:19.395264 | TASK [setup-uv : Extract archive]
2026-09-01 13:14:21.759100 | instance | changed
2026-09-01 13:14:21.764645 | 
2026-09-01 13:14:21.764723 | TASK [setup-uv : Print version]
2026-09-01 13:14:22.127183 | instance | uv 0.8.13
2026-09-01 13:14:22.303165 | instance | ok: Runtime: 0:00:00.013945
2026-09-01 13:14:22.313567 | 
2026-09-01 13:14:22.313644 | TASK [Install Ansible collection siblings]
2026-09-01 13:14:32.323334 | instance | changed:
2026-09-01 13:14:32.323543 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-01 13:14:32.323571 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-01 13:14:32.323594 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-01 13:14:32.323614 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-01 13:14:32.323634 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-01 13:14:32.323657 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-01 13:14:32.323678 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-01 13:14:32.323700 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-01 13:14:32.323720 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-01 13:14:32.323739 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-01 13:14:32.323759 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-01 13:14:32.323800 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-01 13:14:32.323822 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-01 13:14:32.323841 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-01 13:14:32.323862 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-01 13:14:32.323881 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-01 13:14:32.323901 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-01 13:14:32.323919 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-01 13:14:32.323937 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-01 13:14:32.323956 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-01 13:14:32.323974 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-01 13:14:32.323992 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-01 13:14:32.324011 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-01 13:14:32.324040 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-01 13:14:32.324059 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-01 13:14:32.324077 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-01 13:14:32.324095 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-01 13:14:32.324113 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-01 13:14:32.324131 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-01 13:14:32.324149 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-01 13:14:32.324167 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-01 13:14:32.324185 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-01 13:14:32.324204 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-01 13:14:32.324222 | 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-01 13:14:32.324248 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.324267 | instance | Process install dependency map
2026-09-01 13:14:32.324285 | instance | Starting collection install process
2026-09-01 13:14:32.324304 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-01 13:14:32.324322 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-01 13:14:32.324340 | instance | ansible.netcommon:* was installed successfully
2026-09-01 13:14:32.324359 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-01 13:14:32.324377 | instance | Creating virtual environment at: .venv
2026-09-01 13:14:32.324395 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-01 13:14:32.324414 | instance | Downloading rjsonnet (1.2MiB)
2026-09-01 13:14:32.324432 | instance | Downloading pydantic-core (2.0MiB)
2026-09-01 13:14:32.324453 | instance | Downloading cryptography (4.2MiB)
2026-09-01 13:14:32.324472 | instance | Downloading kubernetes (1.9MiB)
2026-09-01 13:14:32.324490 | instance | Downloading pygments (1.2MiB)
2026-09-01 13:14:32.324509 | instance | Downloading ansible-core (2.1MiB)
2026-09-01 13:14:32.324527 | instance | Downloading openstacksdk (1.7MiB)
2026-09-01 13:14:32.324546 | instance | Downloading setuptools (1.1MiB)
2026-09-01 13:14:32.324564 | instance | Downloading netaddr (2.2MiB)
2026-09-01 13:14:32.324582 | instance |    Building pyperclip==1.9.0
2026-09-01 13:14:32.324602 | instance |  Downloading rjsonnet
2026-09-01 13:14:32.324620 | instance |  Downloading pydantic-core
2026-09-01 13:14:32.324639 | instance |  Downloading netaddr
2026-09-01 13:14:32.324657 | instance |  Downloading pygments
2026-09-01 13:14:32.324676 | instance |  Downloading cryptography
2026-09-01 13:14:32.324694 | instance |  Downloading setuptools
2026-09-01 13:14:32.324712 | instance |  Downloading kubernetes
2026-09-01 13:14:32.324730 | instance |  Downloading ansible-core
2026-09-01 13:14:32.324749 | instance |  Downloading openstacksdk
2026-09-01 13:14:32.324767 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-01 13:14:32.324786 | instance |       Built pyperclip==1.9.0
2026-09-01 13:14:32.324804 | instance | Installed 83 packages in 61ms
2026-09-01 13:14:32.324823 | instance | Checked out ansible.posix to 1.6.0
2026-09-01 13:14:32.324841 | 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-01 13:14:32.324860 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.324879 | instance | Process install dependency map
2026-09-01 13:14:32.324904 | instance | Starting collection install process
2026-09-01 13:14:32.324923 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-01 13:14:32.324942 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-01 13:14:32.324980 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-01 13:14:32.325003 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325022 | instance | 2.17.12
2026-09-01 13:14:32.325040 | instance | Checked out ansible.utils to v6.1.0
2026-09-01 13:14:32.325059 | 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-01 13:14:32.325077 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.325095 | instance | Process install dependency map
2026-09-01 13:14:32.325114 | instance | Starting collection install process
2026-09-01 13:14:32.325133 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-01 13:14:32.325152 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-01 13:14:32.325170 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-01 13:14:32.325189 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325208 | instance | 2.17.12
2026-09-01 13:14:32.325226 | instance | Checked out atmosphere.common to v0.7.0
2026-09-01 13:14:32.325244 | 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-01 13:14:32.325263 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.325281 | instance | Process install dependency map
2026-09-01 13:14:32.325299 | instance | Starting collection install process
2026-09-01 13:14:32.325318 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-01 13:14:32.325336 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-01 13:14:32.325355 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-01 13:14:32.325373 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325391 | instance | 2.17.12
2026-09-01 13:14:32.325409 | instance | Checked out community.crypto to 2.2.3
2026-09-01 13:14:32.325427 | 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-01 13:14:32.325446 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.325464 | instance | Process install dependency map
2026-09-01 13:14:32.325482 | instance | Starting collection install process
2026-09-01 13:14:32.325500 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-01 13:14:32.325518 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-01 13:14:32.325536 | instance | community.crypto:2.2.3 was installed successfully
2026-09-01 13:14:32.325554 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325572 | instance | 2.17.12
2026-09-01 13:14:32.325590 | instance | Checked out community.general to 7.3.0
2026-09-01 13:14:32.325608 | 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-01 13:14:32.325633 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.325652 | instance | Process install dependency map
2026-09-01 13:14:32.325670 | instance | Starting collection install process
2026-09-01 13:14:32.325689 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-01 13:14:32.325707 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-01 13:14:32.325725 | instance | community.general:7.3.0 was installed successfully
2026-09-01 13:14:32.325744 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325762 | instance | 2.17.12
2026-09-01 13:14:32.325780 | instance | Checked out community.mysql to 3.6.0
2026-09-01 13:14:32.325801 | 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-01 13:14:32.325820 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.325838 | instance | Process install dependency map
2026-09-01 13:14:32.325857 | instance | Starting collection install process
2026-09-01 13:14:32.325875 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-01 13:14:32.325893 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-01 13:14:32.325911 | instance | community.mysql:3.6.0 was installed successfully
2026-09-01 13:14:32.325930 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.325948 | instance | 2.17.12
2026-09-01 13:14:32.325966 | instance | Checked out kubernetes.core to 2.4.0
2026-09-01 13:14:32.325985 | 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-01 13:14:32.326003 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.326022 | instance | Process install dependency map
2026-09-01 13:14:32.326040 | instance | Starting collection install process
2026-09-01 13:14:32.326059 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-01 13:14:32.326077 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-01 13:14:32.326095 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-01 13:14:32.326114 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.326132 | instance | 2.17.12
2026-09-01 13:14:32.326150 | instance | Checked out openstack.cloud to 2.6.0
2026-09-01 13:14:32.326169 | 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-01 13:14:32.326189 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.326210 | instance | Process install dependency map
2026-09-01 13:14:32.326228 | instance | Starting collection install process
2026-09-01 13:14:32.326246 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-01 13:14:32.326264 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-01 13:14:32.326282 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-01 13:14:32.326301 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.326318 | instance | 2.17.12
2026-09-01 13:14:32.326344 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-01 13:14:32.326363 | 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-01 13:14:32.326382 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.326400 | instance | Process install dependency map
2026-09-01 13:14:32.326418 | instance | Starting collection install process
2026-09-01 13:14:32.326437 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-01 13:14:32.326455 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-01 13:14:32.326473 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-01 13:14:32.326492 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.326510 | instance | 2.17.12
2026-09-01 13:14:32.326527 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-01 13:14:32.326546 | 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-01 13:14:32.326570 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.326589 | instance | Process install dependency map
2026-09-01 13:14:32.326607 | instance | Starting collection install process
2026-09-01 13:14:32.326625 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-01 13:14:32.326644 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-01 13:14:32.326662 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-01 13:14:32.326681 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.326699 | instance | 2.17.12
2026-09-01 13:14:32.326718 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-01 13:14:32.326736 | 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-01 13:14:32.326755 | instance | Starting galaxy collection install process
2026-09-01 13:14:32.326773 | instance | Process install dependency map
2026-09-01 13:14:32.326791 | instance | Starting collection install process
2026-09-01 13:14:32.326810 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-01 13:14:32.326828 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-01 13:14:32.326846 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-01 13:14:32.326864 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-01 13:14:32.326883 | instance | 2.17.12
2026-09-01 13:14:32.332788 | 
2026-09-01 13:14:32.332840 | PLAY RECAP
2026-09-01 13:14:32.332892 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-01 13:14:32.332912 | 
2026-09-01 13:14:32.468225 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-01 13:14:32.470595 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-01 13:14:33.038467 | 
2026-09-01 13:14:33.038591 | PLAY [all]
2026-09-01 13:14:33.050890 | 
2026-09-01 13:14:33.050967 | TASK [Install "jq" for log collection]
2026-09-01 13:14:44.333354 | instance | changed
2026-09-01 13:14:44.335125 | 
2026-09-01 13:14:44.335180 | PLAY RECAP
2026-09-01 13:14:44.335229 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-01 13:14:44.335293 | 
2026-09-01 13:14:44.435932 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-01 13:14:44.439818 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-01 13:14:45.007002 | 
2026-09-01 13:14:45.007135 | PLAY [all]
2026-09-01 13:14:45.017803 | 
2026-09-01 13:14:45.017875 | LOOP [Check inventory directories]
2026-09-01 13:14:45.367046 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-01 13:14:45.533767 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-01 13:14:45.686315 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-01 13:14:45.698960 | 
2026-09-01 13:14:45.699176 | LOOP [Copy inventory file for Zuul]
2026-09-01 13:14:46.559102 | instance | changed:
2026-09-01 13:14:46.559291 | instance | {
2026-09-01 13:14:46.559325 | instance |   "ansible_loop_var": "item",
2026-09-01 13:14:46.559353 | instance |   "changed": false,
2026-09-01 13:14:46.559379 | instance |   "failed": false,
2026-09-01 13:14:46.559408 | instance |   "invocation": {
2026-09-01 13:14:46.559433 | instance |     "module_args": {
2026-09-01 13:14:46.559457 | instance |       "checksum_algorithm": "sha1",
2026-09-01 13:14:46.559481 | instance |       "follow": true,
2026-09-01 13:14:46.559506 | instance |       "get_attributes": true,
2026-09-01 13:14:46.559530 | instance |       "get_checksum": true,
2026-09-01 13:14:46.559554 | instance |       "get_mime": true,
2026-09-01 13:14:46.559579 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-01 13:14:46.559602 | instance |     }
2026-09-01 13:14:46.559632 | instance |   },
2026-09-01 13:14:46.559656 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-01 13:14:46.559679 | instance |   "stat": {
2026-09-01 13:14:46.559702 | instance |     "atime": 1788268464.4743862,
2026-09-01 13:14:46.559725 | instance |     "attr_flags": "e",
2026-09-01 13:14:46.559755 | instance |     "attributes": [
2026-09-01 13:14:46.559777 | instance |       "extents"
2026-09-01 13:14:46.559800 | instance |     ],
2026-09-01 13:14:46.559823 | instance |     "block_size": 4096,
2026-09-01 13:14:46.559845 | instance |     "blocks": 8,
2026-09-01 13:14:46.559868 | instance |     "charset": "unknown",
2026-09-01 13:14:46.559892 | instance |     "ctime": 1788268463.1542134,
2026-09-01 13:14:46.559917 | instance |     "dev": 64513,
2026-09-01 13:14:46.559940 | instance |     "device_type": 0,
2026-09-01 13:14:46.559963 | instance |     "executable": true,
2026-09-01 13:14:46.559985 | instance |     "exists": true,
2026-09-01 13:14:46.560008 | instance |     "gid": 1000,
2026-09-01 13:14:46.560031 | instance |     "gr_name": "zuul",
2026-09-01 13:14:46.560054 | instance |     "inode": 1049385,
2026-09-01 13:14:46.560077 | instance |     "isblk": false,
2026-09-01 13:14:46.560099 | instance |     "ischr": false,
2026-09-01 13:14:46.560123 | instance |     "isdir": true,
2026-09-01 13:14:46.560145 | instance |     "isfifo": false,
2026-09-01 13:14:46.560168 | instance |     "isgid": false,
2026-09-01 13:14:46.560190 | instance |     "islnk": false,
2026-09-01 13:14:46.560213 | instance |     "isreg": false,
2026-09-01 13:14:46.560236 | instance |     "issock": false,
2026-09-01 13:14:46.560259 | instance |     "isuid": false,
2026-09-01 13:14:46.560281 | instance |     "mimetype": "unknown",
2026-09-01 13:14:46.560304 | instance |     "mode": "0755",
2026-09-01 13:14:46.560327 | instance |     "mtime": 1788268463.1542134,
2026-09-01 13:14:46.560349 | instance |     "nlink": 23,
2026-09-01 13:14:46.560371 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-01 13:14:46.560394 | instance |     "pw_name": "zuul",
2026-09-01 13:14:46.560418 | instance |     "readable": true,
2026-09-01 13:14:46.560442 | instance |     "rgrp": true,
2026-09-01 13:14:46.560465 | instance |     "roth": true,
2026-09-01 13:14:46.560602 | instance |     "rusr": true,
2026-09-01 13:14:46.560633 | instance |     "size": 4096,
2026-09-01 13:14:46.560652 | instance |     "uid": 1000,
2026-09-01 13:14:46.560669 | instance |     "version": "3914001920",
2026-09-01 13:14:46.560688 | instance |     "wgrp": false,
2026-09-01 13:14:46.560708 | instance |     "woth": false,
2026-09-01 13:14:46.560727 | instance |     "writeable": true,
2026-09-01 13:14:46.560746 | instance |     "wusr": true,
2026-09-01 13:14:46.560764 | instance |     "xgrp": true,
2026-09-01 13:14:46.560782 | instance |     "xoth": true,
2026-09-01 13:14:46.560799 | instance |     "xusr": true
2026-09-01 13:14:46.560817 | instance |   }
2026-09-01 13:14:46.560835 | instance | }
2026-09-01 13:14:46.560876 | instance | ok: All items complete
2026-09-01 13:14:46.560898 | 
2026-09-01 13:14:46.562185 | instance | skipping: Conditional result was False
2026-09-01 13:14:46.562758 | instance | skipping: Conditional result was False
2026-09-01 13:14:46.578663 | 
2026-09-01 13:14:46.578829 | LOOP [Switch "ansible_host" to private IP]
2026-09-01 13:14:46.942681 | instance | changed: 1 replacements made
2026-09-01 13:14:46.943926 | instance | skipping: Conditional result was False
2026-09-01 13:14:46.944676 | instance | skipping: Conditional result was False
2026-09-01 13:14:46.962990 | 
2026-09-01 13:14:46.963141 | TASK [Run Molecule scenario]
2026-09-01 13:14:47.887819 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-01 13:14:48.327569 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-01 13:14:48.327629 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-01 13:15:00.021603 | instance | INFO     [csi > dependency] Executing
2026-09-01 13:15:00.022007 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-01 13:15:00.022424 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-01 13:15:00.022673 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-01 13:15:00.038064 | instance | INFO     [csi > cleanup] Executing
2026-09-01 13:15:00.038761 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-01 13:15:00.051414 | instance | INFO     [csi > destroy] Executing
2026-09-01 13:15:00.051529 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-01 13:15:00.051623 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-01 13:15:00.060567 | instance | INFO     [csi > syntax] Executing
2026-09-01 13:15:01.585938 | instance |
2026-09-01 13:15:01.586262 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-01 13:15:01.650157 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-01 13:15:01.668902 | instance | INFO     [csi > create] Executing
2026-09-01 13:15:01.673255 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-01 13:15:01.688111 | instance | INFO     [csi > prepare] Executing
2026-09-01 13:15:02.452731 | instance |
2026-09-01 13:15:02.452950 | instance | PLAY [Prepare] *****************************************************************
2026-09-01 13:15:02.453184 | instance |
2026-09-01 13:15:02.453469 | instance | TASK [Gathering Facts] *********************************************************
2026-09-01 13:15:02.453730 | instance | Tuesday 01 September 2026  13:15:02 +0000 (0:00:00.023)       0:00:00.023 *****
2026-09-01 13:15:03.825042 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-01 13:15:03.825177 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-01 13:15:03.825366 | instance | interpreter could change the meaning of that path. See
2026-09-01 13:15:03.825540 | instance | https://docs.ansible.com/ansible-
2026-09-01 13:15:03.825797 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-01 13:15:03.832545 | instance | ok: [instance]
2026-09-01 13:15:03.832795 | instance |
2026-09-01 13:15:03.833090 | instance | TASK [Configure short hostname] ************************************************
2026-09-01 13:15:03.833350 | instance | Tuesday 01 September 2026  13:15:03 +0000 (0:00:01.379)       0:00:01.403 *****
2026-09-01 13:15:04.601357 | instance | changed: [instance]
2026-09-01 13:15:04.601652 | instance |
2026-09-01 13:15:04.601910 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-01 13:15:04.602154 | instance | Tuesday 01 September 2026  13:15:04 +0000 (0:00:00.768)       0:00:02.171 *****
2026-09-01 13:15:04.879706 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-01 13:15:04.880130 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-01 13:15:04.880407 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-01 13:15:04.890154 | instance | changed: [instance]
2026-09-01 13:15:04.890553 | instance |
2026-09-01 13:15:04.890894 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-01 13:15:04.891225 | instance | Tuesday 01 September 2026  13:15:04 +0000 (0:00:00.288)       0:00:02.460 *****
2026-09-01 13:15:05.751761 | instance | ok: [instance]
2026-09-01 13:15:05.751889 | instance |
2026-09-01 13:15:05.751902 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-01 13:15:05.751944 | instance |
2026-09-01 13:15:05.752111 | instance | TASK [Gathering Facts] *********************************************************
2026-09-01 13:15:05.752217 | instance | Tuesday 01 September 2026  13:15:05 +0000 (0:00:00.862)       0:00:03.322 *****
2026-09-01 13:15:06.502611 | instance | ok: [instance]
2026-09-01 13:15:06.502788 | instance |
2026-09-01 13:15:06.503025 | instance | TASK [Install depedencies] *****************************************************
2026-09-01 13:15:06.503277 | instance | Tuesday 01 September 2026  13:15:06 +0000 (0:00:00.749)       0:00:04.072 *****
2026-09-01 13:15:29.468478 | instance | changed: [instance]
2026-09-01 13:15:29.468606 | instance |
2026-09-01 13:15:29.468706 | instance | TASK [Start up service] ********************************************************
2026-09-01 13:15:29.468852 | instance | Tuesday 01 September 2026  13:15:29 +0000 (0:00:22.966)       0:00:27.038 *****
2026-09-01 13:15:30.075445 | instance | ok: [instance]
2026-09-01 13:15:30.075573 | instance |
2026-09-01 13:15:30.075784 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-01 13:15:30.075960 | instance | Tuesday 01 September 2026  13:15:30 +0000 (0:00:00.606)       0:00:27.645 *****
2026-09-01 13:15:30.374443 | instance | ok: [instance]
2026-09-01 13:15:30.374648 | instance |
2026-09-01 13:15:30.374890 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-01 13:15:30.375125 | instance | Tuesday 01 September 2026  13:15:30 +0000 (0:00:00.299)       0:00:27.945 *****
2026-09-01 13:15:31.050359 | instance | changed: [instance]
2026-09-01 13:15:31.050446 | instance |
2026-09-01 13:15:31.050456 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-01 13:15:31.050463 | instance | Tuesday 01 September 2026  13:15:31 +0000 (0:00:00.674)       0:00:28.619 *****
2026-09-01 13:15:31.262247 | instance | ok: [instance]
2026-09-01 13:15:31.262366 | instance |
2026-09-01 13:15:31.262731 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-01 13:15:31.262809 | instance | Tuesday 01 September 2026  13:15:31 +0000 (0:00:00.212)       0:00:28.832 *****
2026-09-01 13:15:31.281825 | instance | skipping: [instance]
2026-09-01 13:15:31.281924 | instance |
2026-09-01 13:15:31.282272 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-01 13:15:31.282328 | instance | Tuesday 01 September 2026  13:15:31 +0000 (0:00:00.020)       0:00:28.853 *****
2026-09-01 13:15:31.857054 | instance | changed: [instance] => (item=osd0)
2026-09-01 13:15:31.857132 | instance | changed: [instance] => (item=osd1)
2026-09-01 13:15:31.857724 | instance | changed: [instance] => (item=osd2)
2026-09-01 13:15:31.857864 | instance |
2026-09-01 13:15:31.857873 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-01 13:15:31.857879 | instance | Tuesday 01 September 2026  13:15:31 +0000 (0:00:00.575)       0:00:29.428 *****
2026-09-01 13:15:32.535761 | instance | changed: [instance] => (item=osd0)
2026-09-01 13:15:32.535861 | instance | changed: [instance] => (item=osd1)
2026-09-01 13:15:32.535873 | instance | changed: [instance] => (item=osd2)
2026-09-01 13:15:32.535883 | instance |
2026-09-01 13:15:32.535893 | instance | TASK [Start loop devices] ******************************************************
2026-09-01 13:15:32.535903 | instance | Tuesday 01 September 2026  13:15:32 +0000 (0:00:00.676)       0:00:30.105 *****
2026-09-01 13:15:33.232086 | instance | changed: [instance] => (item=osd0)
2026-09-01 13:15:33.233042 | instance | changed: [instance] => (item=osd1)
2026-09-01 13:15:33.233093 | instance | changed: [instance] => (item=osd2)
2026-09-01 13:15:33.233103 | instance |
2026-09-01 13:15:33.233112 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-01 13:15:33.233120 | instance | Tuesday 01 September 2026  13:15:33 +0000 (0:00:00.697)       0:00:30.802 *****
2026-09-01 13:15:36.543723 | instance | changed: [instance] => (item=osd0)
2026-09-01 13:15:36.543830 | instance | changed: [instance] => (item=osd1)
2026-09-01 13:15:36.544102 | instance | changed: [instance] => (item=osd2)
2026-09-01 13:15:36.544132 | instance |
2026-09-01 13:15:36.544374 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-01 13:15:36.544446 | instance | Tuesday 01 September 2026  13:15:36 +0000 (0:00:03.312)       0:00:34.114 *****
2026-09-01 13:15:38.522709 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-01 13:15:38.523538 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-01 13:15:38.523600 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-01 13:15:38.524186 | instance |
2026-09-01 13:15:38.524294 | instance | PLAY RECAP *********************************************************************
2026-09-01 13:15:38.528141 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-01 13:15:38.528182 | instance |
2026-09-01 13:15:38.528198 | instance | Tuesday 01 September 2026  13:15:38 +0000 (0:00:01.978)       0:00:36.093 *****
2026-09-01 13:15:38.528211 | instance | ===============================================================================
2026-09-01 13:15:38.528223 | instance | Install depedencies ---------------------------------------------------- 22.97s
2026-09-01 13:15:38.528236 | instance | Create a volume group for each loop device ------------------------------ 3.31s
2026-09-01 13:15:38.528249 | instance | Create a logical volume for each loop device ---------------------------- 1.98s
2026-09-01 13:15:38.528263 | instance | Gathering Facts --------------------------------------------------------- 1.38s
2026-09-01 13:15:38.528276 | instance | Purge "snapd" package --------------------------------------------------- 0.86s
2026-09-01 13:15:38.528288 | instance | Configure short hostname ------------------------------------------------ 0.77s
2026-09-01 13:15:38.528297 | instance | Gathering Facts --------------------------------------------------------- 0.75s
2026-09-01 13:15:38.528380 | instance | Start loop devices ------------------------------------------------------ 0.70s
2026-09-01 13:15:38.528849 | instance | Set permissions on loopback devices ------------------------------------- 0.68s
2026-09-01 13:15:38.529242 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.67s
2026-09-01 13:15:38.529681 | instance | Start up service -------------------------------------------------------- 0.61s
2026-09-01 13:15:38.530077 | instance | Create devices for Ceph ------------------------------------------------- 0.58s
2026-09-01 13:15:38.530931 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s
2026-09-01 13:15:38.531370 | instance | Ensure hostname inside hosts file --------------------------------------- 0.29s
2026-09-01 13:15:38.531614 | instance | Get list of all loopback devices ---------------------------------------- 0.21s
2026-09-01 13:15:38.531825 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-09-01 13:15:38.663370 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-01 13:15:38.678791 | instance | INFO     [csi > converge] Executing
2026-09-01 13:15:40.416969 | instance |
2026-09-01 13:15:40.417271 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-01 13:15:40.417470 | instance |
2026-09-01 13:15:40.417690 | instance | TASK [Gathering Facts] *********************************************************
2026-09-01 13:15:40.417894 | instance | Tuesday 01 September 2026  13:15:40 +0000 (0:00:00.009)       0:00:00.009 *****
2026-09-01 13:15:41.535406 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-01 13:15:41.535891 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-01 13:15:41.536274 | instance | interpreter could change the meaning of that path. See
2026-09-01 13:15:41.536675 | instance | https://docs.ansible.com/ansible-
2026-09-01 13:15:41.537045 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-01 13:15:41.545752 | instance | ok: [instance]
2026-09-01 13:15:41.546091 | instance |
2026-09-01 13:15:41.546420 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-01 13:15:41.546807 | instance | Tuesday 01 September 2026  13:15:41 +0000 (0:00:01.129)       0:00:01.138 *****
2026-09-01 13:15:41.607432 | instance | ok: [instance] => {
2026-09-01 13:15:41.607841 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-01 13:15:41.608178 | instance | }
2026-09-01 13:15:41.608464 | instance |
2026-09-01 13:15:41.608784 | instance | PLAY [all] *********************************************************************
2026-09-01 13:15:41.609093 | instance |
2026-09-01 13:15:41.609385 | instance | TASK [Gathering Facts] *********************************************************
2026-09-01 13:15:41.609771 | instance | Tuesday 01 September 2026  13:15:41 +0000 (0:00:00.061)       0:00:01.200 *****
2026-09-01 13:15:42.531106 | instance | ok: [instance]
2026-09-01 13:15:42.531375 | instance |
2026-09-01 13:15:42.531594 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-09-01 13:15:42.531792 | instance | Tuesday 01 September 2026  13:15:42 +0000 (0:00:00.923)       0:00:02.123 *****
2026-09-01 13:15:42.567976 | instance | skipping: [instance]
2026-09-01 13:15:42.568434 | instance |
2026-09-01 13:15:42.568829 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-01 13:15:42.569159 | instance | Tuesday 01 September 2026  13:15:42 +0000 (0:00:00.037)       0:00:02.160 *****
2026-09-01 13:15:42.760720 | instance | ok: [instance]
2026-09-01 13:15:42.760987 | instance |
2026-09-01 13:15:42.761217 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-01 13:15:42.761418 | instance |
2026-09-01 13:15:42.761609 | instance | TASK [Gathering Facts] *********************************************************
2026-09-01 13:15:42.761795 | instance | Tuesday 01 September 2026  13:15:42 +0000 (0:00:00.193)       0:00:02.354 *****
2026-09-01 13:15:43.712699 | instance | ok: [instance]
2026-09-01 13:15:43.712951 | instance |
2026-09-01 13:15:43.713174 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-01 13:15:43.713371 | instance | Tuesday 01 September 2026  13:15:43 +0000 (0:00:00.950)       0:00:03.305 *****
2026-09-01 13:15:44.064085 | instance | ok: [instance]
2026-09-01 13:15:44.064259 | instance |
2026-09-01 13:15:44.064412 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-01 13:15:44.064568 | instance | Tuesday 01 September 2026  13:15:44 +0000 (0:00:00.350)       0:00:03.655 *****
2026-09-01 13:15:44.101217 | instance | skipping: [instance]
2026-09-01 13:15:44.101252 | instance |
2026-09-01 13:15:44.101257 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-01 13:15:44.101262 | instance | Tuesday 01 September 2026  13:15:44 +0000 (0:00:00.039)       0:00:03.694 *****
2026-09-01 13:15:44.418250 | instance | changed: [instance]
2026-09-01 13:15:44.418342 | instance |
2026-09-01 13:15:44.418647 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-01 13:15:44.418665 | instance | Tuesday 01 September 2026  13:15:44 +0000 (0:00:00.317)       0:00:04.011 *****
2026-09-01 13:15:44.521870 | instance | ok: [instance] => {
2026-09-01 13:15:44.522659 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-01 13:15:44.522701 | instance | }
2026-09-01 13:15:44.522709 | instance |
2026-09-01 13:15:44.522715 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-01 13:15:44.522722 | instance | Tuesday 01 September 2026  13:15:44 +0000 (0:00:00.103)       0:00:04.115 *****
2026-09-01 13:15:45.440646 | instance | changed: [instance]
2026-09-01 13:15:45.440765 | instance |
2026-09-01 13:15:45.441089 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-01 13:15:45.441154 | instance | Tuesday 01 September 2026  13:15:45 +0000 (0:00:00.918)       0:00:05.033 *****
2026-09-01 13:15:45.494631 | instance | skipping: [instance]
2026-09-01 13:15:45.494696 | instance |
2026-09-01 13:15:45.494939 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-01 13:15:45.495001 | instance | Tuesday 01 September 2026  13:15:45 +0000 (0:00:00.054)       0:00:05.087 *****
2026-09-01 13:15:45.556999 | instance | skipping: [instance]
2026-09-01 13:15:45.557091 | instance |
2026-09-01 13:15:45.557390 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-01 13:15:45.557440 | instance | Tuesday 01 September 2026  13:15:45 +0000 (0:00:00.062)       0:00:05.150 *****
2026-09-01 13:15:45.816676 | instance | ok: [instance]
2026-09-01 13:15:45.816885 | instance |
2026-09-01 13:15:45.817246 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-01 13:15:45.817523 | instance | Tuesday 01 September 2026  13:15:45 +0000 (0:00:00.259)       0:00:05.409 *****
2026-09-01 13:15:47.391650 | instance | ok: [instance]
2026-09-01 13:15:47.391714 | instance |
2026-09-01 13:15:47.391721 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-01 13:15:47.391742 | instance | Tuesday 01 September 2026  13:15:47 +0000 (0:00:01.574)       0:00:06.984 *****
2026-09-01 13:15:47.473929 | instance | ok: [instance] => {
2026-09-01 13:15:47.473992 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-01 13:15:47.473999 | instance | }
2026-09-01 13:15:47.474003 | instance |
2026-09-01 13:15:47.474008 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-01 13:15:47.474013 | instance | Tuesday 01 September 2026  13:15:47 +0000 (0:00:00.082)       0:00:07.066 *****
2026-09-01 13:15:48.258437 | instance | changed: [instance]
2026-09-01 13:15:48.258558 | instance |
2026-09-01 13:15:48.259281 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-01 13:15:48.259375 | instance | Tuesday 01 September 2026  13:15:48 +0000 (0:00:00.783)       0:00:07.850 *****
2026-09-01 13:15:51.239297 | instance | changed: [instance]
2026-09-01 13:15:51.239398 | instance |
2026-09-01 13:15:51.239759 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-01 13:15:51.239807 | instance | Tuesday 01 September 2026  13:15:51 +0000 (0:00:02.981)       0:00:10.832 *****
2026-09-01 13:15:51.274615 | instance | skipping: [instance]
2026-09-01 13:15:51.275752 | instance |
2026-09-01 13:15:51.275800 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-01 13:15:51.275814 | instance | Tuesday 01 September 2026  13:15:51 +0000 (0:00:00.035)       0:00:10.867 *****
2026-09-01 13:15:51.312911 | instance | skipping: [instance]
2026-09-01 13:15:51.313652 | instance |
2026-09-01 13:15:51.313684 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-01 13:15:51.313696 | instance | Tuesday 01 September 2026  13:15:51 +0000 (0:00:00.038)       0:00:10.905 *****
2026-09-01 13:15:51.335268 | instance | skipping: [instance]
2026-09-01 13:15:51.335377 | instance |
2026-09-01 13:15:51.335568 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-01 13:15:51.335736 | instance | Tuesday 01 September 2026  13:15:51 +0000 (0:00:00.023)       0:00:10.928 *****
2026-09-01 13:15:56.715675 | instance | changed: [instance]
2026-09-01 13:15:56.715933 | instance |
2026-09-01 13:15:56.716411 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-01 13:15:56.716799 | instance | Tuesday 01 September 2026  13:15:56 +0000 (0:00:05.379)       0:00:16.308 *****
2026-09-01 13:15:57.358134 | instance | changed: [instance]
2026-09-01 13:15:57.358344 | instance |
2026-09-01 13:15:57.358624 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-01 13:15:57.358970 | instance | Tuesday 01 September 2026  13:15:57 +0000 (0:00:00.642)       0:00:16.951 *****
2026-09-01 13:15:58.358582 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-01 13:15:58.358800 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-01 13:15:58.359057 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-01 13:15:58.359296 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-01 13:15:58.359518 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-01 13:15:58.359729 | instance |
2026-09-01 13:15:58.359969 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-01 13:15:58.360236 | instance | Tuesday 01 September 2026  13:15:58 +0000 (0:00:01.000)       0:00:17.951 *****
2026-09-01 13:15:59.036412 | instance | changed: [instance]
2026-09-01 13:15:59.036644 | instance |
2026-09-01 13:15:59.036895 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-01 13:15:59.037188 | instance | Tuesday 01 September 2026  13:15:59 +0000 (0:00:00.647)       0:00:18.599 *****
2026-09-01 13:15:59.037439 | instance |
2026-09-01 13:15:59.037667 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-01 13:15:59.037978 | instance | Tuesday 01 September 2026  13:15:59 +0000 (0:00:00.029)       0:00:18.629 *****
2026-09-01 13:15:59.971692 | instance | ok: [instance]
2026-09-01 13:15:59.971734 | instance |
2026-09-01 13:15:59.971751 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-01 13:15:59.971756 | instance | Tuesday 01 September 2026  13:15:59 +0000 (0:00:00.936)       0:00:19.565 *****
2026-09-01 13:16:00.401210 | instance | changed: [instance]
2026-09-01 13:16:00.401345 | instance |
2026-09-01 13:16:00.401509 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-01 13:16:00.401661 | instance | Tuesday 01 September 2026  13:16:00 +0000 (0:00:00.429)       0:00:19.994 *****
2026-09-01 13:16:00.992008 | instance | changed: [instance]
2026-09-01 13:16:00.992091 | instance |
2026-09-01 13:16:00.992110 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-01 13:16:00.992119 | instance | Tuesday 01 September 2026  13:16:00 +0000 (0:00:00.589)       0:00:20.584 *****
2026-09-01 13:16:01.217517 | instance | ok: [instance]
2026-09-01 13:16:01.218285 | instance |
2026-09-01 13:16:01.218513 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-01 13:16:01.218522 | instance | Tuesday 01 September 2026  13:16:01 +0000 (0:00:00.225)       0:00:20.810 *****
2026-09-01 13:16:01.286279 | instance | ok: [instance] => {
2026-09-01 13:16:01.287285 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-01 13:16:01.287331 | instance | }
2026-09-01 13:16:01.287339 | instance |
2026-09-01 13:16:01.287345 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-01 13:16:01.287353 | instance | Tuesday 01 September 2026  13:16:01 +0000 (0:00:00.068)       0:00:20.879 *****
2026-09-01 13:16:03.050853 | instance | changed: [instance]
2026-09-01 13:16:03.050968 | instance |
2026-09-01 13:16:03.051387 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-01 13:16:03.051450 | instance | Tuesday 01 September 2026  13:16:03 +0000 (0:00:01.765)       0:00:22.644 *****
2026-09-01 13:16:08.447767 | instance | changed: [instance]
2026-09-01 13:16:08.447906 | instance |
2026-09-01 13:16:08.447979 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-01 13:16:08.448262 | instance | Tuesday 01 September 2026  13:16:08 +0000 (0:00:05.396)       0:00:28.041 *****
2026-09-01 13:16:09.767970 | instance | ok: [instance]
2026-09-01 13:16:09.768793 | instance |
2026-09-01 13:16:09.768854 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-01 13:16:09.768866 | instance | Tuesday 01 September 2026  13:16:09 +0000 (0:00:01.319)       0:00:29.360 *****
2026-09-01 13:16:10.113490 | instance | changed: [instance]
2026-09-01 13:16:10.113581 | instance |
2026-09-01 13:16:10.113834 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-01 13:16:10.113889 | instance | Tuesday 01 September 2026  13:16:10 +0000 (0:00:00.346)       0:00:29.706 *****
2026-09-01 13:16:10.595016 | instance | changed: [instance]
2026-09-01 13:16:10.595797 | instance |
2026-09-01 13:16:10.596011 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-01 13:16:10.596023 | instance | Tuesday 01 September 2026  13:16:10 +0000 (0:00:00.481)       0:00:30.188 *****
2026-09-01 13:16:11.241116 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-01 13:16:11.241203 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-01 13:16:11.241671 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-01 13:16:11.241715 | instance |
2026-09-01 13:16:11.241721 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-01 13:16:11.241726 | instance | Tuesday 01 September 2026  13:16:11 +0000 (0:00:00.646)       0:00:30.834 *****
2026-09-01 13:16:11.721712 | instance | changed: [instance]
2026-09-01 13:16:11.722430 | instance |
2026-09-01 13:16:11.722483 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-01 13:16:11.722495 | instance | Tuesday 01 September 2026  13:16:11 +0000 (0:00:00.479)       0:00:31.314 *****
2026-09-01 13:16:12.223278 | instance | changed: [instance]
2026-09-01 13:16:12.223370 | instance |
2026-09-01 13:16:12.224178 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-01 13:16:12.224251 | instance | Tuesday 01 September 2026  13:16:12 +0000 (0:00:00.474)       0:00:31.788 *****
2026-09-01 13:16:12.224300 | instance |
2026-09-01 13:16:12.224316 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-01 13:16:12.224343 | instance | Tuesday 01 September 2026  13:16:12 +0000 (0:00:00.027)       0:00:31.816 *****
2026-09-01 13:16:12.991931 | instance | ok: [instance]
2026-09-01 13:16:12.992732 | instance |
2026-09-01 13:16:12.992767 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-01 13:16:12.992779 | instance | Tuesday 01 September 2026  13:16:12 +0000 (0:00:00.768)       0:00:32.584 *****
2026-09-01 13:16:14.085632 | instance | changed: [instance]
2026-09-01 13:16:14.085716 | instance |
2026-09-01 13:16:14.086123 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-01 13:16:14.086203 | instance | Tuesday 01 September 2026  13:16:14 +0000 (0:00:01.094)       0:00:33.678 *****
2026-09-01 13:16:14.687442 | instance | changed: [instance]
2026-09-01 13:16:14.687520 | instance |
2026-09-01 13:16:14.687815 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-01 13:16:14.687846 | instance | Tuesday 01 September 2026  13:16:14 +0000 (0:00:00.602)       0:00:34.281 *****
2026-09-01 13:16:14.759745 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-01 13:16:14.760141 | instance |
2026-09-01 13:16:14.760214 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-01 13:16:14.760433 | instance | Tuesday 01 September 2026  13:16:14 +0000 (0:00:00.071)       0:00:34.352 *****
2026-09-01 13:16:20.281692 | instance | changed: [instance]
2026-09-01 13:16:20.281746 | instance |
2026-09-01 13:16:20.281755 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-01 13:16:20.281761 | instance | Tuesday 01 September 2026  13:16:20 +0000 (0:00:05.521)       0:00:39.874 *****
2026-09-01 13:16:20.933657 | instance | ok: [instance] => (item=chronyd)
2026-09-01 13:16:20.933718 | instance | ok: [instance] => (item=sshd)
2026-09-01 13:16:20.933731 | instance |
2026-09-01 13:16:20.933741 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-01 13:16:20.933752 | instance | Tuesday 01 September 2026  13:16:20 +0000 (0:00:00.651)       0:00:40.525 *****
2026-09-01 13:16:21.291365 | instance | changed: [instance]
2026-09-01 13:16:21.291415 | instance |
2026-09-01 13:16:21.291425 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-01 13:16:21.291433 | instance | Tuesday 01 September 2026  13:16:21 +0000 (0:00:00.358)       0:00:40.884 *****
2026-09-01 13:16:21.508181 | instance | ok: [instance]
2026-09-01 13:16:21.508255 | instance |
2026-09-01 13:16:21.508345 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-01 13:16:21.508454 | instance | Tuesday 01 September 2026  13:16:21 +0000 (0:00:00.217)       0:00:41.101 *****
2026-09-01 13:16:22.080479 | instance | changed: [instance]
2026-09-01 13:16:22.080740 | instance |
2026-09-01 13:16:22.081064 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-01 13:16:22.081362 | instance | Tuesday 01 September 2026  13:16:22 +0000 (0:00:00.571)       0:00:41.673 *****
2026-09-01 13:16:22.522660 | instance | changed: [instance]
2026-09-01 13:16:22.522713 | instance |
2026-09-01 13:16:22.522721 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-01 13:16:22.522728 | instance | Tuesday 01 September 2026  13:16:22 +0000 (0:00:00.442)       0:00:42.115 *****
2026-09-01 13:16:22.787969 | instance | ok: [instance]
2026-09-01 13:16:22.788082 | instance |
2026-09-01 13:16:22.788487 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-01 13:16:22.788537 | instance | Tuesday 01 September 2026  13:16:22 +0000 (0:00:00.265)       0:00:42.381 *****
2026-09-01 13:16:23.035330 | instance | ok: [instance] => (item=instance)
2026-09-01 13:16:23.036172 | instance |
2026-09-01 13:16:23.036339 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-01 13:16:23.036346 | instance | Tuesday 01 September 2026  13:16:23 +0000 (0:00:00.246)       0:00:42.627 *****
2026-09-01 13:16:23.087810 | instance | ok: [instance]
2026-09-01 13:16:23.087864 | instance |
2026-09-01 13:16:23.088277 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-01 13:16:23.088350 | instance | Tuesday 01 September 2026  13:16:23 +0000 (0:00:00.053)       0:00:42.681 *****
2026-09-01 13:16:23.182273 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-01 13:16:23.182337 | instance |
2026-09-01 13:16:23.182707 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-01 13:16:23.182748 | instance | Tuesday 01 September 2026  13:16:23 +0000 (0:00:00.094)       0:00:42.775 *****
2026-09-01 13:16:23.487822 | instance | changed: [instance]
2026-09-01 13:16:23.487898 | instance |
2026-09-01 13:16:23.488168 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-01 13:16:23.488237 | instance | Tuesday 01 September 2026  13:16:23 +0000 (0:00:00.305)       0:00:43.081 *****
2026-09-01 13:16:24.253200 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-01 13:16:24.253306 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-01 13:16:24.253811 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-01 13:16:24.253855 | instance |
2026-09-01 13:16:24.253861 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-01 13:16:24.253867 | instance | Tuesday 01 September 2026  13:16:24 +0000 (0:00:00.765)       0:00:43.846 *****
2026-09-01 13:17:47.610121 | instance | ok: [instance]
2026-09-01 13:17:47.610202 | instance |
2026-09-01 13:17:47.610219 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-01 13:17:47.610233 | instance | Tuesday 01 September 2026  13:17:47 +0000 (0:01:23.354)       0:02:07.201 *****
2026-09-01 13:17:47.854702 | instance | changed: [instance]
2026-09-01 13:17:47.854805 | instance |
2026-09-01 13:17:47.855001 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-01 13:17:47.855217 | instance | Tuesday 01 September 2026  13:17:47 +0000 (0:00:00.246)       0:02:07.448 *****
2026-09-01 13:17:47.899026 | instance | ok: [instance]
2026-09-01 13:17:47.899546 | instance |
2026-09-01 13:17:47.899585 | instance | TASK [Install Ceph host] *******************************************************
2026-09-01 13:17:47.899594 | instance | Tuesday 01 September 2026  13:17:47 +0000 (0:00:00.044)       0:02:07.492 *****
2026-09-01 13:17:47.971326 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-01 13:17:47.971397 | instance |
2026-09-01 13:17:47.971635 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-01 13:17:47.971673 | instance | Tuesday 01 September 2026  13:17:47 +0000 (0:00:00.072)       0:02:07.565 *****
2026-09-01 13:17:49.556661 | instance | ok: [instance]
2026-09-01 13:17:49.556734 | instance |
2026-09-01 13:17:49.556864 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-01 13:17:49.556963 | instance | Tuesday 01 September 2026  13:17:49 +0000 (0:00:01.584)       0:02:09.149 *****
2026-09-01 13:17:49.634705 | instance | ok: [instance] => (item=instance)
2026-09-01 13:17:49.634777 | instance |
2026-09-01 13:17:49.634947 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-01 13:17:49.635172 | instance | Tuesday 01 September 2026  13:17:49 +0000 (0:00:00.077)       0:02:09.227 *****
2026-09-01 13:17:50.025529 | instance | ok: [instance]
2026-09-01 13:17:50.025613 | instance |
2026-09-01 13:17:50.025947 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-01 13:17:50.026028 | instance | Tuesday 01 September 2026  13:17:50 +0000 (0:00:00.391)       0:02:09.618 *****
2026-09-01 13:17:52.370910 | instance | ok: [instance]
2026-09-01 13:17:52.371039 | instance |
2026-09-01 13:17:52.371050 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-01 13:17:52.371202 | instance | Tuesday 01 September 2026  13:17:52 +0000 (0:00:02.344)       0:02:11.964 *****
2026-09-01 13:18:36.726993 | 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-01 13:18:36.727834 | 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_qv6bpnhm/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_qv6bpnhm/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_qv6bpnhm/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_qv6bpnhm/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-01T13:18:36.538+0000 7f9beccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBR0JZqDVy3HCAAqwVrHB7ue4MRqv9u9BIhJSK47JpHWDX/D+sFPkZXBfk=: Malformed input [buffer:3]\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBR0JZqDVy3HCAAqwVrHB7ue4MRqv9u9BIhJSK47JpHWDX/D+sFPkZXBfk=: Malformed input [buffer:3]\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBR0JZqDVy3HCAAqwVrHB7ue4MRqv9u9BIhJSK47JpHWDX/D+sFPkZXBfk=: Malformed input [buffer:3]\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-01T13:18:36.538+0000 7f9beccd7640 -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-01 13:18:36.730696 | instance |
2026-09-01 13:18:36.733970 | instance | PLAY RECAP *********************************************************************
2026-09-01 13:18:36.734023 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-09-01 13:18:36.734030 | instance |
2026-09-01 13:18:36.734036 | instance | Tuesday 01 September 2026  13:18:36 +0000 (0:00:44.360)       0:02:56.324 *****
2026-09-01 13:18:36.734041 | instance | ===============================================================================
2026-09-01 13:18:36.734046 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 83.35s
2026-09-01 13:18:36.734051 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 44.36s
2026-09-01 13:18:36.734057 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.52s
2026-09-01 13:18:36.734062 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 5.40s
2026-09-01 13:18:36.734068 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.38s
2026-09-01 13:18:36.734074 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.98s
2026-09-01 13:18:36.734112 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.35s
2026-09-01 13:18:36.734118 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.77s
2026-09-01 13:18:36.734124 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.70s
2026-09-01 13:18:36.734129 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.58s
2026-09-01 13:18:36.734134 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.57s
2026-09-01 13:18:36.734139 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.32s
2026-09-01 13:18:36.734144 | instance | Gathering Facts --------------------------------------------------------- 1.13s
2026-09-01 13:18:36.734149 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.09s
2026-09-01 13:18:36.734154 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.00s
2026-09-01 13:18:36.734159 | instance | Gathering Facts --------------------------------------------------------- 0.95s
2026-09-01 13:18:36.734164 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-09-01 13:18:36.734169 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.92s
2026-09-01 13:18:36.734174 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.78s
2026-09-01 13:18:36.734179 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.77s
2026-09-01 13:18:36.849951 | 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-01 13:18:36.850261 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-01 13:18:36.850439 | 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-01 13:18:37.300069 | instance | ERROR
2026-09-01 13:18:37.300294 | instance | {
2026-09-01 13:18:37.300324 | instance |   "delta": "0:03:49.645907",
2026-09-01 13:18:37.300345 | instance |   "end": "2026-09-01 13:18:36.918898",
2026-09-01 13:18:37.300364 | instance |   "msg": "non-zero return code",
2026-09-01 13:18:37.300382 | instance |   "rc": 2,
2026-09-01 13:18:37.300400 | instance |   "start": "2026-09-01 13:14:47.272991"
2026-09-01 13:18:37.300420 | instance | }
failure
2026-09-01 13:18:37.307910 | 
2026-09-01 13:18:37.308009 | PLAY RECAP
2026-09-01 13:18:37.308066 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-01 13:18:37.308090 | 
2026-09-01 13:18:37.469475 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-01 13:18:37.471935 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-01 13:18:38.168258 | 
2026-09-01 13:18:38.168780 | PLAY [all]
2026-09-01 13:18:38.183507 | 
2026-09-01 13:18:38.183583 | TASK [gather-host-logs : creating directory for system status]
2026-09-01 13:18:38.573268 | instance | changed
2026-09-01 13:18:38.580065 | 
2026-09-01 13:18:38.580152 | TASK [gather-host-logs : Get logs for each host]
2026-09-01 13:18:38.950288 | instance | + systemd-cgls --full --all --no-pager
2026-09-01 13:18:38.965274 | instance | + ip addr
2026-09-01 13:18:38.968474 | instance | + ip route
2026-09-01 13:18:38.970801 | instance | + lsblk
2026-09-01 13:18:38.977414 | instance | + mount
2026-09-01 13:18:38.980423 | instance | + docker images
2026-09-01 13:18:39.010013 | instance | + brctl show
2026-09-01 13:18:39.010729 | instance | /bin/bash: line 8: brctl: command not found
2026-09-01 13:18:39.011027 | instance | + ps aux --sort=-%mem
2026-09-01 13:18:39.033386 | instance | + dpkg -l
2026-09-01 13:18:39.043624 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-01 13:18:39.044475 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-01 13:18:39.065417 | instance | + '[' '!' -z '' ']'
2026-09-01 13:18:39.117835 | instance | ok: Runtime: 0:00:00.119617
2026-09-01 13:18:39.126164 | 
2026-09-01 13:18:39.126231 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-01 13:18:39.790653 | instance | changed:
2026-09-01 13:18:39.790885 | instance | created directory /var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/logs/instance
2026-09-01 13:18:39.790927 | instance | cd+++++++++ system/
2026-09-01 13:18:39.790960 | instance | >f+++++++++ system/brctl-show.txt
2026-09-01 13:18:39.790991 | instance | >f+++++++++ system/docker-images.txt
2026-09-01 13:18:39.791020 | instance | >f+++++++++ system/ip-addr.txt
2026-09-01 13:18:39.791053 | instance | >f+++++++++ system/ip-route.txt
2026-09-01 13:18:39.791085 | instance | >f+++++++++ system/lsblk.txt
2026-09-01 13:18:39.791116 | instance | >f+++++++++ system/mount.txt
2026-09-01 13:18:39.791145 | instance | >f+++++++++ system/packages.txt
2026-09-01 13:18:39.791174 | instance | >f+++++++++ system/ps.txt
2026-09-01 13:18:39.791206 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-01 13:18:39.801016 | 
2026-09-01 13:18:39.801095 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-01 13:18:40.020416 | instance | changed: "values"
2026-09-01 13:18:40.184501 | instance | changed: "releases"
2026-09-01 13:18:40.197277 | 
2026-09-01 13:18:40.197501 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-01 13:18:40.424788 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-01 13:18:40.741051 | instance | ok: Runtime: 0:00:00.004972
2026-09-01 13:18:40.747834 | 
2026-09-01 13:18:40.747906 | TASK [helm-release-status : Downloads logs to executor]
2026-09-01 13:18:41.211842 | instance | changed:
2026-09-01 13:18:41.212021 | instance | cd+++++++++ helm/
2026-09-01 13:18:41.212049 | instance | cd+++++++++ helm/releases/
2026-09-01 13:18:41.212072 | instance | cd+++++++++ helm/values/
2026-09-01 13:18:41.220715 | 
2026-09-01 13:18:41.220780 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-01 13:18:41.437869 | instance | changed
2026-09-01 13:18:41.444302 | 
2026-09-01 13:18:41.444381 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-01 13:18:41.696135 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-01 13:18:41.696928 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-01 13:18:41.704027 | instance | environment: line 1: kubectl: command not found
2026-09-01 13:18:41.704667 | instance | environment: line 1: kubectl: command not found
2026-09-01 13:18:41.705025 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-01 13:18:41.706356 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-01 13:18:41.706996 | instance | environment: line 1: kubectl: command not found
2026-09-01 13:18:41.708764 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-01 13:18:41.710233 | instance | environment: line 1: kubectl: command not found
2026-09-01 13:18:41.711237 | instance | environment: line 1: kubectl: command not found
2026-09-01 13:18:41.711662 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-01 13:18:41.711977 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-01 13:18:41.981761 | instance | ok: Runtime: 0:00:00.023090
2026-09-01 13:18:41.987868 | 
2026-09-01 13:18:41.987938 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-01 13:18:42.196094 | instance | changed
2026-09-01 13:18:42.201322 | 
2026-09-01 13:18:42.201399 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-01 13:18:42.428334 | instance | environment: line 5: kubectl: command not found
2026-09-01 13:18:42.428927 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-01 13:18:42.429468 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-01 13:18:42.431208 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-01 13:18:42.738989 | instance | ok: Runtime: 0:00:00.007464
2026-09-01 13:18:42.744615 | 
2026-09-01 13:18:42.744683 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-01 13:18:43.225344 | instance | changed:
2026-09-01 13:18:43.225582 | instance | cd+++++++++ objects/
2026-09-01 13:18:43.225620 | instance | cd+++++++++ objects/cluster/
2026-09-01 13:18:43.225652 | instance | cd+++++++++ objects/namespaced/
2026-09-01 13:18:43.237041 | 
2026-09-01 13:18:43.237106 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-01 13:18:43.451715 | instance | changed
2026-09-01 13:18:43.457901 | 
2026-09-01 13:18:43.457964 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-01 13:18:43.675061 | instance | changed
2026-09-01 13:18:43.680534 | 
2026-09-01 13:18:43.680609 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-01 13:18:43.905824 | instance | environment: line 3: kubectl: command not found
2026-09-01 13:18:44.214515 | instance | ok: Runtime: 0:00:00.006490
2026-09-01 13:18:44.221060 | 
2026-09-01 13:18:44.221125 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-01 13:18:44.763227 | instance | changed:
2026-09-01 13:18:44.763466 | instance | cd+++++++++ pod-logs/
2026-09-01 13:18:44.763518 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-01 13:18:44.773280 | 
2026-09-01 13:18:44.773342 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-01 13:18:44.948231 | instance | changed
2026-09-01 13:18:44.953160 | 
2026-09-01 13:18:44.953227 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-01 13:18:45.142319 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-01 13:18:45.487873 | instance | ok: Runtime: 0:00:00.050722
2026-09-01 13:18:45.492924 | 
2026-09-01 13:18:45.493025 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-01 13:18:45.714421 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-01 13:18:45.762363 | instance | ceph-mgr endpoints:
2026-09-01 13:18:46.040797 | instance | ok: Runtime: 0:00:00.053272
2026-09-01 13:18:46.046331 | 
2026-09-01 13:18:46.046401 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-01 13:18:46.280684 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-01 13:18:46.590545 | instance | ok: Runtime: 0:00:00.027400
2026-09-01 13:18:46.598259 | 
2026-09-01 13:18:46.598352 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-01 13:18:47.102473 | instance | changed: cd+++++++++ prometheus/
2026-09-01 13:18:47.113008 | 
2026-09-01 13:18:47.113077 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-01 13:18:47.344329 | instance | changed
2026-09-01 13:18:47.349221 | 
2026-09-01 13:18:47.349290 | TASK [gather-selenium-data : Get selenium data]
2026-09-01 13:18:47.630389 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-01 13:18:47.631825 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-01 13:18:47.885427 | instance | ERROR
2026-09-01 13:18:47.885647 | instance | {
2026-09-01 13:18:47.885677 | instance |   "delta": "0:00:00.006066",
2026-09-01 13:18:47.885699 | instance |   "end": "2026-09-01 13:18:47.632227",
2026-09-01 13:18:47.885720 | instance |   "msg": "non-zero return code",
2026-09-01 13:18:47.885739 | instance |   "rc": 1,
2026-09-01 13:18:47.885757 | instance |   "start": "2026-09-01 13:18:47.626161"
2026-09-01 13:18:47.885774 | instance | }
2026-09-01 13:18:47.885798 | instance | ERROR: Ignoring Errors
2026-09-01 13:18:47.890801 | 
2026-09-01 13:18:47.890870 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-01 13:18:48.412012 | instance | changed: cd+++++++++ selenium/
2026-09-01 13:18:48.418877 | 
2026-09-01 13:18:48.418935 | PLAY RECAP
2026-09-01 13:18:48.418990 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-01 13:18:48.419013 | 
2026-09-01 13:18:48.567656 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-01 13:18:48.572253 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-01 13:18:49.154597 | 
2026-09-01 13:18:49.154729 | PLAY [all]
2026-09-01 13:18:49.166243 | 
2026-09-01 13:18:49.166320 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-01 13:18:49.210975 | instance | skipping: Conditional result was False
2026-09-01 13:18:49.221401 | 
2026-09-01 13:18:49.221481 | TASK [fetch-output : Set log path for single node]
2026-09-01 13:18:49.264518 | instance | ok
2026-09-01 13:18:49.270381 | 
2026-09-01 13:18:49.270450 | LOOP [fetch-output : Ensure local output dirs]
2026-09-01 13:18:49.643371 | instance -> localhost | ok: "/var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/logs"
2026-09-01 13:18:49.848087 | instance -> localhost | changed: "/var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/artifacts"
2026-09-01 13:18:50.052206 | instance -> localhost | changed: "/var/lib/zuul/builds/f5331012077240b5bd4a6bdbc65341e3/work/docs"
2026-09-01 13:18:50.066299 | 
2026-09-01 13:18:50.066449 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-01 13:18:51.799699 | instance | changed: .d..t...... ./
2026-09-01 13:18:51.799971 | instance | changed: All items complete
2026-09-01 13:18:51.800010 | 
2026-09-01 13:18:52.320878 | instance | changed: .d..t...... ./
2026-09-01 13:18:52.804077 | instance | changed: .d..t...... ./
2026-09-01 13:18:52.827906 | 
2026-09-01 13:18:52.828081 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-01 13:18:53.244663 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009650
2026-09-01 13:18:53.453956 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007383
2026-09-01 13:18:53.473648 | 
2026-09-01 13:18:53.473795 | PLAY [all]
2026-09-01 13:18:53.479803 | 
2026-09-01 13:18:53.479875 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-01 13:18:53.911486 | instance | changed
2026-09-01 13:18:53.922997 | 
2026-09-01 13:18:53.923128 | PLAY RECAP
2026-09-01 13:18:53.923183 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-01 13:18:53.923206 | 
2026-09-01 13:18:54.086478 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-01 13:18:54.090519 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-01 13:18:54.689963 | 
2026-09-01 13:18:54.690114 | PLAY [localhost]
2026-09-01 13:18:54.700286 | 
2026-09-01 13:18:54.700356 | TASK [Generate Zuul manifest]
2026-09-01 13:18:54.719361 | localhost | ok
2026-09-01 13:18:54.736409 | 
2026-09-01 13:18:54.736499 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-01 13:18:55.089276 | localhost | changed
2026-09-01 13:18:55.420873 | 
2026-09-01 13:18:55.421056 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-01 13:18:55.452044 | localhost | ok
2026-09-01 13:18:55.461120 | 
2026-09-01 13:18:55.461209 | TASK [Upload logs]
2026-09-01 13:18:55.481703 | localhost | ok
2026-09-01 13:18:55.579349 | 
2026-09-01 13:18:55.579449 | TASK [Set zuul-log-path fact]
2026-09-01 13:18:55.600101 | localhost | ok
2026-09-01 13:18:55.612432 | 
2026-09-01 13:18:55.612499 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-01 13:18:55.643902 | localhost | ok
2026-09-01 13:18:55.651903 | 
2026-09-01 13:18:55.651970 | TASK [upload-logs : Create log directories]
2026-09-01 13:18:56.059167 | localhost | changed
2026-09-01 13:18:56.065561 | 
2026-09-01 13:18:56.065659 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-01 13:18:56.462229 | localhost -> localhost | ok: Runtime: 0:00:00.005922
2026-09-01 13:18:56.468252 | 
2026-09-01 13:18:56.468320 | TASK [upload-logs : Upload logs to log server]
2026-09-01 13:18:56.915548 | localhost | Output suppressed because no_log was given
2026-09-01 13:18:56.954062 | 
2026-09-01 13:18:56.954220 | LOOP [upload-logs : Compress console log and json output]
2026-09-01 13:18:56.999377 | localhost | skipping: Conditional result was False
2026-09-01 13:18:57.006167 | localhost | skipping: Conditional result was False
2026-09-01 13:18:57.018232 | 
2026-09-01 13:18:57.018377 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-01 13:18:57.061396 | localhost | skipping: Conditional result was False
2026-09-01 13:18:57.061809 | 
2026-09-01 13:18:57.066015 | localhost | skipping: Conditional result was False
2026-09-01 13:18:57.082643 | 
2026-09-01 13:18:57.082825 | LOOP [upload-logs : Upload console log and json output]