2026-09-07 03:19:55.915251 | Job console starting
2026-09-07 03:19:55.930325 | Updating git repos
2026-09-07 03:20:02.060235 | Cloning repos into workspace
2026-09-07 03:20:17.831149 | Restoring repo states
2026-09-07 03:20:23.767380 | Merging changes
2026-09-07 03:20:24.641136 | Checking out repos
2026-09-07 03:20:26.274544 | Preparing playbooks
2026-09-07 03:20:28.945135 | Running Ansible setup
2026-09-07 03:20:32.888648 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 03:20:33.495676 | 
2026-09-07 03:20:33.495825 | PLAY [localhost]
2026-09-07 03:20:33.516157 | 
2026-09-07 03:20:33.516459 | TASK [Gathering Facts]
2026-09-07 03:20:34.504782 | localhost | ok
2026-09-07 03:20:34.510664 | 
2026-09-07 03:20:34.510747 | TASK [Setup log path fact]
2026-09-07 03:20:34.538675 | localhost | ok
2026-09-07 03:20:34.551488 | 
2026-09-07 03:20:34.551612 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 03:20:34.592631 | localhost | ok
2026-09-07 03:20:34.600759 | 
2026-09-07 03:20:34.600862 | TASK [emit-job-header : Print job information]
2026-09-07 03:20:34.631713 | # Job Information
2026-09-07 03:20:34.631893 | Ansible Version: 2.16.18
2026-09-07 03:20:34.631941 | Job: atmosphere-molecule-csi-rbd
2026-09-07 03:20:34.631970 | Pipeline: check
2026-09-07 03:20:34.631996 | Executor: 2d72f0692154
2026-09-07 03:20:34.632021 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090
2026-09-07 03:20:34.632050 | Event ID: 6481cec0-aa6a-11f1-93ea-2a50bc4e7375
2026-09-07 03:20:34.636154 | 
2026-09-07 03:20:34.636251 | LOOP [emit-job-header : Print node information]
2026-09-07 03:20:34.774751 | localhost | ok:
2026-09-07 03:20:34.775089 | localhost | # Node Information
2026-09-07 03:20:34.775173 | localhost | Inventory Hostname: instance
2026-09-07 03:20:34.775233 | localhost | Hostname: np0000192016
2026-09-07 03:20:34.775278 | localhost | Username: zuul
2026-09-07 03:20:34.775335 | localhost | Distro: Ubuntu 22.04
2026-09-07 03:20:34.775391 | localhost | Provider: yul1
2026-09-07 03:20:34.775437 | localhost | Region: ca-ymq-1
2026-09-07 03:20:34.775480 | localhost | Label: ubuntu-jammy
2026-09-07 03:20:34.775549 | localhost | Product Name: OpenStack Nova
2026-09-07 03:20:34.775592 | localhost | Interface IP: 162.253.55.186
2026-09-07 03:20:34.789829 | 
2026-09-07 03:20:34.790029 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-07 03:20:35.284738 | localhost -> localhost | changed
2026-09-07 03:20:35.296709 | 
2026-09-07 03:20:35.296929 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-07 03:20:36.231157 | localhost -> localhost | changed
2026-09-07 03:20:36.243117 | 
2026-09-07 03:20:36.243236 | PLAY [all]
2026-09-07 03:20:36.260605 | 
2026-09-07 03:20:36.260806 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-07 03:20:36.530718 | instance -> localhost | ok
2026-09-07 03:20:36.541768 | 
2026-09-07 03:20:36.541910 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-07 03:20:36.576421 | instance | ok
2026-09-07 03:20:36.602167 | instance | included: /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-07 03:20:36.610078 | 
2026-09-07 03:20:36.610196 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-07 03:20:37.853981 | instance -> localhost | Generating public/private rsa key pair.
2026-09-07 03:20:37.854315 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/ca0e66f6d6bb4858914013cade1948f7_id_rsa
2026-09-07 03:20:37.854348 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/ca0e66f6d6bb4858914013cade1948f7_id_rsa.pub
2026-09-07 03:20:37.854368 | instance -> localhost | The key fingerprint is:
2026-09-07 03:20:37.854387 | instance -> localhost | SHA256:K73AUcgjA6s9qOeG2a2FQY6Ehg/H3dRtr6kC1MKuaWE zuul-build-sshkey
2026-09-07 03:20:37.854430 | instance -> localhost | The key's randomart image is:
2026-09-07 03:20:37.854449 | instance -> localhost | +---[RSA 3072]----+
2026-09-07 03:20:37.854474 | instance -> localhost | |  .   .. .       |
2026-09-07 03:20:37.854505 | instance -> localhost | |o. + + .. o      |
2026-09-07 03:20:37.854524 | instance -> localhost | |+o=.+.= .. .     |
2026-09-07 03:20:37.854542 | instance -> localhost | |o@  +o.o    .    |
2026-09-07 03:20:37.854559 | instance -> localhost | |+ *o .. S  o     |
2026-09-07 03:20:37.854575 | instance -> localhost | |. E+o. o .o      |
2026-09-07 03:20:37.854592 | instance -> localhost | |.=o=..+ o.       |
2026-09-07 03:20:37.854609 | instance -> localhost | |oo*.. .o..       |
2026-09-07 03:20:37.854628 | instance -> localhost | | oo.   ..        |
2026-09-07 03:20:37.854645 | instance -> localhost | +----[SHA256]-----+
2026-09-07 03:20:37.854876 | instance -> localhost | ok: Runtime: 0:00:00.783829
2026-09-07 03:20:37.861820 | 
2026-09-07 03:20:37.862000 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-07 03:20:37.892726 | instance | ok
2026-09-07 03:20:37.903428 | instance | included: /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-07 03:20:37.912962 | 
2026-09-07 03:20:37.913049 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-07 03:20:37.929014 | instance | skipping: Conditional result was False
2026-09-07 03:20:37.936363 | 
2026-09-07 03:20:37.936461 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-07 03:20:38.411152 | instance | changed
2026-09-07 03:20:38.426658 | 
2026-09-07 03:20:38.426875 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-07 03:20:38.612293 | instance | ok
2026-09-07 03:20:38.622736 | 
2026-09-07 03:20:38.622966 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-07 03:20:39.143508 | instance | changed
2026-09-07 03:20:39.147910 | 
2026-09-07 03:20:39.147991 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-07 03:20:39.640183 | instance | changed
2026-09-07 03:20:39.652752 | 
2026-09-07 03:20:39.653010 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-07 03:20:39.669047 | instance | skipping: Conditional result was False
2026-09-07 03:20:39.675770 | 
2026-09-07 03:20:39.675922 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-07 03:20:40.070829 | instance -> localhost | changed
2026-09-07 03:20:40.100165 | 
2026-09-07 03:20:40.100284 | TASK [add-build-sshkey : Add back temp key]
2026-09-07 03:20:40.424897 | instance -> localhost | Identity added: /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/ca0e66f6d6bb4858914013cade1948f7_id_rsa (zuul-build-sshkey)
2026-09-07 03:20:40.425088 | instance -> localhost | ok: Runtime: 0:00:00.015442
2026-09-07 03:20:40.429483 | 
2026-09-07 03:20:40.429565 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-07 03:20:40.739071 | instance | ok
2026-09-07 03:20:40.748226 | 
2026-09-07 03:20:40.748381 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-07 03:20:40.783764 | instance | skipping: Conditional result was False
2026-09-07 03:20:40.797859 | 
2026-09-07 03:20:40.798048 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-07 03:20:41.235850 | instance | ok
2026-09-07 03:20:41.247267 | 
2026-09-07 03:20:41.247395 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-07 03:20:44.839305 | instance | Output suppressed because no_log was given
2026-09-07 03:20:44.857878 | 
2026-09-07 03:20:44.858066 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-07 03:20:45.046582 | instance | ok: "logs"
2026-09-07 03:20:45.046953 | instance | ok: All items complete
2026-09-07 03:20:45.047014 | 
2026-09-07 03:20:45.228786 | instance | ok: "artifacts"
2026-09-07 03:20:45.400606 | instance | ok: "docs"
2026-09-07 03:20:45.413742 | 
2026-09-07 03:20:45.414349 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-07 03:20:45.625407 | instance | changed: "logs"
2026-09-07 03:20:45.804228 | instance | changed: "artifacts"
2026-09-07 03:20:45.984648 | instance | changed: "docs"
2026-09-07 03:20:46.002781 | 
2026-09-07 03:20:46.002882 | PLAY RECAP
2026-09-07 03:20:46.002960 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-07 03:20:46.002992 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:20:46.003015 | 
2026-09-07 03:20:46.165856 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 03:20:46.169072 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 03:20:46.816730 | 
2026-09-07 03:20:46.816858 | PLAY [all]
2026-09-07 03:20:46.826832 | 
2026-09-07 03:20:46.826911 | TASK [setup-uv : Extract archive]
2026-09-07 03:20:49.284778 | instance | changed
2026-09-07 03:20:49.290362 | 
2026-09-07 03:20:49.290439 | TASK [setup-uv : Print version]
2026-09-07 03:20:49.703287 | instance | uv 0.8.13
2026-09-07 03:20:49.823745 | instance | ok: Runtime: 0:00:00.013834
2026-09-07 03:20:49.841552 | 
2026-09-07 03:20:49.841780 | TASK [Install Ansible collection siblings]
2026-09-07 03:20:59.322213 | instance | changed:
2026-09-07 03:20:59.322495 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-07 03:20:59.322546 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-07 03:20:59.322586 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-07 03:20:59.322623 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-07 03:20:59.322661 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-07 03:20:59.322703 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-07 03:20:59.322742 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-07 03:20:59.322780 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-07 03:20:59.322817 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-07 03:20:59.322852 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-07 03:20:59.322886 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-07 03:20:59.322921 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-07 03:20:59.322955 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-07 03:20:59.322989 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-07 03:20:59.323024 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-07 03:20:59.323059 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-07 03:20:59.323093 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-07 03:20:59.323126 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-07 03:20:59.323159 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-07 03:20:59.323193 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-07 03:20:59.323227 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-07 03:20:59.323261 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-07 03:20:59.323296 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 03:20:59.323353 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-07 03:20:59.323390 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-07 03:20:59.323423 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 03:20:59.323456 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 03:20:59.323505 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 03:20:59.323540 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-07 03:20:59.323574 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-07 03:20:59.323607 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 03:20:59.323640 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 03:20:59.323675 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-07 03:20:59.323707 | 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-07 03:20:59.323743 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.323770 | instance | Process install dependency map
2026-09-07 03:20:59.323796 | instance | Starting collection install process
2026-09-07 03:20:59.323824 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-07 03:20:59.323853 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-07 03:20:59.323882 | instance | ansible.netcommon:* was installed successfully
2026-09-07 03:20:59.323912 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-07 03:20:59.323941 | instance | Creating virtual environment at: .venv
2026-09-07 03:20:59.323969 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 03:20:59.323998 | instance | Downloading setuptools (1.1MiB)
2026-09-07 03:20:59.324026 | instance | Downloading ansible-core (2.1MiB)
2026-09-07 03:20:59.324061 | instance | Downloading rjsonnet (1.2MiB)
2026-09-07 03:20:59.324095 | instance | Downloading cryptography (4.2MiB)
2026-09-07 03:20:59.324127 | instance | Downloading openstacksdk (1.7MiB)
2026-09-07 03:20:59.324159 | instance | Downloading kubernetes (1.9MiB)
2026-09-07 03:20:59.324191 | instance | Downloading netaddr (2.2MiB)
2026-09-07 03:20:59.324222 | instance | Downloading pygments (1.2MiB)
2026-09-07 03:20:59.324253 | instance |    Building pyperclip==1.9.0
2026-09-07 03:20:59.324285 | instance |  Downloading rjsonnet
2026-09-07 03:20:59.324320 | instance |  Downloading netaddr
2026-09-07 03:20:59.324351 | instance |  Downloading pygments
2026-09-07 03:20:59.324384 | instance |  Downloading cryptography
2026-09-07 03:20:59.324415 | instance |  Downloading setuptools
2026-09-07 03:20:59.324445 | instance |  Downloading kubernetes
2026-09-07 03:20:59.324484 | instance |  Downloading ansible-core
2026-09-07 03:20:59.324538 | instance |  Downloading openstacksdk
2026-09-07 03:20:59.324570 | instance |       Built pyperclip==1.9.0
2026-09-07 03:20:59.324599 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 03:20:59.324626 | instance | Installed 79 packages in 58ms
2026-09-07 03:20:59.324656 | instance | Checked out ansible.posix to 1.6.0
2026-09-07 03:20:59.324685 | 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-07 03:20:59.324714 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.324742 | instance | Process install dependency map
2026-09-07 03:20:59.324770 | instance | Starting collection install process
2026-09-07 03:20:59.324796 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-07 03:20:59.324834 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-07 03:20:59.324863 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-07 03:20:59.324890 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.324918 | instance | 2.17.12
2026-09-07 03:20:59.324945 | instance | Checked out ansible.utils to v6.1.0
2026-09-07 03:20:59.324974 | 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-07 03:20:59.325003 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.325033 | instance | Process install dependency map
2026-09-07 03:20:59.325064 | instance | Starting collection install process
2026-09-07 03:20:59.325092 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-07 03:20:59.325115 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-07 03:20:59.325139 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-07 03:20:59.325168 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.325199 | instance | 2.17.12
2026-09-07 03:20:59.325228 | instance | Checked out atmosphere.common to v0.7.0
2026-09-07 03:20:59.325259 | 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-07 03:20:59.325290 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.325320 | instance | Process install dependency map
2026-09-07 03:20:59.325352 | instance | Starting collection install process
2026-09-07 03:20:59.325382 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-07 03:20:59.325411 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-07 03:20:59.325439 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-07 03:20:59.325482 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.325511 | instance | 2.17.12
2026-09-07 03:20:59.325535 | instance | Checked out community.crypto to 2.2.3
2026-09-07 03:20:59.325561 | 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-07 03:20:59.325586 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.325610 | instance | Process install dependency map
2026-09-07 03:20:59.325632 | instance | Starting collection install process
2026-09-07 03:20:59.325653 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-07 03:20:59.325669 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-07 03:20:59.325685 | instance | community.crypto:2.2.3 was installed successfully
2026-09-07 03:20:59.325700 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.325716 | instance | 2.17.12
2026-09-07 03:20:59.325732 | instance | Checked out community.general to 7.3.0
2026-09-07 03:20:59.325752 | 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-07 03:20:59.325775 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.325804 | instance | Process install dependency map
2026-09-07 03:20:59.325827 | instance | Starting collection install process
2026-09-07 03:20:59.325851 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-07 03:20:59.325874 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-07 03:20:59.325898 | instance | community.general:7.3.0 was installed successfully
2026-09-07 03:20:59.325922 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.325947 | instance | 2.17.12
2026-09-07 03:20:59.325971 | instance | Checked out community.mysql to 3.6.0
2026-09-07 03:20:59.325996 | 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-07 03:20:59.326018 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326048 | instance | Process install dependency map
2026-09-07 03:20:59.326074 | instance | Starting collection install process
2026-09-07 03:20:59.326101 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-07 03:20:59.326127 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-07 03:20:59.326150 | instance | community.mysql:3.6.0 was installed successfully
2026-09-07 03:20:59.326170 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.326190 | instance | 2.17.12
2026-09-07 03:20:59.326207 | instance | Checked out kubernetes.core to 2.4.0
2026-09-07 03:20:59.326223 | 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-07 03:20:59.326240 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326256 | instance | Process install dependency map
2026-09-07 03:20:59.326272 | instance | Starting collection install process
2026-09-07 03:20:59.326288 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-07 03:20:59.326304 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-07 03:20:59.326319 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-07 03:20:59.326335 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.326350 | instance | 2.17.12
2026-09-07 03:20:59.326366 | instance | Checked out openstack.cloud to 2.6.0
2026-09-07 03:20:59.326381 | 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-07 03:20:59.326397 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326412 | instance | Process install dependency map
2026-09-07 03:20:59.326432 | instance | Starting collection install process
2026-09-07 03:20:59.326456 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-07 03:20:59.326493 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-07 03:20:59.326511 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-07 03:20:59.326527 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.326543 | instance | 2.17.12
2026-09-07 03:20:59.326559 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-07 03:20:59.326575 | 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-07 03:20:59.326597 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326614 | instance | Process install dependency map
2026-09-07 03:20:59.326630 | instance | Starting collection install process
2026-09-07 03:20:59.326646 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-07 03:20:59.326662 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-07 03:20:59.326677 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-07 03:20:59.326693 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.326708 | instance | 2.17.12
2026-09-07 03:20:59.326724 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-07 03:20:59.326740 | 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-07 03:20:59.326755 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326771 | instance | Process install dependency map
2026-09-07 03:20:59.326787 | instance | Starting collection install process
2026-09-07 03:20:59.326803 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-07 03:20:59.326820 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-07 03:20:59.326836 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-07 03:20:59.326851 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.326867 | instance | 2.17.12
2026-09-07 03:20:59.326882 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-07 03:20:59.326899 | 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-07 03:20:59.326914 | instance | Starting galaxy collection install process
2026-09-07 03:20:59.326930 | instance | Process install dependency map
2026-09-07 03:20:59.326945 | instance | Starting collection install process
2026-09-07 03:20:59.326961 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-07 03:20:59.326976 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-07 03:20:59.326993 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-07 03:20:59.327010 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:20:59.327034 | instance | 2.17.12
2026-09-07 03:20:59.332627 | 
2026-09-07 03:20:59.332676 | PLAY RECAP
2026-09-07 03:20:59.332815 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:20:59.332840 | 
2026-09-07 03:20:59.542598 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 03:20:59.547042 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 03:21:00.130503 | 
2026-09-07 03:21:00.130633 | PLAY [all]
2026-09-07 03:21:00.140478 | 
2026-09-07 03:21:00.140584 | TASK [Install "jq" for log collection]
2026-09-07 03:21:09.484292 | instance | changed
2026-09-07 03:21:09.486560 | 
2026-09-07 03:21:09.486630 | PLAY RECAP
2026-09-07 03:21:09.486694 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:21:09.486750 | 
2026-09-07 03:21:09.653931 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 03:21:09.655990 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 03:21:10.353751 | 
2026-09-07 03:21:10.353950 | PLAY [all]
2026-09-07 03:21:10.366321 | 
2026-09-07 03:21:10.366415 | LOOP [Check inventory directories]
2026-09-07 03:21:10.784057 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-07 03:21:10.959255 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-07 03:21:11.122159 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-07 03:21:11.137967 | 
2026-09-07 03:21:11.138228 | LOOP [Copy inventory file for Zuul]
2026-09-07 03:21:11.994633 | instance | changed:
2026-09-07 03:21:11.994945 | instance | {
2026-09-07 03:21:11.995022 | instance |   "ansible_loop_var": "item",
2026-09-07 03:21:11.995075 | instance |   "changed": false,
2026-09-07 03:21:11.995117 | instance |   "failed": false,
2026-09-07 03:21:11.995164 | instance |   "invocation": {
2026-09-07 03:21:11.995206 | instance |     "module_args": {
2026-09-07 03:21:11.995245 | instance |       "checksum_algorithm": "sha1",
2026-09-07 03:21:11.995285 | instance |       "follow": true,
2026-09-07 03:21:11.995340 | instance |       "get_attributes": true,
2026-09-07 03:21:11.995387 | instance |       "get_checksum": true,
2026-09-07 03:21:11.995427 | instance |       "get_mime": true,
2026-09-07 03:21:11.995489 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-07 03:21:11.995529 | instance |     }
2026-09-07 03:21:11.995566 | instance |   },
2026-09-07 03:21:11.995600 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-07 03:21:11.995635 | instance |   "stat": {
2026-09-07 03:21:11.995670 | instance |     "atime": 1788751252.0200913,
2026-09-07 03:21:11.995706 | instance |     "attr_flags": "e",
2026-09-07 03:21:11.995740 | instance |     "attributes": [
2026-09-07 03:21:11.995775 | instance |       "extents"
2026-09-07 03:21:11.995808 | instance |     ],
2026-09-07 03:21:11.995843 | instance |     "block_size": 4096,
2026-09-07 03:21:11.995876 | instance |     "blocks": 8,
2026-09-07 03:21:11.995911 | instance |     "charset": "unknown",
2026-09-07 03:21:11.995948 | instance |     "ctime": 1788751250.772064,
2026-09-07 03:21:11.995983 | instance |     "dev": 64513,
2026-09-07 03:21:11.996018 | instance |     "device_type": 0,
2026-09-07 03:21:11.996052 | instance |     "executable": true,
2026-09-07 03:21:11.996086 | instance |     "exists": true,
2026-09-07 03:21:11.996120 | instance |     "gid": 1000,
2026-09-07 03:21:11.996153 | instance |     "gr_name": "zuul",
2026-09-07 03:21:11.996187 | instance |     "inode": 1049145,
2026-09-07 03:21:11.996220 | instance |     "isblk": false,
2026-09-07 03:21:11.996255 | instance |     "ischr": false,
2026-09-07 03:21:11.996290 | instance |     "isdir": true,
2026-09-07 03:21:11.996325 | instance |     "isfifo": false,
2026-09-07 03:21:11.996358 | instance |     "isgid": false,
2026-09-07 03:21:11.996391 | instance |     "islnk": false,
2026-09-07 03:21:11.996424 | instance |     "isreg": false,
2026-09-07 03:21:11.996473 | instance |     "issock": false,
2026-09-07 03:21:11.996537 | instance |     "isuid": false,
2026-09-07 03:21:11.996573 | instance |     "mimetype": "unknown",
2026-09-07 03:21:11.996607 | instance |     "mode": "0755",
2026-09-07 03:21:11.996640 | instance |     "mtime": 1788751250.772064,
2026-09-07 03:21:11.996674 | instance |     "nlink": 21,
2026-09-07 03:21:11.996707 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-07 03:21:11.996741 | instance |     "pw_name": "zuul",
2026-09-07 03:21:11.996776 | instance |     "readable": true,
2026-09-07 03:21:11.996809 | instance |     "rgrp": true,
2026-09-07 03:21:11.996847 | instance |     "roth": true,
2026-09-07 03:21:11.996881 | instance |     "rusr": true,
2026-09-07 03:21:11.996915 | instance |     "size": 4096,
2026-09-07 03:21:11.996948 | instance |     "uid": 1000,
2026-09-07 03:21:11.997000 | instance |     "version": "743446812",
2026-09-07 03:21:11.997037 | instance |     "wgrp": false,
2026-09-07 03:21:11.997076 | instance |     "woth": false,
2026-09-07 03:21:11.997111 | instance |     "writeable": true,
2026-09-07 03:21:11.997146 | instance |     "wusr": true,
2026-09-07 03:21:11.997180 | instance |     "xgrp": true,
2026-09-07 03:21:11.997214 | instance |     "xoth": true,
2026-09-07 03:21:11.997248 | instance |     "xusr": true
2026-09-07 03:21:11.997281 | instance |   }
2026-09-07 03:21:11.997316 | instance | }
2026-09-07 03:21:11.997389 | instance | ok: All items complete
2026-09-07 03:21:11.997432 | 
2026-09-07 03:21:11.999762 | instance | skipping: Conditional result was False
2026-09-07 03:21:12.001007 | instance | skipping: Conditional result was False
2026-09-07 03:21:12.025374 | 
2026-09-07 03:21:12.025617 | LOOP [Switch "ansible_host" to private IP]
2026-09-07 03:21:12.401714 | instance | changed: 1 replacements made
2026-09-07 03:21:12.415115 | instance | skipping: Conditional result was False
2026-09-07 03:21:12.416760 | instance | skipping: Conditional result was False
2026-09-07 03:21:12.440693 | 
2026-09-07 03:21:12.440906 | TASK [Run Molecule scenario]
2026-09-07 03:21:13.400087 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-07 03:21:13.799844 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-07 03:21:13.799907 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-07 03:21:24.662986 | instance | INFO     [csi > dependency] Executing
2026-09-07 03:21:24.663596 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-07 03:21:24.664028 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-07 03:21:24.664305 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-07 03:21:24.679063 | instance | INFO     [csi > cleanup] Executing
2026-09-07 03:21:24.679724 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 03:21:24.693230 | instance | INFO     [csi > destroy] Executing
2026-09-07 03:21:24.693290 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-07 03:21:24.693398 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-07 03:21:24.702535 | instance | INFO     [csi > syntax] Executing
2026-09-07 03:21:26.269664 | instance |
2026-09-07 03:21:26.269837 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-07 03:21:26.372947 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-07 03:21:26.383268 | instance | INFO     [csi > create] Executing
2026-09-07 03:21:26.385651 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 03:21:26.395410 | instance | INFO     [csi > prepare] Executing
2026-09-07 03:21:27.300746 | instance |
2026-09-07 03:21:27.300941 | instance | PLAY [Prepare] *****************************************************************
2026-09-07 03:21:27.301218 | instance |
2026-09-07 03:21:27.301481 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:21:27.301736 | instance | Monday 07 September 2026  03:21:27 +0000 (0:00:00.028)       0:00:00.028 ******
2026-09-07 03:21:28.638205 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 03:21:28.638284 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 03:21:28.638362 | instance | interpreter could change the meaning of that path. See
2026-09-07 03:21:28.638493 | instance | https://docs.ansible.com/ansible-
2026-09-07 03:21:28.638616 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 03:21:28.649227 | instance | ok: [instance]
2026-09-07 03:21:28.649343 | instance |
2026-09-07 03:21:28.649557 | instance | TASK [Configure short hostname] ************************************************
2026-09-07 03:21:28.649676 | instance | Monday 07 September 2026  03:21:28 +0000 (0:00:01.349)       0:00:01.377 ******
2026-09-07 03:21:29.384935 | instance | changed: [instance]
2026-09-07 03:21:29.385146 | instance |
2026-09-07 03:21:29.385403 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-07 03:21:29.385664 | instance | Monday 07 September 2026  03:21:29 +0000 (0:00:00.735)       0:00:02.112 ******
2026-09-07 03:21:29.673460 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-07 03:21:29.673816 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-07 03:21:29.674210 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-07 03:21:29.683489 | instance | changed: [instance]
2026-09-07 03:21:29.683801 | instance |
2026-09-07 03:21:29.684154 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-07 03:21:29.684508 | instance | Monday 07 September 2026  03:21:29 +0000 (0:00:00.298)       0:00:02.411 ******
2026-09-07 03:21:30.490357 | instance | ok: [instance]
2026-09-07 03:21:30.490545 | instance |
2026-09-07 03:21:30.490789 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-07 03:21:30.491010 | instance |
2026-09-07 03:21:30.491282 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:21:30.491526 | instance | Monday 07 September 2026  03:21:30 +0000 (0:00:00.806)       0:00:03.218 ******
2026-09-07 03:21:31.266701 | instance | ok: [instance]
2026-09-07 03:21:31.267052 | instance |
2026-09-07 03:21:31.267407 | instance | TASK [Install depedencies] *****************************************************
2026-09-07 03:21:31.267713 | instance | Monday 07 September 2026  03:21:31 +0000 (0:00:00.775)       0:00:03.994 ******
2026-09-07 03:21:54.752625 | instance | changed: [instance]
2026-09-07 03:21:54.752746 | instance |
2026-09-07 03:21:54.753088 | instance | TASK [Start up service] ********************************************************
2026-09-07 03:21:54.753124 | instance | Monday 07 September 2026  03:21:54 +0000 (0:00:23.486)       0:00:27.481 ******
2026-09-07 03:21:55.297588 | instance | ok: [instance]
2026-09-07 03:21:55.297625 | instance |
2026-09-07 03:21:55.297631 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-07 03:21:55.297635 | instance | Monday 07 September 2026  03:21:55 +0000 (0:00:00.544)       0:00:28.026 ******
2026-09-07 03:21:55.638043 | instance | ok: [instance]
2026-09-07 03:21:55.638757 | instance |
2026-09-07 03:21:55.638805 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-07 03:21:55.638816 | instance | Monday 07 September 2026  03:21:55 +0000 (0:00:00.339)       0:00:28.366 ******
2026-09-07 03:21:56.373565 | instance | changed: [instance]
2026-09-07 03:21:56.374366 | instance |
2026-09-07 03:21:56.374428 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-07 03:21:56.374445 | instance | Monday 07 September 2026  03:21:56 +0000 (0:00:00.735)       0:00:29.101 ******
2026-09-07 03:21:56.606378 | instance | ok: [instance]
2026-09-07 03:21:56.607317 | instance |
2026-09-07 03:21:56.607374 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-07 03:21:56.607641 | instance | Monday 07 September 2026  03:21:56 +0000 (0:00:00.232)       0:00:29.334 ******
2026-09-07 03:21:56.629680 | instance | skipping: [instance]
2026-09-07 03:21:56.630422 | instance |
2026-09-07 03:21:56.630457 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-07 03:21:56.630468 | instance | Monday 07 September 2026  03:21:56 +0000 (0:00:00.023)       0:00:29.357 ******
2026-09-07 03:21:57.195047 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:21:57.196410 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:21:57.196443 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:21:57.196453 | instance |
2026-09-07 03:21:57.196463 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-07 03:21:57.196472 | instance | Monday 07 September 2026  03:21:57 +0000 (0:00:00.565)       0:00:29.923 ******
2026-09-07 03:21:57.874222 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:21:57.874274 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:21:57.874285 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:21:57.874294 | instance |
2026-09-07 03:21:57.874304 | instance | TASK [Start loop devices] ******************************************************
2026-09-07 03:21:57.874313 | instance | Monday 07 September 2026  03:21:57 +0000 (0:00:00.677)       0:00:30.601 ******
2026-09-07 03:21:59.610771 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:21:59.611312 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:21:59.611563 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:21:59.612489 | instance |
2026-09-07 03:21:59.612531 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-07 03:21:59.612546 | instance | Monday 07 September 2026  03:21:59 +0000 (0:00:01.737)       0:00:32.339 ******
2026-09-07 03:22:02.834994 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:22:02.835530 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:22:02.835603 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:22:02.836459 | instance |
2026-09-07 03:22:02.836537 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-07 03:22:02.836550 | instance | Monday 07 September 2026  03:22:02 +0000 (0:00:03.223)       0:00:35.562 ******
2026-09-07 03:22:04.928941 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-07 03:22:04.931289 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-07 03:22:04.931396 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-07 03:22:04.931409 | instance |
2026-09-07 03:22:04.931420 | instance | PLAY RECAP *********************************************************************
2026-09-07 03:22:04.931432 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-07 03:22:04.931441 | instance |
2026-09-07 03:22:04.931450 | instance | Monday 07 September 2026  03:22:04 +0000 (0:00:02.094)       0:00:37.657 ******
2026-09-07 03:22:04.931459 | instance | ===============================================================================
2026-09-07 03:22:04.931474 | instance | Install depedencies ---------------------------------------------------- 23.49s
2026-09-07 03:22:04.935358 | instance | Create a volume group for each loop device ------------------------------ 3.22s
2026-09-07 03:22:04.935453 | instance | Create a logical volume for each loop device ---------------------------- 2.09s
2026-09-07 03:22:04.935472 | instance | Start loop devices ------------------------------------------------------ 1.74s
2026-09-07 03:22:04.935484 | instance | Gathering Facts --------------------------------------------------------- 1.35s
2026-09-07 03:22:04.935496 | instance | Purge "snapd" package --------------------------------------------------- 0.81s
2026-09-07 03:22:04.935508 | instance | Gathering Facts --------------------------------------------------------- 0.78s
2026-09-07 03:22:04.935520 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.74s
2026-09-07 03:22:04.935533 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-07 03:22:04.935545 | instance | Set permissions on loopback devices ------------------------------------- 0.68s
2026-09-07 03:22:04.935558 | instance | Create devices for Ceph ------------------------------------------------- 0.57s
2026-09-07 03:22:04.935570 | instance | Start up service -------------------------------------------------------- 0.54s
2026-09-07 03:22:04.935582 | instance | Generate lvm.conf ------------------------------------------------------- 0.34s
2026-09-07 03:22:04.935595 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-07 03:22:04.935618 | instance | Get list of all loopback devices ---------------------------------------- 0.23s
2026-09-07 03:22:04.935774 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-09-07 03:22:05.052946 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-07 03:22:05.069047 | instance | INFO     [csi > converge] Executing
2026-09-07 03:22:06.515621 | instance |
2026-09-07 03:22:06.516160 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-07 03:22:06.516621 | instance |
2026-09-07 03:22:06.517008 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:22:06.517393 | instance | Monday 07 September 2026  03:22:06 +0000 (0:00:00.007)       0:00:00.007 ******
2026-09-07 03:22:07.595229 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 03:22:07.595614 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 03:22:07.596007 | instance | interpreter could change the meaning of that path. See
2026-09-07 03:22:07.596320 | instance | https://docs.ansible.com/ansible-
2026-09-07 03:22:07.596623 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 03:22:07.611724 | instance | ok: [instance]
2026-09-07 03:22:07.612180 | instance |
2026-09-07 03:22:07.612499 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-07 03:22:07.612843 | instance | Monday 07 September 2026  03:22:07 +0000 (0:00:01.096)       0:00:01.103 ******
2026-09-07 03:22:07.675610 | instance | ok: [instance] => {
2026-09-07 03:22:07.676008 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-07 03:22:07.676311 | instance | }
2026-09-07 03:22:07.676693 | instance |
2026-09-07 03:22:07.677038 | instance | PLAY [all] *********************************************************************
2026-09-07 03:22:07.677325 | instance |
2026-09-07 03:22:07.677616 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:22:07.677964 | instance | Monday 07 September 2026  03:22:07 +0000 (0:00:00.063)       0:00:01.167 ******
2026-09-07 03:22:08.636089 | instance | ok: [instance]
2026-09-07 03:22:08.636564 | instance |
2026-09-07 03:22:08.637018 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-07 03:22:08.637349 | instance | Monday 07 September 2026  03:22:08 +0000 (0:00:00.960)       0:00:02.127 ******
2026-09-07 03:22:08.854781 | instance | ok: [instance]
2026-09-07 03:22:08.855308 | instance |
2026-09-07 03:22:08.855665 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-07 03:22:08.856046 | instance |
2026-09-07 03:22:08.856400 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:22:08.856739 | instance | Monday 07 September 2026  03:22:08 +0000 (0:00:00.219)       0:00:02.346 ******
2026-09-07 03:22:09.891643 | instance | ok: [instance]
2026-09-07 03:22:09.892096 | instance |
2026-09-07 03:22:09.892503 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:22:09.892864 | instance | Monday 07 September 2026  03:22:09 +0000 (0:00:01.036)       0:00:03.382 ******
2026-09-07 03:22:10.223976 | instance | ok: [instance]
2026-09-07 03:22:10.224411 | instance |
2026-09-07 03:22:10.224741 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:22:10.225159 | instance | Monday 07 September 2026  03:22:10 +0000 (0:00:00.332)       0:00:03.715 ******
2026-09-07 03:22:10.277489 | instance | skipping: [instance]
2026-09-07 03:22:10.277933 | instance |
2026-09-07 03:22:10.278359 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-07 03:22:10.278770 | instance | Monday 07 September 2026  03:22:10 +0000 (0:00:00.053)       0:00:03.769 ******
2026-09-07 03:22:10.683680 | instance | changed: [instance]
2026-09-07 03:22:10.683882 | instance |
2026-09-07 03:22:10.684025 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:22:10.684163 | instance | Monday 07 September 2026  03:22:10 +0000 (0:00:00.406)       0:00:04.175 ******
2026-09-07 03:22:10.781592 | instance | ok: [instance] => {
2026-09-07 03:22:10.782060 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-07 03:22:10.782432 | instance | }
2026-09-07 03:22:10.782717 | instance |
2026-09-07 03:22:10.783122 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:22:10.783546 | instance | Monday 07 September 2026  03:22:10 +0000 (0:00:00.097)       0:00:04.272 ******
2026-09-07 03:22:11.543300 | instance | changed: [instance]
2026-09-07 03:22:11.543529 | instance |
2026-09-07 03:22:11.543858 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:22:11.544163 | instance | Monday 07 September 2026  03:22:11 +0000 (0:00:00.761)       0:00:05.034 ******
2026-09-07 03:22:11.612072 | instance | skipping: [instance]
2026-09-07 03:22:11.612342 | instance |
2026-09-07 03:22:11.612659 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:22:11.612947 | instance | Monday 07 September 2026  03:22:11 +0000 (0:00:00.069)       0:00:05.103 ******
2026-09-07 03:22:11.672465 | instance | skipping: [instance]
2026-09-07 03:22:11.672683 | instance |
2026-09-07 03:22:11.672973 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:22:11.673280 | instance | Monday 07 September 2026  03:22:11 +0000 (0:00:00.060)       0:00:05.164 ******
2026-09-07 03:22:11.937852 | instance | ok: [instance]
2026-09-07 03:22:11.938056 | instance |
2026-09-07 03:22:11.938302 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:22:11.938542 | instance | Monday 07 September 2026  03:22:11 +0000 (0:00:00.264)       0:00:05.429 ******
2026-09-07 03:22:13.188598 | instance | ok: [instance]
2026-09-07 03:22:13.188826 | instance |
2026-09-07 03:22:13.189156 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:22:13.189465 | instance | Monday 07 September 2026  03:22:13 +0000 (0:00:01.250)       0:00:06.680 ******
2026-09-07 03:22:13.276892 | instance | ok: [instance] => {
2026-09-07 03:22:13.277166 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-07 03:22:13.277444 | instance | }
2026-09-07 03:22:13.277661 | instance |
2026-09-07 03:22:13.277977 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:22:13.278286 | instance | Monday 07 September 2026  03:22:13 +0000 (0:00:00.088)       0:00:06.768 ******
2026-09-07 03:22:14.281230 | instance | changed: [instance]
2026-09-07 03:22:14.281785 | instance |
2026-09-07 03:22:14.282106 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:22:14.282407 | instance | Monday 07 September 2026  03:22:14 +0000 (0:00:01.004)       0:00:07.773 ******
2026-09-07 03:22:17.191777 | instance | changed: [instance]
2026-09-07 03:22:17.192003 | instance |
2026-09-07 03:22:17.192197 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-07 03:22:17.192385 | instance | Monday 07 September 2026  03:22:17 +0000 (0:00:02.909)       0:00:10.683 ******
2026-09-07 03:22:17.227852 | instance | skipping: [instance]
2026-09-07 03:22:17.228003 | instance |
2026-09-07 03:22:17.228237 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-07 03:22:17.228433 | instance | Monday 07 September 2026  03:22:17 +0000 (0:00:00.034)       0:00:10.717 ******
2026-09-07 03:22:17.263807 | instance | skipping: [instance]
2026-09-07 03:22:17.264175 | instance |
2026-09-07 03:22:17.264548 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-07 03:22:17.264766 | instance | Monday 07 September 2026  03:22:17 +0000 (0:00:00.036)       0:00:10.754 ******
2026-09-07 03:22:17.310443 | instance | skipping: [instance]
2026-09-07 03:22:17.310675 | instance |
2026-09-07 03:22:17.310958 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-07 03:22:17.311259 | instance | Monday 07 September 2026  03:22:17 +0000 (0:00:00.045)       0:00:10.800 ******
2026-09-07 03:22:23.439337 | instance | changed: [instance]
2026-09-07 03:22:23.439535 | instance |
2026-09-07 03:22:23.439547 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-07 03:22:23.439558 | instance | Monday 07 September 2026  03:22:23 +0000 (0:00:06.129)       0:00:16.929 ******
2026-09-07 03:22:24.128205 | instance | changed: [instance]
2026-09-07 03:22:24.128330 | instance |
2026-09-07 03:22:24.128488 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-07 03:22:24.128648 | instance | Monday 07 September 2026  03:22:24 +0000 (0:00:00.690)       0:00:17.620 ******
2026-09-07 03:22:25.191579 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-07 03:22:25.191725 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-07 03:22:25.191739 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-07 03:22:25.191760 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-07 03:22:25.192763 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-07 03:22:25.192856 | instance |
2026-09-07 03:22:25.192891 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-07 03:22:25.192909 | instance | Monday 07 September 2026  03:22:25 +0000 (0:00:01.062)       0:00:18.682 ******
2026-09-07 03:22:25.826353 | instance | changed: [instance]
2026-09-07 03:22:25.827419 | instance |
2026-09-07 03:22:25.827528 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-07 03:22:25.827540 | instance | Monday 07 September 2026  03:22:25 +0000 (0:00:00.608)       0:00:19.290 ******
2026-09-07 03:22:25.827550 | instance |
2026-09-07 03:22:25.827559 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 03:22:25.827579 | instance | Monday 07 September 2026  03:22:25 +0000 (0:00:00.028)       0:00:19.318 ******
2026-09-07 03:22:26.793178 | instance | ok: [instance]
2026-09-07 03:22:26.793288 | instance |
2026-09-07 03:22:26.793300 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-07 03:22:26.793442 | instance | Monday 07 September 2026  03:22:26 +0000 (0:00:00.967)       0:00:20.285 ******
2026-09-07 03:22:27.320403 | instance | changed: [instance]
2026-09-07 03:22:27.320560 | instance |
2026-09-07 03:22:27.320577 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-07 03:22:27.320591 | instance | Monday 07 September 2026  03:22:27 +0000 (0:00:00.524)       0:00:20.810 ******
2026-09-07 03:22:27.951745 | instance | changed: [instance]
2026-09-07 03:22:27.951921 | instance |
2026-09-07 03:22:27.952577 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:22:27.952661 | instance | Monday 07 September 2026  03:22:27 +0000 (0:00:00.633)       0:00:21.443 ******
2026-09-07 03:22:28.214279 | instance | ok: [instance]
2026-09-07 03:22:28.214362 | instance |
2026-09-07 03:22:28.214849 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:22:28.214902 | instance | Monday 07 September 2026  03:22:28 +0000 (0:00:00.262)       0:00:21.706 ******
2026-09-07 03:22:28.285300 | instance | ok: [instance] => {
2026-09-07 03:22:28.285884 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-07 03:22:28.285952 | instance | }
2026-09-07 03:22:28.285959 | instance |
2026-09-07 03:22:28.285964 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:22:28.285969 | instance | Monday 07 September 2026  03:22:28 +0000 (0:00:00.070)       0:00:21.776 ******
2026-09-07 03:22:29.133469 | instance | changed: [instance]
2026-09-07 03:22:29.133589 | instance |
2026-09-07 03:22:29.134118 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:22:29.134182 | instance | Monday 07 September 2026  03:22:29 +0000 (0:00:00.848)       0:00:22.625 ******
2026-09-07 03:22:33.560935 | instance | changed: [instance]
2026-09-07 03:22:33.561046 | instance |
2026-09-07 03:22:33.561388 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-07 03:22:33.561435 | instance | Monday 07 September 2026  03:22:33 +0000 (0:00:04.426)       0:00:27.051 ******
2026-09-07 03:22:34.681115 | instance | ok: [instance]
2026-09-07 03:22:34.681583 | instance |
2026-09-07 03:22:34.681729 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-07 03:22:34.681737 | instance | Monday 07 September 2026  03:22:34 +0000 (0:00:01.121)       0:00:28.173 ******
2026-09-07 03:22:35.091900 | instance | changed: [instance]
2026-09-07 03:22:35.092624 | instance |
2026-09-07 03:22:35.092680 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-07 03:22:35.092691 | instance | Monday 07 September 2026  03:22:35 +0000 (0:00:00.410)       0:00:28.583 ******
2026-09-07 03:22:35.592751 | instance | changed: [instance]
2026-09-07 03:22:35.593587 | instance |
2026-09-07 03:22:35.593659 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-07 03:22:35.593671 | instance | Monday 07 September 2026  03:22:35 +0000 (0:00:00.500)       0:00:29.084 ******
2026-09-07 03:22:36.201701 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-07 03:22:36.201867 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-07 03:22:36.202991 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-07 03:22:36.203058 | instance |
2026-09-07 03:22:36.203070 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-07 03:22:36.203080 | instance | Monday 07 September 2026  03:22:36 +0000 (0:00:00.609)       0:00:29.693 ******
2026-09-07 03:22:36.731330 | instance | changed: [instance]
2026-09-07 03:22:36.731926 | instance |
2026-09-07 03:22:36.731994 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-07 03:22:36.732010 | instance | Monday 07 September 2026  03:22:36 +0000 (0:00:00.529)       0:00:30.222 ******
2026-09-07 03:22:37.249472 | instance | changed: [instance]
2026-09-07 03:22:37.249542 | instance |
2026-09-07 03:22:37.249550 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-07 03:22:37.249558 | instance | Monday 07 September 2026  03:22:37 +0000 (0:00:00.493)       0:00:30.716 ******
2026-09-07 03:22:37.249565 | instance |
2026-09-07 03:22:37.249572 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 03:22:37.249579 | instance | Monday 07 September 2026  03:22:37 +0000 (0:00:00.023)       0:00:30.740 ******
2026-09-07 03:22:37.988922 | instance | ok: [instance]
2026-09-07 03:22:37.989003 | instance |
2026-09-07 03:22:37.989260 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-07 03:22:37.989322 | instance | Monday 07 September 2026  03:22:37 +0000 (0:00:00.741)       0:00:31.481 ******
2026-09-07 03:22:38.882646 | instance | changed: [instance]
2026-09-07 03:22:38.883088 | instance |
2026-09-07 03:22:38.883109 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-07 03:22:38.883117 | instance | Monday 07 September 2026  03:22:38 +0000 (0:00:00.893)       0:00:32.375 ******
2026-09-07 03:22:39.507901 | instance | changed: [instance]
2026-09-07 03:22:39.507955 | instance |
2026-09-07 03:22:39.507963 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-07 03:22:39.507971 | instance | Monday 07 September 2026  03:22:39 +0000 (0:00:00.623)       0:00:32.999 ******
2026-09-07 03:22:39.576681 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-07 03:22:39.577417 | instance |
2026-09-07 03:22:39.577478 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-07 03:22:39.577490 | instance | Monday 07 September 2026  03:22:39 +0000 (0:00:00.069)       0:00:33.068 ******
2026-09-07 03:22:44.990301 | instance | changed: [instance]
2026-09-07 03:22:44.990515 | instance |
2026-09-07 03:22:44.990961 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-07 03:22:44.991046 | instance | Monday 07 September 2026  03:22:44 +0000 (0:00:05.413)       0:00:38.482 ******
2026-09-07 03:22:45.658641 | instance | ok: [instance] => (item=chronyd)
2026-09-07 03:22:45.658761 | instance | ok: [instance] => (item=sshd)
2026-09-07 03:22:45.659280 | instance |
2026-09-07 03:22:45.659322 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-07 03:22:45.659330 | instance | Monday 07 September 2026  03:22:45 +0000 (0:00:00.668)       0:00:39.151 ******
2026-09-07 03:22:51.817522 | instance | changed: [instance]
2026-09-07 03:22:51.818256 | instance |
2026-09-07 03:22:51.818305 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-07 03:22:51.818316 | instance | Monday 07 September 2026  03:22:51 +0000 (0:00:06.158)       0:00:45.309 ******
2026-09-07 03:22:52.058728 | instance | ok: [instance]
2026-09-07 03:22:52.058787 | instance |
2026-09-07 03:22:52.059032 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-07 03:22:52.059072 | instance | Monday 07 September 2026  03:22:52 +0000 (0:00:00.241)       0:00:45.551 ******
2026-09-07 03:22:52.625650 | instance | changed: [instance]
2026-09-07 03:22:52.626460 | instance |
2026-09-07 03:22:52.626537 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-07 03:22:52.626551 | instance | Monday 07 September 2026  03:22:52 +0000 (0:00:00.565)       0:00:46.116 ******
2026-09-07 03:22:52.969585 | instance | changed: [instance]
2026-09-07 03:22:52.969719 | instance |
2026-09-07 03:22:52.969732 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-07 03:22:52.969865 | instance | Monday 07 September 2026  03:22:52 +0000 (0:00:00.345)       0:00:46.461 ******
2026-09-07 03:22:53.110885 | instance | ok: [instance]
2026-09-07 03:22:53.111291 | instance |
2026-09-07 03:22:53.111363 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-07 03:22:53.111759 | instance | Monday 07 September 2026  03:22:53 +0000 (0:00:00.140)       0:00:46.602 ******
2026-09-07 03:22:53.380950 | instance | ok: [instance] => (item=instance)
2026-09-07 03:22:53.381111 | instance |
2026-09-07 03:22:53.381399 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-07 03:22:53.381461 | instance | Monday 07 September 2026  03:22:53 +0000 (0:00:00.270)       0:00:46.873 ******
2026-09-07 03:22:53.460432 | instance | ok: [instance]
2026-09-07 03:22:53.460521 | instance |
2026-09-07 03:22:53.460537 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-07 03:22:53.460551 | instance | Monday 07 September 2026  03:22:53 +0000 (0:00:00.077)       0:00:46.950 ******
2026-09-07 03:22:53.561601 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-07 03:22:53.561749 | instance |
2026-09-07 03:22:53.561766 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-07 03:22:53.561932 | instance | Monday 07 September 2026  03:22:53 +0000 (0:00:00.102)       0:00:47.053 ******
2026-09-07 03:22:53.909262 | instance | changed: [instance]
2026-09-07 03:22:53.910154 | instance |
2026-09-07 03:22:53.910242 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-07 03:22:53.910256 | instance | Monday 07 September 2026  03:22:53 +0000 (0:00:00.346)       0:00:47.400 ******
2026-09-07 03:22:54.711717 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-07 03:22:54.713105 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-07 03:22:54.713174 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-07 03:22:54.713185 | instance |
2026-09-07 03:22:54.713195 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-07 03:22:54.713205 | instance | Monday 07 September 2026  03:22:54 +0000 (0:00:00.803)       0:00:48.203 ******
2026-09-07 03:24:27.379034 | instance | ok: [instance]
2026-09-07 03:24:27.379077 | instance |
2026-09-07 03:24:27.379084 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-07 03:24:27.379091 | instance | Monday 07 September 2026  03:24:27 +0000 (0:01:32.667)       0:02:20.870 ******
2026-09-07 03:24:27.674974 | instance | changed: [instance]
2026-09-07 03:24:27.675201 | instance |
2026-09-07 03:24:27.675459 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-07 03:24:27.675715 | instance | Monday 07 September 2026  03:24:27 +0000 (0:00:00.296)       0:02:21.166 ******
2026-09-07 03:24:27.757497 | instance | ok: [instance]
2026-09-07 03:24:27.757558 | instance |
2026-09-07 03:24:27.757679 | instance | TASK [Install Ceph host] *******************************************************
2026-09-07 03:24:27.757787 | instance | Monday 07 September 2026  03:24:27 +0000 (0:00:00.083)       0:02:21.250 ******
2026-09-07 03:24:27.828729 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-07 03:24:27.828772 | instance |
2026-09-07 03:24:27.828777 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-07 03:24:27.828782 | instance | Monday 07 September 2026  03:24:27 +0000 (0:00:00.070)       0:02:21.320 ******
2026-09-07 03:24:29.530212 | instance | ok: [instance]
2026-09-07 03:24:29.531318 | instance |
2026-09-07 03:24:29.531375 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-07 03:24:29.531642 | instance | Monday 07 September 2026  03:24:29 +0000 (0:00:01.700)       0:02:23.021 ******
2026-09-07 03:24:29.596210 | instance | ok: [instance] => (item=instance)
2026-09-07 03:24:29.596428 | instance |
2026-09-07 03:24:29.596711 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-07 03:24:29.596966 | instance | Monday 07 September 2026  03:24:29 +0000 (0:00:00.066)       0:02:23.087 ******
2026-09-07 03:24:29.946113 | instance | ok: [instance]
2026-09-07 03:24:29.946166 | instance |
2026-09-07 03:24:29.946272 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-07 03:24:29.946384 | instance | Monday 07 September 2026  03:24:29 +0000 (0:00:00.350)       0:02:23.438 ******
2026-09-07 03:24:32.721126 | instance | ok: [instance]
2026-09-07 03:24:32.721200 | instance |
2026-09-07 03:24:32.721335 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-07 03:24:32.721485 | instance | Monday 07 September 2026  03:24:32 +0000 (0:00:02.774)       0:02:26.213 ******
2026-09-07 03:25:19.518425 | 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-07 03:25:19.518534 | 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_r0g5g7gc/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_r0g5g7gc/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_r0g5g7gc/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_r0g5g7gc/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-07T03:25:19.328+0000 7f367a4e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBBLp5qAL0LFyAAUBSs2s0I5W23tl1749oxowv6Vq8pKikZeTXOlWqwH3A=: Malformed input [buffer:3]\n2026-09-07T03:25:19.328+0000 7f367a4e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:25:19.332+0000 7f367a4e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBBLp5qAL0LFyAAUBSs2s0I5W23tl1749oxowv6Vq8pKikZeTXOlWqwH3A=: Malformed input [buffer:3]\n2026-09-07T03:25:19.332+0000 7f367a4e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:25:19.332+0000 7f367a4e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBBLp5qAL0LFyAAUBSs2s0I5W23tl1749oxowv6Vq8pKikZeTXOlWqwH3A=: Malformed input [buffer:3]\n2026-09-07T03:25:19.332+0000 7f367a4e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:25:19.332+0000 7f367a4e3640 -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-07 03:25:19.520639 | instance |
2026-09-07 03:25:19.523277 | instance | PLAY RECAP *********************************************************************
2026-09-07 03:25:19.523325 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-07 03:25:19.523333 | instance |
2026-09-07 03:25:19.523339 | instance | Monday 07 September 2026  03:25:19 +0000 (0:00:46.799)       0:03:13.013 ******
2026-09-07 03:25:19.523345 | instance | ===============================================================================
2026-09-07 03:25:19.523350 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 92.67s
2026-09-07 03:25:19.523356 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 46.80s
2026-09-07 03:25:19.523361 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 6.16s
2026-09-07 03:25:19.523366 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.13s
2026-09-07 03:25:19.523372 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.41s
2026-09-07 03:25:19.523469 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.43s
2026-09-07 03:25:19.523876 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.91s
2026-09-07 03:25:19.524241 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.78s
2026-09-07 03:25:19.524752 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.71s
2026-09-07 03:25:19.525122 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.70s
2026-09-07 03:25:19.525543 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.25s
2026-09-07 03:25:19.525962 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.12s
2026-09-07 03:25:19.526357 | instance | Gathering Facts --------------------------------------------------------- 1.10s
2026-09-07 03:25:19.526798 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.06s
2026-09-07 03:25:19.527325 | instance | Gathering Facts --------------------------------------------------------- 1.04s
2026-09-07 03:25:19.527796 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.00s
2026-09-07 03:25:19.528184 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-07 03:25:19.528628 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.89s
2026-09-07 03:25:19.528966 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.85s
2026-09-07 03:25:19.529311 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.80s
2026-09-07 03:25:19.629836 | 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-07 03:25:19.630150 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-07 03:25:19.630383 | 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-07 03:25:19.819641 | instance | ERROR
2026-09-07 03:25:19.819920 | instance | {
2026-09-07 03:25:19.819999 | instance |   "delta": "0:04:06.863922",
2026-09-07 03:25:19.820043 | instance |   "end": "2026-09-07 03:25:19.702359",
2026-09-07 03:25:19.820080 | instance |   "msg": "non-zero return code",
2026-09-07 03:25:19.820115 | instance |   "rc": 2,
2026-09-07 03:25:19.820150 | instance |   "start": "2026-09-07 03:21:12.838437"
2026-09-07 03:25:19.820185 | instance | }
failure
2026-09-07 03:25:19.828827 | 
2026-09-07 03:25:19.828933 | PLAY RECAP
2026-09-07 03:25:19.829029 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:25:19.829084 | 
2026-09-07 03:25:19.959518 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 03:25:19.964052 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 03:25:20.654904 | 
2026-09-07 03:25:20.655083 | PLAY [all]
2026-09-07 03:25:20.672399 | 
2026-09-07 03:25:20.672531 | TASK [gather-host-logs : creating directory for system status]
2026-09-07 03:25:21.091094 | instance | changed
2026-09-07 03:25:21.101887 | 
2026-09-07 03:25:21.102119 | TASK [gather-host-logs : Get logs for each host]
2026-09-07 03:25:21.520425 | instance | + systemd-cgls --full --all --no-pager
2026-09-07 03:25:21.534819 | instance | + ip addr
2026-09-07 03:25:21.537979 | instance | + ip route
2026-09-07 03:25:21.540236 | instance | + lsblk
2026-09-07 03:25:21.544839 | instance | + mount
2026-09-07 03:25:21.547547 | instance | + docker images
2026-09-07 03:25:21.571628 | instance | + brctl show
2026-09-07 03:25:21.572033 | instance | /bin/bash: line 8: brctl: command not found
2026-09-07 03:25:21.572245 | instance | + ps aux --sort=-%mem
2026-09-07 03:25:21.591612 | instance | + dpkg -l
2026-09-07 03:25:21.603861 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-07 03:25:21.604292 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-07 03:25:21.623683 | instance | + '[' '!' -z '' ']'
2026-09-07 03:25:21.657241 | instance | ok: Runtime: 0:00:00.106437
2026-09-07 03:25:21.663092 | 
2026-09-07 03:25:21.663154 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-07 03:25:22.347220 | instance | changed:
2026-09-07 03:25:22.347515 | instance | created directory /var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/logs/instance
2026-09-07 03:25:22.347580 | instance | cd+++++++++ system/
2026-09-07 03:25:22.347627 | instance | >f+++++++++ system/brctl-show.txt
2026-09-07 03:25:22.347704 | instance | >f+++++++++ system/docker-images.txt
2026-09-07 03:25:22.347746 | instance | >f+++++++++ system/ip-addr.txt
2026-09-07 03:25:22.347789 | instance | >f+++++++++ system/ip-route.txt
2026-09-07 03:25:22.347832 | instance | >f+++++++++ system/lsblk.txt
2026-09-07 03:25:22.347872 | instance | >f+++++++++ system/mount.txt
2026-09-07 03:25:22.347911 | instance | >f+++++++++ system/packages.txt
2026-09-07 03:25:22.347948 | instance | >f+++++++++ system/ps.txt
2026-09-07 03:25:22.347990 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-07 03:25:22.365676 | 
2026-09-07 03:25:22.365769 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-07 03:25:22.624197 | instance | changed: "values"
2026-09-07 03:25:22.834607 | instance | changed: "releases"
2026-09-07 03:25:22.846965 | 
2026-09-07 03:25:22.847111 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-07 03:25:23.099384 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-07 03:25:23.379576 | instance | ok: Runtime: 0:00:00.006023
2026-09-07 03:25:23.390416 | 
2026-09-07 03:25:23.390606 | TASK [helm-release-status : Downloads logs to executor]
2026-09-07 03:25:23.929977 | instance | changed:
2026-09-07 03:25:23.930882 | instance | cd+++++++++ helm/
2026-09-07 03:25:23.930972 | instance | cd+++++++++ helm/releases/
2026-09-07 03:25:23.931030 | instance | cd+++++++++ helm/values/
2026-09-07 03:25:23.950440 | 
2026-09-07 03:25:23.950662 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-07 03:25:24.144281 | instance | changed
2026-09-07 03:25:24.151567 | 
2026-09-07 03:25:24.151695 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-07 03:25:24.443202 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:25:24.443275 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:25:24.448369 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:25:24.449202 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:25:24.451860 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:25:24.452919 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:25:24.454272 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:25:24.455681 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:25:24.457764 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:25:24.458766 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:25:24.459340 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:25:24.460720 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:25:24.690517 | instance | ok: Runtime: 0:00:00.025134
2026-09-07 03:25:24.700058 | 
2026-09-07 03:25:24.700182 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-07 03:25:24.929461 | instance | changed
2026-09-07 03:25:24.943104 | 
2026-09-07 03:25:24.943290 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-07 03:25:25.175425 | instance | environment: line 5: kubectl: command not found
2026-09-07 03:25:25.176388 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:25:25.176871 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:25:25.177180 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:25:25.490084 | instance | ok: Runtime: 0:00:00.008941
2026-09-07 03:25:25.501700 | 
2026-09-07 03:25:25.501916 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-07 03:25:26.046269 | instance | changed:
2026-09-07 03:25:26.046519 | instance | cd+++++++++ objects/
2026-09-07 03:25:26.046572 | instance | cd+++++++++ objects/cluster/
2026-09-07 03:25:26.046613 | instance | cd+++++++++ objects/namespaced/
2026-09-07 03:25:26.065390 | 
2026-09-07 03:25:26.065620 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-07 03:25:26.314486 | instance | changed
2026-09-07 03:25:26.323676 | 
2026-09-07 03:25:26.323822 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-07 03:25:26.552766 | instance | changed
2026-09-07 03:25:26.562054 | 
2026-09-07 03:25:26.562204 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-07 03:25:26.831050 | instance | environment: line 3: kubectl: command not found
2026-09-07 03:25:27.110388 | instance | ok: Runtime: 0:00:00.009437
2026-09-07 03:25:27.120558 | 
2026-09-07 03:25:27.120723 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-07 03:25:27.633556 | instance | changed:
2026-09-07 03:25:27.633852 | instance | cd+++++++++ pod-logs/
2026-09-07 03:25:27.633930 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-07 03:25:27.651510 | 
2026-09-07 03:25:27.651688 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-07 03:25:27.857196 | instance | changed
2026-09-07 03:25:27.866432 | 
2026-09-07 03:25:27.866560 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-07 03:25:28.111170 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 03:25:28.413049 | instance | ok: Runtime: 0:00:00.051665
2026-09-07 03:25:28.423215 | 
2026-09-07 03:25:28.423380 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-07 03:25:28.672926 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 03:25:28.719152 | instance | ceph-mgr endpoints:
2026-09-07 03:25:28.971191 | instance | ok: Runtime: 0:00:00.051226
2026-09-07 03:25:28.981307 | 
2026-09-07 03:25:28.981437 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-07 03:25:29.228672 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-07 03:25:29.526589 | instance | ok: Runtime: 0:00:00.050129
2026-09-07 03:25:29.536468 | 
2026-09-07 03:25:29.536803 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-07 03:25:30.087974 | instance | changed: cd+++++++++ prometheus/
2026-09-07 03:25:30.104864 | 
2026-09-07 03:25:30.105020 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-07 03:25:30.322852 | instance | changed
2026-09-07 03:25:30.333388 | 
2026-09-07 03:25:30.333635 | TASK [gather-selenium-data : Get selenium data]
2026-09-07 03:25:30.646891 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-07 03:25:30.647886 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-07 03:25:30.882773 | instance | ERROR
2026-09-07 03:25:30.883117 | instance | {
2026-09-07 03:25:30.883209 | instance |   "delta": "0:00:00.005959",
2026-09-07 03:25:30.883276 | instance |   "end": "2026-09-07 03:25:30.648159",
2026-09-07 03:25:30.883390 | instance |   "msg": "non-zero return code",
2026-09-07 03:25:30.883447 | instance |   "rc": 1,
2026-09-07 03:25:30.883486 | instance |   "start": "2026-09-07 03:25:30.642200"
2026-09-07 03:25:30.883524 | instance | }
2026-09-07 03:25:30.883574 | instance | ERROR: Ignoring Errors
2026-09-07 03:25:30.893935 | 
2026-09-07 03:25:30.894073 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-07 03:25:31.453166 | instance | changed: cd+++++++++ selenium/
2026-09-07 03:25:31.458676 | 
2026-09-07 03:25:31.458726 | PLAY RECAP
2026-09-07 03:25:31.458772 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-07 03:25:31.458792 | 
2026-09-07 03:25:31.618889 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 03:25:31.623019 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 03:25:32.227005 | 
2026-09-07 03:25:32.227130 | PLAY [all]
2026-09-07 03:25:32.238167 | 
2026-09-07 03:25:32.238281 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-07 03:25:32.302478 | instance | skipping: Conditional result was False
2026-09-07 03:25:32.309962 | 
2026-09-07 03:25:32.310122 | TASK [fetch-output : Set log path for single node]
2026-09-07 03:25:32.363785 | instance | ok
2026-09-07 03:25:32.373235 | 
2026-09-07 03:25:32.373411 | LOOP [fetch-output : Ensure local output dirs]
2026-09-07 03:25:32.773460 | instance -> localhost | ok: "/var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/logs"
2026-09-07 03:25:32.997829 | instance -> localhost | changed: "/var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/artifacts"
2026-09-07 03:25:33.218846 | instance -> localhost | changed: "/var/lib/zuul/builds/ca0e66f6d6bb4858914013cade1948f7/work/docs"
2026-09-07 03:25:33.241558 | 
2026-09-07 03:25:33.241798 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-07 03:25:33.928686 | instance | changed: .d..t...... ./
2026-09-07 03:25:33.929035 | instance | changed: All items complete
2026-09-07 03:25:33.929100 | 
2026-09-07 03:25:34.437742 | instance | changed: .d..t...... ./
2026-09-07 03:25:34.928291 | instance | changed: .d..t...... ./
2026-09-07 03:25:34.947416 | 
2026-09-07 03:25:34.947538 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-07 03:25:35.319108 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006965
2026-09-07 03:25:35.529983 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.004799
2026-09-07 03:25:35.545470 | 
2026-09-07 03:25:35.545787 | PLAY [all]
2026-09-07 03:25:35.559975 | 
2026-09-07 03:25:35.560157 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-07 03:25:35.980718 | instance | changed
2026-09-07 03:25:35.990089 | 
2026-09-07 03:25:35.990193 | PLAY RECAP
2026-09-07 03:25:35.990253 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-07 03:25:35.990282 | 
2026-09-07 03:25:36.126269 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 03:25:36.129236 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-07 03:25:36.691142 | 
2026-09-07 03:25:36.691296 | PLAY [localhost]
2026-09-07 03:25:36.700345 | 
2026-09-07 03:25:36.700451 | TASK [Generate Zuul manifest]
2026-09-07 03:25:36.717074 | localhost | ok
2026-09-07 03:25:36.736183 | 
2026-09-07 03:25:36.736665 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-07 03:25:37.083918 | localhost | changed
2026-09-07 03:25:37.104926 | 
2026-09-07 03:25:37.105099 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-07 03:25:37.136658 | localhost | ok
2026-09-07 03:25:37.149387 | 
2026-09-07 03:25:37.149516 | TASK [Upload logs]
2026-09-07 03:25:37.171792 | localhost | ok
2026-09-07 03:25:37.249796 | 
2026-09-07 03:25:37.249912 | TASK [Set zuul-log-path fact]
2026-09-07 03:25:37.265510 | localhost | ok
2026-09-07 03:25:37.276069 | 
2026-09-07 03:25:37.276132 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 03:25:37.303224 | localhost | ok
2026-09-07 03:25:37.311545 | 
2026-09-07 03:25:37.311657 | TASK [upload-logs : Create log directories]
2026-09-07 03:25:37.764347 | localhost | changed
2026-09-07 03:25:37.768810 | 
2026-09-07 03:25:37.768886 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-07 03:25:38.193813 | localhost -> localhost | ok: Runtime: 0:00:00.005300
2026-09-07 03:25:38.203030 | 
2026-09-07 03:25:38.203186 | TASK [upload-logs : Upload logs to log server]
2026-09-07 03:25:38.745964 | localhost | Output suppressed because no_log was given
2026-09-07 03:25:38.805886 | 
2026-09-07 03:25:38.806043 | LOOP [upload-logs : Compress console log and json output]
2026-09-07 03:25:38.861904 | localhost | skipping: Conditional result was False
2026-09-07 03:25:38.869208 | localhost | skipping: Conditional result was False
2026-09-07 03:25:38.885810 | 
2026-09-07 03:25:38.886045 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-07 03:25:38.951856 | localhost | skipping: Conditional result was False
2026-09-07 03:25:38.952385 | 
2026-09-07 03:25:38.958679 | localhost | skipping: Conditional result was False
2026-09-07 03:25:38.973763 | 
2026-09-07 03:25:38.974233 | LOOP [upload-logs : Upload console log and json output]