2026-09-11 17:20:03.446175 | Job console starting
2026-09-11 17:20:03.457016 | Updating git repos
2026-09-11 17:20:07.223496 | Cloning repos into workspace
2026-09-11 17:20:27.081685 | Restoring repo states
2026-09-11 17:20:42.012859 | Merging changes
2026-09-11 17:20:43.207918 | Checking out repos
2026-09-11 17:20:44.800788 | Preparing playbooks
2026-09-11 17:20:47.019657 | Running Ansible setup
2026-09-11 17:20:50.938583 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:20:51.497117 | 
2026-09-11 17:20:51.497225 | PLAY [localhost]
2026-09-11 17:20:51.504027 | 
2026-09-11 17:20:51.504090 | TASK [Gathering Facts]
2026-09-11 17:20:53.416216 | localhost | ok
2026-09-11 17:20:53.422376 | 
2026-09-11 17:20:53.422454 | TASK [Setup log path fact]
2026-09-11 17:20:53.440793 | localhost | ok
2026-09-11 17:20:53.449831 | 
2026-09-11 17:20:53.449898 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:20:53.478852 | localhost | ok
2026-09-11 17:20:53.485966 | 
2026-09-11 17:20:53.486056 | TASK [emit-job-header : Print job information]
2026-09-11 17:20:53.536402 | # Job Information
2026-09-11 17:20:53.536688 | Ansible Version: 2.16.18
2026-09-11 17:20:53.536755 | Job: atmosphere-molecule-csi-rbd
2026-09-11 17:20:53.536820 | Pipeline: check
2026-09-11 17:20:53.536859 | Executor: 2d72f0692154
2026-09-11 17:20:53.536897 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-09-11 17:20:53.536940 | Event ID: 8473cd80-ae04-11f1-8f74-5d6bc7122c54
2026-09-11 17:20:53.542308 | 
2026-09-11 17:20:53.542628 | LOOP [emit-job-header : Print node information]
2026-09-11 17:20:53.653988 | localhost | ok:
2026-09-11 17:20:53.654334 | localhost | # Node Information
2026-09-11 17:20:53.654382 | localhost | Inventory Hostname: instance
2026-09-11 17:20:53.654414 | localhost | Hostname: np0000192607
2026-09-11 17:20:53.654442 | localhost | Username: zuul
2026-09-11 17:20:53.654469 | localhost | Distro: Ubuntu 22.04
2026-09-11 17:20:53.654567 | localhost | Provider: yul1
2026-09-11 17:20:53.654600 | localhost | Region: ca-ymq-1
2026-09-11 17:20:53.654656 | localhost | Label: ubuntu-jammy
2026-09-11 17:20:53.654707 | localhost | Product Name: OpenStack Nova
2026-09-11 17:20:53.654758 | localhost | Interface IP: 162.253.55.95
2026-09-11 17:20:53.672691 | 
2026-09-11 17:20:53.672909 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-11 17:20:54.084007 | localhost -> localhost | changed
2026-09-11 17:20:54.090554 | 
2026-09-11 17:20:54.090650 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-11 17:20:55.047409 | localhost -> localhost | changed
2026-09-11 17:20:55.082422 | 
2026-09-11 17:20:55.082610 | PLAY [all]
2026-09-11 17:20:55.100962 | 
2026-09-11 17:20:55.101243 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-11 17:20:55.344142 | instance -> localhost | ok
2026-09-11 17:20:55.349829 | 
2026-09-11 17:20:55.349896 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-11 17:20:55.385879 | instance | ok
2026-09-11 17:20:55.406296 | instance | included: /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-11 17:20:55.416563 | 
2026-09-11 17:20:55.416730 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-11 17:20:56.512850 | instance -> localhost | Generating public/private rsa key pair.
2026-09-11 17:20:56.513111 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/5c39cff44a51416d98eb4971f6d534c9_id_rsa
2026-09-11 17:20:56.513160 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/5c39cff44a51416d98eb4971f6d534c9_id_rsa.pub
2026-09-11 17:20:56.513198 | instance -> localhost | The key fingerprint is:
2026-09-11 17:20:56.513232 | instance -> localhost | SHA256:G7+lBFkhWjS2x4oznGCBqHgU9vwd4y/d1HGoXKOYOKU zuul-build-sshkey
2026-09-11 17:20:56.513288 | instance -> localhost | The key's randomart image is:
2026-09-11 17:20:56.513321 | instance -> localhost | +---[RSA 3072]----+
2026-09-11 17:20:56.513362 | instance -> localhost | | .oo.  .* .      |
2026-09-11 17:20:56.513395 | instance -> localhost | |..oo . + = .   . |
2026-09-11 17:20:56.513421 | instance -> localhost | |o.  = . + =   = .|
2026-09-11 17:20:56.513446 | instance -> localhost | |o .. + = @ + = + |
2026-09-11 17:20:56.513472 | instance -> localhost | | .    B E o = .  |
2026-09-11 17:20:56.513500 | instance -> localhost | |       o O o     |
2026-09-11 17:20:56.513525 | instance -> localhost | |        o = o    |
2026-09-11 17:20:56.513550 | instance -> localhost | |         o +     |
2026-09-11 17:20:56.513582 | instance -> localhost | |          o      |
2026-09-11 17:20:56.513611 | instance -> localhost | +----[SHA256]-----+
2026-09-11 17:20:56.513686 | instance -> localhost | ok: Runtime: 0:00:00.644960
2026-09-11 17:20:56.522358 | 
2026-09-11 17:20:56.522567 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-11 17:20:56.543849 | instance | ok
2026-09-11 17:20:56.554913 | instance | included: /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-11 17:20:56.564311 | 
2026-09-11 17:20:56.564466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-11 17:20:56.588699 | instance | skipping: Conditional result was False
2026-09-11 17:20:56.596349 | 
2026-09-11 17:20:56.596591 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-11 17:20:57.088461 | instance | changed
2026-09-11 17:20:57.101300 | 
2026-09-11 17:20:57.101435 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-11 17:20:57.318863 | instance | ok
2026-09-11 17:20:57.328249 | 
2026-09-11 17:20:57.328379 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-11 17:20:57.860844 | instance | changed
2026-09-11 17:20:57.871698 | 
2026-09-11 17:20:57.871855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-11 17:20:58.387387 | instance | changed
2026-09-11 17:20:58.400355 | 
2026-09-11 17:20:58.400537 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-11 17:20:58.426550 | instance | skipping: Conditional result was False
2026-09-11 17:20:58.438379 | 
2026-09-11 17:20:58.438508 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-11 17:20:58.850705 | instance -> localhost | changed
2026-09-11 17:20:58.872665 | 
2026-09-11 17:20:58.872948 | TASK [add-build-sshkey : Add back temp key]
2026-09-11 17:20:59.198672 | instance -> localhost | Identity added: /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/5c39cff44a51416d98eb4971f6d534c9_id_rsa (zuul-build-sshkey)
2026-09-11 17:20:59.199071 | instance -> localhost | ok: Runtime: 0:00:00.014260
2026-09-11 17:20:59.209464 | 
2026-09-11 17:20:59.209671 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-11 17:20:59.594917 | instance | ok
2026-09-11 17:20:59.606636 | 
2026-09-11 17:20:59.606824 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-11 17:20:59.644248 | instance | skipping: Conditional result was False
2026-09-11 17:20:59.661285 | 
2026-09-11 17:20:59.661431 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-11 17:21:00.041909 | instance | ok
2026-09-11 17:21:00.050933 | 
2026-09-11 17:21:00.051054 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-11 17:21:03.629810 | instance | Output suppressed because no_log was given
2026-09-11 17:21:03.637005 | 
2026-09-11 17:21:03.637084 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-11 17:21:03.865306 | instance | ok: "logs"
2026-09-11 17:21:03.865833 | instance | ok: All items complete
2026-09-11 17:21:03.865944 | 
2026-09-11 17:21:04.006119 | instance | ok: "artifacts"
2026-09-11 17:21:04.156888 | instance | ok: "docs"
2026-09-11 17:21:04.179052 | 
2026-09-11 17:21:04.179288 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-11 17:21:04.372740 | instance | changed: "logs"
2026-09-11 17:21:04.531849 | instance | changed: "artifacts"
2026-09-11 17:21:04.716662 | instance | changed: "docs"
2026-09-11 17:21:04.734253 | 
2026-09-11 17:21:04.735166 | PLAY RECAP
2026-09-11 17:21:04.735305 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-11 17:21:04.735376 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:21:04.735428 | 
2026-09-11 17:21:04.876794 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:21:04.880328 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:21:05.419908 | 
2026-09-11 17:21:05.420022 | PLAY [all]
2026-09-11 17:21:05.429604 | 
2026-09-11 17:21:05.429680 | TASK [setup-uv : Extract archive]
2026-09-11 17:21:08.020015 | instance | changed
2026-09-11 17:21:08.037763 | 
2026-09-11 17:21:08.038026 | TASK [setup-uv : Print version]
2026-09-11 17:21:08.437332 | instance | uv 0.8.13
2026-09-11 17:21:08.585331 | instance | ok: Runtime: 0:00:00.009623
2026-09-11 17:21:08.603165 | 
2026-09-11 17:21:08.603303 | TASK [Install Ansible collection siblings]
2026-09-11 17:21:18.138340 | instance | changed:
2026-09-11 17:21:18.138589 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-11 17:21:18.138646 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-11 17:21:18.138687 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-11 17:21:18.138725 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-11 17:21:18.138762 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-11 17:21:18.138834 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-11 17:21:18.138876 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-11 17:21:18.138919 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-11 17:21:18.139065 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-11 17:21:18.139111 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-11 17:21:18.139151 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-11 17:21:18.139317 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-11 17:21:18.139438 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-11 17:21:18.139513 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-11 17:21:18.139602 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-11 17:21:18.139670 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-11 17:21:18.139750 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-11 17:21:18.139853 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-11 17:21:18.139912 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-11 17:21:18.139973 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-11 17:21:18.140052 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-11 17:21:18.140144 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-11 17:21:18.140218 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:21:18.140296 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-11 17:21:18.140354 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-11 17:21:18.140415 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:21:18.140525 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:21:18.140579 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:21:18.140617 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-11 17:21:18.140652 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-11 17:21:18.140686 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:21:18.140722 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:21:18.140758 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-11 17:21:18.140818 | 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-11 17:21:18.140867 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.140903 | instance | Process install dependency map
2026-09-11 17:21:18.140944 | instance | Starting collection install process
2026-09-11 17:21:18.140997 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-11 17:21:18.141099 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-11 17:21:18.141227 | instance | ansible.netcommon:* was installed successfully
2026-09-11 17:21:18.141323 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-11 17:21:18.141447 | instance | Creating virtual environment at: .venv
2026-09-11 17:21:18.141543 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:21:18.141647 | instance | Downloading cryptography (4.2MiB)
2026-09-11 17:21:18.141748 | instance | Downloading setuptools (1.1MiB)
2026-09-11 17:21:18.141855 | instance | Downloading rjsonnet (1.2MiB)
2026-09-11 17:21:18.141900 | instance | Downloading netaddr (2.2MiB)
2026-09-11 17:21:18.141937 | instance | Downloading pygments (1.2MiB)
2026-09-11 17:21:18.141973 | instance | Downloading openstacksdk (1.7MiB)
2026-09-11 17:21:18.142009 | instance | Downloading kubernetes (1.9MiB)
2026-09-11 17:21:18.142046 | instance | Downloading ansible-core (2.1MiB)
2026-09-11 17:21:18.142083 | instance |    Building pyperclip==1.9.0
2026-09-11 17:21:18.142118 | instance |  Downloading rjsonnet
2026-09-11 17:21:18.142157 | instance |  Downloading netaddr
2026-09-11 17:21:18.142193 | instance |  Downloading pygments
2026-09-11 17:21:18.142228 | instance |  Downloading cryptography
2026-09-11 17:21:18.142263 | instance |  Downloading setuptools
2026-09-11 17:21:18.142297 | instance |  Downloading kubernetes
2026-09-11 17:21:18.142332 | instance |  Downloading ansible-core
2026-09-11 17:21:18.142366 | instance |  Downloading openstacksdk
2026-09-11 17:21:18.142401 | instance |       Built pyperclip==1.9.0
2026-09-11 17:21:18.142436 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:21:18.142472 | instance | Installed 79 packages in 67ms
2026-09-11 17:21:18.142507 | instance | Checked out ansible.posix to 1.6.0
2026-09-11 17:21:18.142542 | 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-11 17:21:18.142577 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.142611 | instance | Process install dependency map
2026-09-11 17:21:18.142645 | instance | Starting collection install process
2026-09-11 17:21:18.142679 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-11 17:21:18.142738 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-11 17:21:18.143159 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-11 17:21:18.143433 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.143495 | instance | 2.17.12
2026-09-11 17:21:18.143537 | instance | Checked out ansible.utils to v6.1.0
2026-09-11 17:21:18.143574 | 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-11 17:21:18.143611 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.143646 | instance | Process install dependency map
2026-09-11 17:21:18.143682 | instance | Starting collection install process
2026-09-11 17:21:18.143717 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-11 17:21:18.143752 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-11 17:21:18.143810 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-11 17:21:18.143848 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.143883 | instance | 2.17.12
2026-09-11 17:21:18.143918 | instance | Checked out atmosphere.common to v0.7.0
2026-09-11 17:21:18.143953 | 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-11 17:21:18.143987 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.144021 | instance | Process install dependency map
2026-09-11 17:21:18.144055 | instance | Starting collection install process
2026-09-11 17:21:18.144088 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-11 17:21:18.144123 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-11 17:21:18.144157 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-11 17:21:18.144191 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.144226 | instance | 2.17.12
2026-09-11 17:21:18.144260 | instance | Checked out community.crypto to 2.2.3
2026-09-11 17:21:18.144295 | 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-11 17:21:18.144329 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.144363 | instance | Process install dependency map
2026-09-11 17:21:18.144396 | instance | Starting collection install process
2026-09-11 17:21:18.144431 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-11 17:21:18.144464 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-11 17:21:18.144523 | instance | community.crypto:2.2.3 was installed successfully
2026-09-11 17:21:18.144563 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.144597 | instance | 2.17.12
2026-09-11 17:21:18.144631 | instance | Checked out community.general to 7.3.0
2026-09-11 17:21:18.144665 | 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-11 17:21:18.144698 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.144748 | instance | Process install dependency map
2026-09-11 17:21:18.144861 | instance | Starting collection install process
2026-09-11 17:21:18.144934 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-11 17:21:18.144988 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-11 17:21:18.145039 | instance | community.general:7.3.0 was installed successfully
2026-09-11 17:21:18.145092 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.145143 | instance | 2.17.12
2026-09-11 17:21:18.145194 | instance | Checked out community.mysql to 3.6.0
2026-09-11 17:21:18.145244 | 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-11 17:21:18.145295 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.145353 | instance | Process install dependency map
2026-09-11 17:21:18.145405 | instance | Starting collection install process
2026-09-11 17:21:18.145449 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-11 17:21:18.145499 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-11 17:21:18.145543 | instance | community.mysql:3.6.0 was installed successfully
2026-09-11 17:21:18.145581 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.145619 | instance | 2.17.12
2026-09-11 17:21:18.145668 | instance | Checked out kubernetes.core to 2.4.0
2026-09-11 17:21:18.145715 | 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-11 17:21:18.145753 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.145815 | instance | Process install dependency map
2026-09-11 17:21:18.145856 | instance | Starting collection install process
2026-09-11 17:21:18.145893 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-11 17:21:18.145931 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-11 17:21:18.145967 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-11 17:21:18.146005 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.146044 | instance | 2.17.12
2026-09-11 17:21:18.146081 | instance | Checked out openstack.cloud to 2.6.0
2026-09-11 17:21:18.146116 | 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-11 17:21:18.146153 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.146191 | instance | Process install dependency map
2026-09-11 17:21:18.146225 | instance | Starting collection install process
2026-09-11 17:21:18.146259 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-11 17:21:18.146293 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-11 17:21:18.146330 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-11 17:21:18.146366 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.146402 | instance | 2.17.12
2026-09-11 17:21:18.146439 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-11 17:21:18.146476 | 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-11 17:21:18.146523 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.146559 | instance | Process install dependency map
2026-09-11 17:21:18.146597 | instance | Starting collection install process
2026-09-11 17:21:18.146632 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-11 17:21:18.146669 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-11 17:21:18.146705 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-11 17:21:18.146739 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.146793 | instance | 2.17.12
2026-09-11 17:21:18.147033 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-11 17:21:18.147089 | 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-11 17:21:18.147127 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.147162 | instance | Process install dependency map
2026-09-11 17:21:18.147196 | instance | Starting collection install process
2026-09-11 17:21:18.147230 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-11 17:21:18.147264 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-11 17:21:18.147299 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-11 17:21:18.147332 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.147366 | instance | 2.17.12
2026-09-11 17:21:18.147400 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-11 17:21:18.147437 | 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-11 17:21:18.147471 | instance | Starting galaxy collection install process
2026-09-11 17:21:18.147506 | instance | Process install dependency map
2026-09-11 17:21:18.147539 | instance | Starting collection install process
2026-09-11 17:21:18.147573 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-11 17:21:18.147607 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-11 17:21:18.147642 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-11 17:21:18.147676 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:21:18.147710 | instance | 2.17.12
2026-09-11 17:21:18.159299 | 
2026-09-11 17:21:18.159390 | PLAY RECAP
2026-09-11 17:21:18.159551 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:21:18.159603 | 
2026-09-11 17:21:18.275929 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:21:18.278829 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:21:18.853725 | 
2026-09-11 17:21:18.854126 | PLAY [all]
2026-09-11 17:21:18.864368 | 
2026-09-11 17:21:18.864443 | TASK [Install "jq" for log collection]
2026-09-11 17:21:30.632879 | instance | changed
2026-09-11 17:21:30.636238 | 
2026-09-11 17:21:30.636347 | PLAY RECAP
2026-09-11 17:21:30.636437 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:21:30.636559 | 
2026-09-11 17:21:30.750174 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:21:30.754125 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:21:31.369885 | 
2026-09-11 17:21:31.370044 | PLAY [all]
2026-09-11 17:21:31.380638 | 
2026-09-11 17:21:31.380709 | LOOP [Check inventory directories]
2026-09-11 17:21:31.737776 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-11 17:21:31.897101 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-11 17:21:32.072966 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-11 17:21:32.086941 | 
2026-09-11 17:21:32.087173 | LOOP [Copy inventory file for Zuul]
2026-09-11 17:21:32.941219 | instance | changed:
2026-09-11 17:21:32.978438 | instance | {
2026-09-11 17:21:32.978923 | instance |   "ansible_loop_var": "item",
2026-09-11 17:21:32.979381 | instance |   "changed": false,
2026-09-11 17:21:32.979607 | instance |   "failed": false,
2026-09-11 17:21:32.979693 | instance |   "invocation": {
2026-09-11 17:21:32.979741 | instance |     "module_args": {
2026-09-11 17:21:32.979805 | instance |       "checksum_algorithm": "sha1",
2026-09-11 17:21:32.979851 | instance |       "follow": true,
2026-09-11 17:21:32.979888 | instance |       "get_attributes": true,
2026-09-11 17:21:32.979928 | instance |       "get_checksum": true,
2026-09-11 17:21:32.979963 | instance |       "get_mime": true,
2026-09-11 17:21:32.980000 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-11 17:21:32.980038 | instance |     }
2026-09-11 17:21:32.980070 | instance |   },
2026-09-11 17:21:32.980105 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:21:32.980139 | instance |   "stat": {
2026-09-11 17:21:32.980174 | instance |     "atime": 1789147270.8267365,
2026-09-11 17:21:32.980210 | instance |     "attr_flags": "e",
2026-09-11 17:21:32.980245 | instance |     "attributes": [
2026-09-11 17:21:32.980280 | instance |       "extents"
2026-09-11 17:21:32.980312 | instance |     ],
2026-09-11 17:21:32.980344 | instance |     "block_size": 4096,
2026-09-11 17:21:32.980377 | instance |     "blocks": 8,
2026-09-11 17:21:32.980411 | instance |     "charset": "unknown",
2026-09-11 17:21:32.980448 | instance |     "ctime": 1789147269.4748123,
2026-09-11 17:21:32.980484 | instance |     "dev": 64513,
2026-09-11 17:21:32.980569 | instance |     "device_type": 0,
2026-09-11 17:21:32.980617 | instance |     "executable": true,
2026-09-11 17:21:32.980654 | instance |     "exists": true,
2026-09-11 17:21:32.980702 | instance |     "gid": 1000,
2026-09-11 17:21:32.980753 | instance |     "gr_name": "zuul",
2026-09-11 17:21:32.980818 | instance |     "inode": 1049147,
2026-09-11 17:21:32.980886 | instance |     "isblk": false,
2026-09-11 17:21:32.980980 | instance |     "ischr": false,
2026-09-11 17:21:32.981038 | instance |     "isdir": true,
2026-09-11 17:21:32.981078 | instance |     "isfifo": false,
2026-09-11 17:21:32.981123 | instance |     "isgid": false,
2026-09-11 17:21:32.981164 | instance |     "islnk": false,
2026-09-11 17:21:32.981197 | instance |     "isreg": false,
2026-09-11 17:21:32.981241 | instance |     "issock": false,
2026-09-11 17:21:32.981285 | instance |     "isuid": false,
2026-09-11 17:21:32.981317 | instance |     "mimetype": "unknown",
2026-09-11 17:21:32.981362 | instance |     "mode": "0755",
2026-09-11 17:21:32.981405 | instance |     "mtime": 1789147269.4748123,
2026-09-11 17:21:32.981439 | instance |     "nlink": 22,
2026-09-11 17:21:32.981479 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:21:32.981525 | instance |     "pw_name": "zuul",
2026-09-11 17:21:32.981618 | instance |     "readable": true,
2026-09-11 17:21:32.981693 | instance |     "rgrp": true,
2026-09-11 17:21:32.981746 | instance |     "roth": true,
2026-09-11 17:21:32.981820 | instance |     "rusr": true,
2026-09-11 17:21:32.981871 | instance |     "size": 4096,
2026-09-11 17:21:32.982419 | instance |     "uid": 1000,
2026-09-11 17:21:32.982497 | instance |     "version": "2795274105",
2026-09-11 17:21:32.982542 | instance |     "wgrp": false,
2026-09-11 17:21:32.982583 | instance |     "woth": false,
2026-09-11 17:21:32.982618 | instance |     "writeable": true,
2026-09-11 17:21:32.982651 | instance |     "wusr": true,
2026-09-11 17:21:32.982683 | instance |     "xgrp": true,
2026-09-11 17:21:32.982716 | instance |     "xoth": true,
2026-09-11 17:21:32.982748 | instance |     "xusr": true
2026-09-11 17:21:32.982809 | instance |   }
2026-09-11 17:21:32.982850 | instance | }
2026-09-11 17:21:32.982950 | instance | ok: All items complete
2026-09-11 17:21:32.982995 | 
2026-09-11 17:21:32.986684 | instance | skipping: Conditional result was False
2026-09-11 17:21:32.988548 | instance | skipping: Conditional result was False
2026-09-11 17:21:33.017129 | 
2026-09-11 17:21:33.018056 | LOOP [Switch "ansible_host" to private IP]
2026-09-11 17:21:33.380871 | instance | changed: 1 replacements made
2026-09-11 17:21:33.384308 | instance | skipping: Conditional result was False
2026-09-11 17:21:33.389254 | instance | skipping: Conditional result was False
2026-09-11 17:21:33.407198 | 
2026-09-11 17:21:33.407355 | TASK [Run Molecule scenario]
2026-09-11 17:21:34.404292 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-11 17:21:34.859690 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-11 17:21:34.859773 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-11 17:21:46.194429 | instance | INFO     [csi > dependency] Executing
2026-09-11 17:21:46.194829 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-11 17:21:46.195248 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-11 17:21:46.195577 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-11 17:21:46.216136 | instance | INFO     [csi > cleanup] Executing
2026-09-11 17:21:46.216886 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:21:46.229689 | instance | INFO     [csi > destroy] Executing
2026-09-11 17:21:46.229753 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-11 17:21:46.229811 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-11 17:21:46.240954 | instance | INFO     [csi > syntax] Executing
2026-09-11 17:21:47.738005 | instance |
2026-09-11 17:21:47.738116 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:21:47.807109 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-11 17:21:47.819869 | instance | INFO     [csi > create] Executing
2026-09-11 17:21:47.822399 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:21:47.833333 | instance | INFO     [csi > prepare] Executing
2026-09-11 17:21:48.614162 | instance |
2026-09-11 17:21:48.614532 | instance | PLAY [Prepare] *****************************************************************
2026-09-11 17:21:48.615021 | instance |
2026-09-11 17:21:48.615407 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:21:48.615773 | instance | Friday 11 September 2026  17:21:48 +0000 (0:00:00.025)       0:00:00.025 ******
2026-09-11 17:21:49.899963 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:21:49.900207 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:21:49.900498 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:21:49.900739 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:21:49.900990 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:21:49.911555 | instance | ok: [instance]
2026-09-11 17:21:49.911787 | instance |
2026-09-11 17:21:49.912030 | instance | TASK [Configure short hostname] ************************************************
2026-09-11 17:21:49.912306 | instance | Friday 11 September 2026  17:21:49 +0000 (0:00:01.298)       0:00:01.324 ******
2026-09-11 17:21:50.683123 | instance | changed: [instance]
2026-09-11 17:21:50.683233 | instance |
2026-09-11 17:21:50.683469 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-11 17:21:50.683641 | instance | Friday 11 September 2026  17:21:50 +0000 (0:00:00.771)       0:00:02.095 ******
2026-09-11 17:21:50.973771 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-11 17:21:50.973994 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-11 17:21:50.974270 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-11 17:21:50.980014 | instance | changed: [instance]
2026-09-11 17:21:50.980229 | instance |
2026-09-11 17:21:50.980511 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-11 17:21:50.980752 | instance | Friday 11 September 2026  17:21:50 +0000 (0:00:00.297)       0:00:02.392 ******
2026-09-11 17:21:51.834409 | instance | ok: [instance]
2026-09-11 17:21:51.834629 | instance |
2026-09-11 17:21:51.834948 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-11 17:21:51.835109 | instance |
2026-09-11 17:21:51.835355 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:21:51.835632 | instance | Friday 11 September 2026  17:21:51 +0000 (0:00:00.854)       0:00:03.246 ******
2026-09-11 17:21:52.627701 | instance | ok: [instance]
2026-09-11 17:21:52.627946 | instance |
2026-09-11 17:21:52.628206 | instance | TASK [Install depedencies] *****************************************************
2026-09-11 17:21:52.628519 | instance | Friday 11 September 2026  17:21:52 +0000 (0:00:00.792)       0:00:04.039 ******
2026-09-11 17:22:15.854241 | instance | changed: [instance]
2026-09-11 17:22:15.854588 | instance |
2026-09-11 17:22:15.854878 | instance | TASK [Start up service] ********************************************************
2026-09-11 17:22:15.855134 | instance | Friday 11 September 2026  17:22:15 +0000 (0:00:23.226)       0:00:27.266 ******
2026-09-11 17:22:16.417300 | instance | ok: [instance]
2026-09-11 17:22:16.417566 | instance |
2026-09-11 17:22:16.417916 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-11 17:22:16.418233 | instance | Friday 11 September 2026  17:22:16 +0000 (0:00:00.562)       0:00:27.828 ******
2026-09-11 17:22:16.725978 | instance | ok: [instance]
2026-09-11 17:22:16.726210 | instance |
2026-09-11 17:22:16.726460 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-11 17:22:16.726743 | instance | Friday 11 September 2026  17:22:16 +0000 (0:00:00.309)       0:00:28.138 ******
2026-09-11 17:22:17.493145 | instance | changed: [instance]
2026-09-11 17:22:17.493376 | instance |
2026-09-11 17:22:17.493391 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-11 17:22:17.493402 | instance | Friday 11 September 2026  17:22:17 +0000 (0:00:00.766)       0:00:28.904 ******
2026-09-11 17:22:17.710476 | instance | ok: [instance]
2026-09-11 17:22:17.710536 | instance |
2026-09-11 17:22:17.710867 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-11 17:22:17.710938 | instance | Friday 11 September 2026  17:22:17 +0000 (0:00:00.218)       0:00:29.122 ******
2026-09-11 17:22:17.736576 | instance | skipping: [instance]
2026-09-11 17:22:17.736698 | instance |
2026-09-11 17:22:17.737119 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-11 17:22:17.737304 | instance | Friday 11 September 2026  17:22:17 +0000 (0:00:00.026)       0:00:29.149 ******
2026-09-11 17:22:18.378236 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:22:18.379564 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:22:18.379656 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:22:18.379661 | instance |
2026-09-11 17:22:18.379676 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-11 17:22:18.379922 | instance | Friday 11 September 2026  17:22:18 +0000 (0:00:00.641)       0:00:29.790 ******
2026-09-11 17:22:19.097591 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:22:19.097830 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:22:19.098157 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:22:19.098444 | instance |
2026-09-11 17:22:19.098772 | instance | TASK [Start loop devices] ******************************************************
2026-09-11 17:22:19.099224 | instance | Friday 11 September 2026  17:22:19 +0000 (0:00:00.719)       0:00:30.509 ******
2026-09-11 17:22:19.886514 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:22:19.886807 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:22:19.887042 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:22:19.887248 | instance |
2026-09-11 17:22:19.887476 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-11 17:22:19.887685 | instance | Friday 11 September 2026  17:22:19 +0000 (0:00:00.787)       0:00:31.297 ******
2026-09-11 17:22:23.183401 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:22:23.183687 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:22:23.183699 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:22:23.183709 | instance |
2026-09-11 17:22:23.183719 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-11 17:22:23.183728 | instance | Friday 11 September 2026  17:22:23 +0000 (0:00:03.297)       0:00:34.594 ******
2026-09-11 17:22:25.101341 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-11 17:22:25.101399 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-11 17:22:25.101431 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-11 17:22:25.103502 | instance |
2026-09-11 17:22:25.103529 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:22:25.103541 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-11 17:22:25.103551 | instance |
2026-09-11 17:22:25.103560 | instance | Friday 11 September 2026  17:22:25 +0000 (0:00:01.918)       0:00:36.513 ******
2026-09-11 17:22:25.103569 | instance | ===============================================================================
2026-09-11 17:22:25.103578 | instance | Install depedencies ---------------------------------------------------- 23.23s
2026-09-11 17:22:25.107683 | instance | Create a volume group for each loop device ------------------------------ 3.30s
2026-09-11 17:22:25.107797 | instance | Create a logical volume for each loop device ---------------------------- 1.92s
2026-09-11 17:22:25.107828 | instance | Gathering Facts --------------------------------------------------------- 1.30s
2026-09-11 17:22:25.107856 | instance | Purge "snapd" package --------------------------------------------------- 0.85s
2026-09-11 17:22:25.107871 | instance | Gathering Facts --------------------------------------------------------- 0.79s
2026-09-11 17:22:25.107885 | instance | Start loop devices ------------------------------------------------------ 0.79s
2026-09-11 17:22:25.107898 | instance | Configure short hostname ------------------------------------------------ 0.77s
2026-09-11 17:22:25.107911 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.77s
2026-09-11 17:22:25.107923 | instance | Set permissions on loopback devices ------------------------------------- 0.72s
2026-09-11 17:22:25.107936 | instance | Create devices for Ceph ------------------------------------------------- 0.64s
2026-09-11 17:22:25.107949 | instance | Start up service -------------------------------------------------------- 0.56s
2026-09-11 17:22:25.107990 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-09-11 17:22:25.108005 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-11 17:22:25.108019 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-11 17:22:25.108045 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-11 17:22:25.188415 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-11 17:22:25.207179 | instance | INFO     [csi > converge] Executing
2026-09-11 17:22:26.612813 | instance |
2026-09-11 17:22:26.613061 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-11 17:22:26.613297 | instance |
2026-09-11 17:22:26.613545 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:22:26.613793 | instance | Friday 11 September 2026  17:22:26 +0000 (0:00:00.007)       0:00:00.007 ******
2026-09-11 17:22:27.722101 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:22:27.722303 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:22:27.722499 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:22:27.722672 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:22:27.722850 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:22:27.736844 | instance | ok: [instance]
2026-09-11 17:22:27.737098 | instance |
2026-09-11 17:22:27.737354 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-11 17:22:27.737631 | instance | Friday 11 September 2026  17:22:27 +0000 (0:00:01.124)       0:00:01.131 ******
2026-09-11 17:22:27.793644 | instance | ok: [instance] => {
2026-09-11 17:22:27.793927 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-11 17:22:27.794249 | instance | }
2026-09-11 17:22:27.794588 | instance |
2026-09-11 17:22:27.794922 | instance | PLAY [all] *********************************************************************
2026-09-11 17:22:27.795217 | instance |
2026-09-11 17:22:27.795523 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:22:27.795758 | instance | Friday 11 September 2026  17:22:27 +0000 (0:00:00.056)       0:00:01.188 ******
2026-09-11 17:22:28.797571 | instance | ok: [instance]
2026-09-11 17:22:28.798134 | instance |
2026-09-11 17:22:28.798566 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-11 17:22:28.798912 | instance | Friday 11 September 2026  17:22:28 +0000 (0:00:01.003)       0:00:02.191 ******
2026-09-11 17:22:29.014485 | instance | ok: [instance]
2026-09-11 17:22:29.014692 | instance |
2026-09-11 17:22:29.014879 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-11 17:22:29.015041 | instance |
2026-09-11 17:22:29.015248 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:22:29.015393 | instance | Friday 11 September 2026  17:22:29 +0000 (0:00:00.216)       0:00:02.408 ******
2026-09-11 17:22:29.996685 | instance | ok: [instance]
2026-09-11 17:22:29.997100 | instance |
2026-09-11 17:22:30.003326 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:22:30.003391 | instance | Friday 11 September 2026  17:22:29 +0000 (0:00:00.982)       0:00:03.391 ******
2026-09-11 17:22:30.277993 | instance | ok: [instance]
2026-09-11 17:22:30.278404 | instance |
2026-09-11 17:22:30.278794 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:22:30.279215 | instance | Friday 11 September 2026  17:22:30 +0000 (0:00:00.281)       0:00:03.673 ******
2026-09-11 17:22:30.327663 | instance | skipping: [instance]
2026-09-11 17:22:30.327940 | instance |
2026-09-11 17:22:30.328191 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-11 17:22:30.328418 | instance | Friday 11 September 2026  17:22:30 +0000 (0:00:00.049)       0:00:03.722 ******
2026-09-11 17:22:30.681468 | instance | changed: [instance]
2026-09-11 17:22:30.681893 | instance |
2026-09-11 17:22:30.682274 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:22:30.682589 | instance | Friday 11 September 2026  17:22:30 +0000 (0:00:00.353)       0:00:04.076 ******
2026-09-11 17:22:30.780575 | instance | ok: [instance] => {
2026-09-11 17:22:30.781008 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-11 17:22:30.781336 | instance | }
2026-09-11 17:22:30.781630 | instance |
2026-09-11 17:22:30.781933 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:22:30.782258 | instance | Friday 11 September 2026  17:22:30 +0000 (0:00:00.098)       0:00:04.174 ******
2026-09-11 17:22:31.461358 | instance | changed: [instance]
2026-09-11 17:22:31.461834 | instance |
2026-09-11 17:22:31.462220 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:22:31.462570 | instance | Friday 11 September 2026  17:22:31 +0000 (0:00:00.681)       0:00:04.855 ******
2026-09-11 17:22:31.503973 | instance | skipping: [instance]
2026-09-11 17:22:31.504264 | instance |
2026-09-11 17:22:31.504431 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:22:31.504577 | instance | Friday 11 September 2026  17:22:31 +0000 (0:00:00.040)       0:00:04.896 ******
2026-09-11 17:22:31.544565 | instance | skipping: [instance]
2026-09-11 17:22:31.544623 | instance |
2026-09-11 17:22:31.544629 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:22:31.544634 | instance | Friday 11 September 2026  17:22:31 +0000 (0:00:00.042)       0:00:04.939 ******
2026-09-11 17:22:31.799605 | instance | ok: [instance]
2026-09-11 17:22:31.799674 | instance |
2026-09-11 17:22:31.799683 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:22:31.799696 | instance | Friday 11 September 2026  17:22:31 +0000 (0:00:00.254)       0:00:05.194 ******
2026-09-11 17:22:33.310269 | instance | ok: [instance]
2026-09-11 17:22:33.310367 | instance |
2026-09-11 17:22:33.310452 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:22:33.310570 | instance | Friday 11 September 2026  17:22:33 +0000 (0:00:01.510)       0:00:06.705 ******
2026-09-11 17:22:33.405723 | instance | ok: [instance] => {
2026-09-11 17:22:33.406070 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-11 17:22:33.406372 | instance | }
2026-09-11 17:22:33.406613 | instance |
2026-09-11 17:22:33.407009 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:22:33.407337 | instance | Friday 11 September 2026  17:22:33 +0000 (0:00:00.094)       0:00:06.800 ******
2026-09-11 17:22:34.051492 | instance | changed: [instance]
2026-09-11 17:22:34.051627 | instance |
2026-09-11 17:22:34.051824 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:22:34.051952 | instance | Friday 11 September 2026  17:22:34 +0000 (0:00:00.645)       0:00:07.446 ******
2026-09-11 17:22:37.109545 | instance | changed: [instance]
2026-09-11 17:22:37.109629 | instance |
2026-09-11 17:22:37.109646 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-11 17:22:37.109676 | instance | Friday 11 September 2026  17:22:37 +0000 (0:00:03.057)       0:00:10.503 ******
2026-09-11 17:22:37.153725 | instance | skipping: [instance]
2026-09-11 17:22:37.154330 | instance |
2026-09-11 17:22:37.154511 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-11 17:22:37.154522 | instance | Friday 11 September 2026  17:22:37 +0000 (0:00:00.045)       0:00:10.548 ******
2026-09-11 17:22:37.194813 | instance | skipping: [instance]
2026-09-11 17:22:37.195561 | instance |
2026-09-11 17:22:37.196113 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-11 17:22:37.196152 | instance | Friday 11 September 2026  17:22:37 +0000 (0:00:00.040)       0:00:10.589 ******
2026-09-11 17:22:37.232370 | instance | skipping: [instance]
2026-09-11 17:22:37.232554 | instance |
2026-09-11 17:22:37.232893 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-11 17:22:37.233209 | instance | Friday 11 September 2026  17:22:37 +0000 (0:00:00.037)       0:00:10.627 ******
2026-09-11 17:22:43.188809 | instance | changed: [instance]
2026-09-11 17:22:43.189051 | instance |
2026-09-11 17:22:43.189062 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-11 17:22:43.189073 | instance | Friday 11 September 2026  17:22:43 +0000 (0:00:05.956)       0:00:16.583 ******
2026-09-11 17:22:43.831051 | instance | changed: [instance]
2026-09-11 17:22:43.831540 | instance |
2026-09-11 17:22:43.831617 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-11 17:22:43.831955 | instance | Friday 11 September 2026  17:22:43 +0000 (0:00:00.641)       0:00:17.225 ******
2026-09-11 17:22:44.880007 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-11 17:22:44.880091 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-11 17:22:44.881086 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-11 17:22:44.881134 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-11 17:22:44.881142 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-11 17:22:44.881149 | instance |
2026-09-11 17:22:44.881161 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-11 17:22:44.881167 | instance | Friday 11 September 2026  17:22:44 +0000 (0:00:01.049)       0:00:18.275 ******
2026-09-11 17:22:45.493968 | instance | changed: [instance]
2026-09-11 17:22:45.494044 | instance |
2026-09-11 17:22:45.494645 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-11 17:22:45.494692 | instance | Friday 11 September 2026  17:22:45 +0000 (0:00:00.599)       0:00:18.875 ******
2026-09-11 17:22:45.494699 | instance |
2026-09-11 17:22:45.494705 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:22:45.494710 | instance | Friday 11 September 2026  17:22:45 +0000 (0:00:00.014)       0:00:18.889 ******
2026-09-11 17:22:46.497220 | instance | ok: [instance]
2026-09-11 17:22:46.497996 | instance |
2026-09-11 17:22:46.498057 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-11 17:22:46.498072 | instance | Friday 11 September 2026  17:22:46 +0000 (0:00:01.002)       0:00:19.891 ******
2026-09-11 17:22:47.009716 | instance | changed: [instance]
2026-09-11 17:22:47.010625 | instance |
2026-09-11 17:22:47.010724 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-11 17:22:47.010738 | instance | Friday 11 September 2026  17:22:47 +0000 (0:00:00.512)       0:00:20.403 ******
2026-09-11 17:22:47.657390 | instance | changed: [instance]
2026-09-11 17:22:47.657508 | instance |
2026-09-11 17:22:47.657867 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:22:47.657934 | instance | Friday 11 September 2026  17:22:47 +0000 (0:00:00.648)       0:00:21.052 ******
2026-09-11 17:22:47.936522 | instance | ok: [instance]
2026-09-11 17:22:47.936585 | instance |
2026-09-11 17:22:47.936597 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:22:47.936608 | instance | Friday 11 September 2026  17:22:47 +0000 (0:00:00.277)       0:00:21.330 ******
2026-09-11 17:22:47.989823 | instance | ok: [instance] => {
2026-09-11 17:22:47.989894 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-11 17:22:47.990500 | instance | }
2026-09-11 17:22:47.990574 | instance |
2026-09-11 17:22:47.990582 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:22:47.990588 | instance | Friday 11 September 2026  17:22:47 +0000 (0:00:00.054)       0:00:21.384 ******
2026-09-11 17:22:50.882705 | instance | changed: [instance]
2026-09-11 17:22:50.883545 | instance |
2026-09-11 17:22:50.883749 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:22:50.883765 | instance | Friday 11 September 2026  17:22:50 +0000 (0:00:02.892)       0:00:24.277 ******
2026-09-11 17:22:55.425093 | instance | changed: [instance]
2026-09-11 17:22:55.425160 | instance |
2026-09-11 17:22:55.425504 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-11 17:22:55.425525 | instance | Friday 11 September 2026  17:22:55 +0000 (0:00:04.542)       0:00:28.819 ******
2026-09-11 17:22:56.866175 | instance | ok: [instance]
2026-09-11 17:22:56.866936 | instance |
2026-09-11 17:22:56.867009 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-11 17:22:56.867022 | instance | Friday 11 September 2026  17:22:56 +0000 (0:00:01.440)       0:00:30.260 ******
2026-09-11 17:22:57.266859 | instance | changed: [instance]
2026-09-11 17:22:57.266993 | instance |
2026-09-11 17:22:57.267459 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-11 17:22:57.267534 | instance | Friday 11 September 2026  17:22:57 +0000 (0:00:00.400)       0:00:30.661 ******
2026-09-11 17:22:57.806368 | instance | changed: [instance]
2026-09-11 17:22:57.806517 | instance |
2026-09-11 17:22:57.806803 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-11 17:22:57.806864 | instance | Friday 11 September 2026  17:22:57 +0000 (0:00:00.539)       0:00:31.201 ******
2026-09-11 17:22:58.486542 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-11 17:22:58.487609 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-11 17:22:58.487737 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-11 17:22:58.487766 | instance |
2026-09-11 17:22:58.488294 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-11 17:22:58.488368 | instance | Friday 11 September 2026  17:22:58 +0000 (0:00:00.679)       0:00:31.881 ******
2026-09-11 17:22:59.011834 | instance | changed: [instance]
2026-09-11 17:22:59.011943 | instance |
2026-09-11 17:22:59.012339 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-11 17:22:59.012401 | instance | Friday 11 September 2026  17:22:59 +0000 (0:00:00.525)       0:00:32.406 ******
2026-09-11 17:22:59.533640 | instance | changed: [instance]
2026-09-11 17:22:59.533728 | instance |
2026-09-11 17:22:59.533795 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-11 17:22:59.534243 | instance | Friday 11 September 2026  17:22:59 +0000 (0:00:00.505)       0:00:32.912 ******
2026-09-11 17:22:59.534290 | instance |
2026-09-11 17:22:59.534296 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:22:59.534300 | instance | Friday 11 September 2026  17:22:59 +0000 (0:00:00.016)       0:00:32.929 ******
2026-09-11 17:23:00.358493 | instance | ok: [instance]
2026-09-11 17:23:00.358565 | instance |
2026-09-11 17:23:00.358798 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-11 17:23:00.358872 | instance | Friday 11 September 2026  17:23:00 +0000 (0:00:00.824)       0:00:33.753 ******
2026-09-11 17:23:01.353196 | instance | changed: [instance]
2026-09-11 17:23:01.353958 | instance |
2026-09-11 17:23:01.353991 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-11 17:23:01.354003 | instance | Friday 11 September 2026  17:23:01 +0000 (0:00:00.994)       0:00:34.748 ******
2026-09-11 17:23:01.938240 | instance | changed: [instance]
2026-09-11 17:23:01.938328 | instance |
2026-09-11 17:23:01.938651 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-11 17:23:01.938699 | instance | Friday 11 September 2026  17:23:01 +0000 (0:00:00.585)       0:00:35.333 ******
2026-09-11 17:23:02.024198 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-11 17:23:02.024973 | instance |
2026-09-11 17:23:02.025032 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-11 17:23:02.025044 | instance | Friday 11 September 2026  17:23:02 +0000 (0:00:00.085)       0:00:35.418 ******
2026-09-11 17:23:07.377613 | instance | changed: [instance]
2026-09-11 17:23:07.377784 | instance |
2026-09-11 17:23:07.378324 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-11 17:23:07.378390 | instance | Friday 11 September 2026  17:23:07 +0000 (0:00:05.352)       0:00:40.771 ******
2026-09-11 17:23:08.090908 | instance | ok: [instance] => (item=chronyd)
2026-09-11 17:23:08.091590 | instance | ok: [instance] => (item=sshd)
2026-09-11 17:23:08.091703 | instance |
2026-09-11 17:23:08.091728 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-11 17:23:08.091968 | instance | Friday 11 September 2026  17:23:08 +0000 (0:00:00.713)       0:00:41.485 ******
2026-09-11 17:23:24.387597 | instance | changed: [instance]
2026-09-11 17:23:24.387721 | instance |
2026-09-11 17:23:24.387744 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-11 17:23:24.387950 | instance | Friday 11 September 2026  17:23:24 +0000 (0:00:16.296)       0:00:57.781 ******
2026-09-11 17:23:24.612717 | instance | ok: [instance]
2026-09-11 17:23:24.612846 | instance |
2026-09-11 17:23:24.612859 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-11 17:23:24.612984 | instance | Friday 11 September 2026  17:23:24 +0000 (0:00:00.226)       0:00:58.008 ******
2026-09-11 17:23:25.076714 | instance | changed: [instance]
2026-09-11 17:23:25.076844 | instance |
2026-09-11 17:23:25.077387 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-11 17:23:25.077455 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:00.463)       0:00:58.471 ******
2026-09-11 17:23:25.464048 | instance | changed: [instance]
2026-09-11 17:23:25.464496 | instance |
2026-09-11 17:23:25.464711 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-11 17:23:25.464721 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:00.387)       0:00:58.859 ******
2026-09-11 17:23:25.602064 | instance | ok: [instance]
2026-09-11 17:23:25.602864 | instance |
2026-09-11 17:23:25.602896 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-11 17:23:25.602909 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:00.137)       0:00:58.996 ******
2026-09-11 17:23:25.866244 | instance | ok: [instance] => (item=instance)
2026-09-11 17:23:25.866336 | instance |
2026-09-11 17:23:25.866405 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-11 17:23:25.866532 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:00.264)       0:00:59.261 ******
2026-09-11 17:23:25.931245 | instance | ok: [instance]
2026-09-11 17:23:25.931324 | instance |
2026-09-11 17:23:25.931730 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-11 17:23:25.931780 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:00.064)       0:00:59.326 ******
2026-09-11 17:23:26.022265 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-11 17:23:26.022364 | instance |
2026-09-11 17:23:26.022378 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-11 17:23:26.022529 | instance | Friday 11 September 2026  17:23:26 +0000 (0:00:00.090)       0:00:59.417 ******
2026-09-11 17:23:26.393010 | instance | changed: [instance]
2026-09-11 17:23:26.393085 | instance |
2026-09-11 17:23:26.393097 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-11 17:23:26.393108 | instance | Friday 11 September 2026  17:23:26 +0000 (0:00:00.369)       0:00:59.786 ******
2026-09-11 17:23:27.180798 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-11 17:23:27.180887 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-11 17:23:27.181357 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-11 17:23:27.181416 | instance |
2026-09-11 17:23:27.181423 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-11 17:23:27.181430 | instance | Friday 11 September 2026  17:23:27 +0000 (0:00:00.789)       0:01:00.576 ******
2026-09-11 17:24:59.034269 | instance | ok: [instance]
2026-09-11 17:24:59.034335 | instance |
2026-09-11 17:24:59.034348 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-11 17:24:59.034358 | instance | Friday 11 September 2026  17:24:59 +0000 (0:01:31.852)       0:02:32.428 ******
2026-09-11 17:24:59.289332 | instance | changed: [instance]
2026-09-11 17:24:59.289550 | instance |
2026-09-11 17:24:59.289880 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-11 17:24:59.290204 | instance | Friday 11 September 2026  17:24:59 +0000 (0:00:00.255)       0:02:32.683 ******
2026-09-11 17:24:59.346387 | instance | ok: [instance]
2026-09-11 17:24:59.346478 | instance |
2026-09-11 17:24:59.346903 | instance | TASK [Install Ceph host] *******************************************************
2026-09-11 17:24:59.347026 | instance | Friday 11 September 2026  17:24:59 +0000 (0:00:00.057)       0:02:32.740 ******
2026-09-11 17:24:59.438589 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-11 17:24:59.438675 | instance |
2026-09-11 17:24:59.438687 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-11 17:24:59.438841 | instance | Friday 11 September 2026  17:24:59 +0000 (0:00:00.092)       0:02:32.833 ******
2026-09-11 17:25:01.246013 | instance | ok: [instance]
2026-09-11 17:25:01.246075 | instance |
2026-09-11 17:25:01.246087 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-11 17:25:01.246098 | instance | Friday 11 September 2026  17:25:01 +0000 (0:00:01.802)       0:02:34.636 ******
2026-09-11 17:25:01.323345 | instance | ok: [instance] => (item=instance)
2026-09-11 17:25:01.323392 | instance |
2026-09-11 17:25:01.323404 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-11 17:25:01.323414 | instance | Friday 11 September 2026  17:25:01 +0000 (0:00:00.081)       0:02:34.717 ******
2026-09-11 17:25:01.739511 | instance | ok: [instance]
2026-09-11 17:25:01.739771 | instance |
2026-09-11 17:25:01.740044 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-11 17:25:01.740056 | instance | Friday 11 September 2026  17:25:01 +0000 (0:00:00.417)       0:02:35.134 ******
2026-09-11 17:25:04.217458 | instance | ok: [instance]
2026-09-11 17:25:04.217512 | instance |
2026-09-11 17:25:04.217521 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-11 17:25:04.217529 | instance | Friday 11 September 2026  17:25:04 +0000 (0:00:02.477)       0:02:37.612 ******
2026-09-11 17:25:46.374331 | 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-11 17:25:46.375251 | 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_pnpq5tdc/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_pnpq5tdc/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_pnpq5tdc/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_pnpq5tdc/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-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBAOaRqS+JLCSAAZidMfgO4AcV07av8mK6uJ4RoyRd/eES+t91apQOU6H0=: Malformed input [buffer:3]\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBAOaRqS+JLCSAAZidMfgO4AcV07av8mK6uJ4RoyRd/eES+t91apQOU6H0=: Malformed input [buffer:3]\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBAOaRqS+JLCSAAZidMfgO4AcV07av8mK6uJ4RoyRd/eES+t91apQOU6H0=: Malformed input [buffer:3]\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:25:46.167+0000 7f6ed45e9640 -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-11 17:25:46.378320 | instance |
2026-09-11 17:25:46.379548 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:25:46.379859 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-11 17:25:46.379887 | instance |
2026-09-11 17:25:46.379899 | instance | Friday 11 September 2026  17:25:46 +0000 (0:00:42.161)       0:03:19.774 ******
2026-09-11 17:25:46.379909 | instance | ===============================================================================
2026-09-11 17:25:46.379925 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 91.85s
2026-09-11 17:25:46.383487 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.16s
2026-09-11 17:25:46.383514 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 16.30s
2026-09-11 17:25:46.383521 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.96s
2026-09-11 17:25:46.383528 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.35s
2026-09-11 17:25:46.383533 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.54s
2026-09-11 17:25:46.383539 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.06s
2026-09-11 17:25:46.383545 | instance | vexxhost.containers.download_artifact : Download item ------------------- 2.89s
2026-09-11 17:25:46.383565 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.48s
2026-09-11 17:25:46.383572 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.83s
2026-09-11 17:25:46.383578 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.80s
2026-09-11 17:25:46.383584 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.51s
2026-09-11 17:25:46.383590 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.44s
2026-09-11 17:25:46.383596 | instance | Gathering Facts --------------------------------------------------------- 1.12s
2026-09-11 17:25:46.383602 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.05s
2026-09-11 17:25:46.383608 | instance | Gathering Facts --------------------------------------------------------- 1.00s
2026-09-11 17:25:46.383617 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.99s
2026-09-11 17:25:46.383974 | instance | Gathering Facts --------------------------------------------------------- 0.98s
2026-09-11 17:25:46.384387 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.79s
2026-09-11 17:25:46.384753 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.71s
2026-09-11 17:25:46.548010 | 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-11 17:25:46.548346 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-11 17:25:46.548538 | 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-11 17:25:46.773585 | instance | ERROR
2026-09-11 17:25:46.773843 | instance | {
2026-09-11 17:25:46.773919 | instance |   "delta": "0:04:12.872210",
2026-09-11 17:25:46.773959 | instance |   "end": "2026-09-11 17:25:46.628058",
2026-09-11 17:25:46.773994 | instance |   "msg": "non-zero return code",
2026-09-11 17:25:46.774028 | instance |   "rc": 2,
2026-09-11 17:25:46.774061 | instance |   "start": "2026-09-11 17:21:33.755848"
2026-09-11 17:25:46.774094 | instance | }
failure
2026-09-11 17:25:46.787510 | 
2026-09-11 17:25:46.787605 | PLAY RECAP
2026-09-11 17:25:46.787684 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:25:46.787725 | 
2026-09-11 17:25:46.930605 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:25:46.932647 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:25:47.496271 | 
2026-09-11 17:25:47.496381 | PLAY [all]
2026-09-11 17:25:47.508635 | 
2026-09-11 17:25:47.508729 | TASK [gather-host-logs : creating directory for system status]
2026-09-11 17:25:47.875074 | instance | changed
2026-09-11 17:25:47.884444 | 
2026-09-11 17:25:47.884627 | TASK [gather-host-logs : Get logs for each host]
2026-09-11 17:25:48.304892 | instance | + systemd-cgls --full --all --no-pager
2026-09-11 17:25:48.323980 | instance | + ip addr
2026-09-11 17:25:48.326217 | instance | + ip route
2026-09-11 17:25:48.329176 | instance | + lsblk
2026-09-11 17:25:48.334585 | instance | + mount
2026-09-11 17:25:48.337104 | instance | + docker images
2026-09-11 17:25:48.364007 | instance | + brctl show
2026-09-11 17:25:48.364729 | instance | /bin/bash: line 8: brctl: command not found
2026-09-11 17:25:48.365048 | instance | + ip neigh
2026-09-11 17:25:48.368113 | instance | + bridge fdb show
2026-09-11 17:25:48.372407 | instance | + ps aux --sort=-%mem
2026-09-11 17:25:48.396133 | instance | + dpkg -l
2026-09-11 17:25:48.404012 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-11 17:25:48.404669 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-11 17:25:48.426804 | instance | + '[' '!' -z '' ']'
2026-09-11 17:25:48.933981 | instance | ok: Runtime: 0:00:00.127943
2026-09-11 17:25:48.944868 | 
2026-09-11 17:25:48.945002 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-11 17:25:49.619560 | instance | changed:
2026-09-11 17:25:49.619830 | instance | created directory /var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/logs/instance
2026-09-11 17:25:49.619907 | instance | cd+++++++++ system/
2026-09-11 17:25:49.619966 | instance | >f+++++++++ system/brctl-show.txt
2026-09-11 17:25:49.620018 | instance | >f+++++++++ system/bridge-fdb.txt
2026-09-11 17:25:49.620069 | instance | >f+++++++++ system/docker-images.txt
2026-09-11 17:25:49.620128 | instance | >f+++++++++ system/ip-addr.txt
2026-09-11 17:25:49.620183 | instance | >f+++++++++ system/ip-neigh.txt
2026-09-11 17:25:49.620236 | instance | >f+++++++++ system/ip-route.txt
2026-09-11 17:25:49.620292 | instance | >f+++++++++ system/lsblk.txt
2026-09-11 17:25:49.620343 | instance | >f+++++++++ system/mount.txt
2026-09-11 17:25:49.620391 | instance | >f+++++++++ system/packages.txt
2026-09-11 17:25:49.620440 | instance | >f+++++++++ system/ps.txt
2026-09-11 17:25:49.620488 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-11 17:25:49.640707 | 
2026-09-11 17:25:49.640916 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-11 17:25:49.867536 | instance | changed: "values"
2026-09-11 17:25:50.064888 | instance | changed: "releases"
2026-09-11 17:25:50.084733 | 
2026-09-11 17:25:50.084967 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-11 17:25:50.369782 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-11 17:25:50.641874 | instance | ok: Runtime: 0:00:00.004972
2026-09-11 17:25:50.652548 | 
2026-09-11 17:25:50.652700 | TASK [helm-release-status : Downloads logs to executor]
2026-09-11 17:25:51.198151 | instance | changed:
2026-09-11 17:25:51.198468 | instance | cd+++++++++ helm/
2026-09-11 17:25:51.198524 | instance | cd+++++++++ helm/releases/
2026-09-11 17:25:51.198565 | instance | cd+++++++++ helm/values/
2026-09-11 17:25:51.219652 | 
2026-09-11 17:25:51.219804 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-11 17:25:51.448274 | instance | changed
2026-09-11 17:25:51.459786 | 
2026-09-11 17:25:51.459965 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-11 17:25:51.764756 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:25:51.764861 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:25:51.770706 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:25:51.772244 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:25:51.774279 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:25:51.776085 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:25:51.777075 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:25:51.778404 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:25:51.779678 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:25:51.780247 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:25:51.781688 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:25:51.782353 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:25:52.011958 | instance | ok: Runtime: 0:00:00.026402
2026-09-11 17:25:52.022258 | 
2026-09-11 17:25:52.022415 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-11 17:25:52.240891 | instance | changed
2026-09-11 17:25:52.250836 | 
2026-09-11 17:25:52.250992 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-11 17:25:52.513712 | instance | environment: line 5: kubectl: command not found
2026-09-11 17:25:52.514169 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:25:52.514393 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:25:52.514766 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:25:52.802735 | instance | ok: Runtime: 0:00:00.008061
2026-09-11 17:25:52.813782 | 
2026-09-11 17:25:52.813934 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-11 17:25:53.385588 | instance | changed:
2026-09-11 17:25:53.385861 | instance | cd+++++++++ objects/
2026-09-11 17:25:53.385921 | instance | cd+++++++++ objects/cluster/
2026-09-11 17:25:53.385963 | instance | cd+++++++++ objects/namespaced/
2026-09-11 17:25:53.403474 | 
2026-09-11 17:25:53.403599 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-11 17:25:53.622391 | instance | changed
2026-09-11 17:25:53.633132 | 
2026-09-11 17:25:53.633268 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-11 17:25:53.851464 | instance | changed
2026-09-11 17:25:53.860384 | 
2026-09-11 17:25:53.860561 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-11 17:25:54.132348 | instance | environment: line 3: kubectl: command not found
2026-09-11 17:25:54.408990 | instance | ok: Runtime: 0:00:00.008573
2026-09-11 17:25:54.419193 | 
2026-09-11 17:25:54.419372 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-11 17:25:54.965221 | instance | changed:
2026-09-11 17:25:54.965383 | instance | cd+++++++++ pod-logs/
2026-09-11 17:25:54.965413 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-11 17:25:54.974327 | 
2026-09-11 17:25:54.974394 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-11 17:25:55.190246 | instance | changed
2026-09-11 17:25:55.197842 | 
2026-09-11 17:25:55.197929 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-11 17:25:55.438804 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:25:55.746121 | instance | ok: Runtime: 0:00:00.048344
2026-09-11 17:25:55.756447 | 
2026-09-11 17:25:55.756598 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-11 17:25:56.029031 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:25:56.063744 | instance | ceph-mgr endpoints:
2026-09-11 17:25:56.305705 | instance | ok: Runtime: 0:00:00.041013
2026-09-11 17:25:56.316339 | 
2026-09-11 17:25:56.316491 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-11 17:25:56.563933 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-11 17:25:56.866541 | instance | ok: Runtime: 0:00:00.035858
2026-09-11 17:25:56.877994 | 
2026-09-11 17:25:56.878126 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-11 17:25:57.404440 | instance | changed: cd+++++++++ prometheus/
2026-09-11 17:25:57.415769 | 
2026-09-11 17:25:57.415872 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-11 17:25:57.654579 | instance | changed
2026-09-11 17:25:57.660660 | 
2026-09-11 17:25:57.660743 | TASK [gather-selenium-data : Get selenium data]
2026-09-11 17:25:57.960409 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-11 17:25:57.961913 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-11 17:25:58.194327 | instance | ERROR
2026-09-11 17:25:58.194490 | instance | {
2026-09-11 17:25:58.194517 | instance |   "delta": "0:00:00.007173",
2026-09-11 17:25:58.194535 | instance |   "end": "2026-09-11 17:25:57.962381",
2026-09-11 17:25:58.194551 | instance |   "msg": "non-zero return code",
2026-09-11 17:25:58.194566 | instance |   "rc": 1,
2026-09-11 17:25:58.194583 | instance |   "start": "2026-09-11 17:25:57.955208"
2026-09-11 17:25:58.194598 | instance | }
2026-09-11 17:25:58.194619 | instance | ERROR: Ignoring Errors
2026-09-11 17:25:58.198668 | 
2026-09-11 17:25:58.198726 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-11 17:25:58.761459 | instance | changed: cd+++++++++ selenium/
2026-09-11 17:25:58.770222 | 
2026-09-11 17:25:58.770540 | PLAY RECAP
2026-09-11 17:25:58.770696 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-11 17:25:58.770739 | 
2026-09-11 17:25:58.883347 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:25:58.885495 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:25:59.413048 | 
2026-09-11 17:25:59.413149 | PLAY [all]
2026-09-11 17:25:59.423101 | 
2026-09-11 17:25:59.423173 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-11 17:25:59.477859 | instance | skipping: Conditional result was False
2026-09-11 17:25:59.483774 | 
2026-09-11 17:25:59.483893 | TASK [fetch-output : Set log path for single node]
2026-09-11 17:25:59.526200 | instance | ok
2026-09-11 17:25:59.534551 | 
2026-09-11 17:25:59.534684 | LOOP [fetch-output : Ensure local output dirs]
2026-09-11 17:25:59.941778 | instance -> localhost | ok: "/var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/logs"
2026-09-11 17:26:00.160799 | instance -> localhost | changed: "/var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/artifacts"
2026-09-11 17:26:00.375963 | instance -> localhost | changed: "/var/lib/zuul/builds/5c39cff44a51416d98eb4971f6d534c9/work/docs"
2026-09-11 17:26:00.392908 | 
2026-09-11 17:26:00.393091 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-11 17:26:01.053728 | instance | changed: .d..t...... ./
2026-09-11 17:26:01.054094 | instance | changed: All items complete
2026-09-11 17:26:01.054154 | 
2026-09-11 17:26:01.531403 | instance | changed: .d..t...... ./
2026-09-11 17:26:02.021405 | instance | changed: .d..t...... ./
2026-09-11 17:26:02.043333 | 
2026-09-11 17:26:02.043552 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-11 17:26:02.469356 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.005944
2026-09-11 17:26:02.701298 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007259
2026-09-11 17:26:02.720137 | 
2026-09-11 17:26:02.720211 | PLAY [all]
2026-09-11 17:26:02.726969 | 
2026-09-11 17:26:02.727063 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-11 17:26:03.124858 | instance | changed
2026-09-11 17:26:03.135455 | 
2026-09-11 17:26:03.135587 | PLAY RECAP
2026-09-11 17:26:03.135712 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-11 17:26:03.135773 | 
2026-09-11 17:26:03.243970 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:26:03.247736 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-11 17:26:03.862987 | 
2026-09-11 17:26:03.863101 | PLAY [localhost]
2026-09-11 17:26:03.871692 | 
2026-09-11 17:26:03.871756 | TASK [Generate Zuul manifest]
2026-09-11 17:26:03.887428 | localhost | ok
2026-09-11 17:26:03.901783 | 
2026-09-11 17:26:03.901877 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-11 17:26:04.285134 | localhost | changed
2026-09-11 17:26:04.303773 | 
2026-09-11 17:26:04.303936 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-11 17:26:04.340767 | localhost | ok
2026-09-11 17:26:04.353355 | 
2026-09-11 17:26:04.353484 | TASK [Upload logs]
2026-09-11 17:26:04.375756 | localhost | ok
2026-09-11 17:26:04.445143 | 
2026-09-11 17:26:04.445246 | TASK [Set zuul-log-path fact]
2026-09-11 17:26:04.461142 | localhost | ok
2026-09-11 17:26:04.471035 | 
2026-09-11 17:26:04.471095 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:26:04.498525 | localhost | ok
2026-09-11 17:26:04.506543 | 
2026-09-11 17:26:04.506631 | TASK [upload-logs : Create log directories]
2026-09-11 17:26:04.948293 | localhost | changed
2026-09-11 17:26:04.952415 | 
2026-09-11 17:26:04.952480 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-11 17:26:05.327127 | localhost -> localhost | ok: Runtime: 0:00:00.004106
2026-09-11 17:26:05.336108 | 
2026-09-11 17:26:05.336230 | TASK [upload-logs : Upload logs to log server]
2026-09-11 17:26:05.824660 | localhost | Output suppressed because no_log was given
2026-09-11 17:26:05.869904 | 
2026-09-11 17:26:05.870059 | LOOP [upload-logs : Compress console log and json output]
2026-09-11 17:26:05.931020 | localhost | skipping: Conditional result was False
2026-09-11 17:26:05.940278 | localhost | skipping: Conditional result was False
2026-09-11 17:26:05.953206 | 
2026-09-11 17:26:05.953433 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-11 17:26:05.997644 | localhost | skipping: Conditional result was False
2026-09-11 17:26:05.998066 | 
2026-09-11 17:26:06.001718 | localhost | skipping: Conditional result was False
2026-09-11 17:26:06.017344 | 
2026-09-11 17:26:06.017564 | LOOP [upload-logs : Upload console log and json output]