2026-09-10 01:48:14.198689 | Job console starting
2026-09-10 01:48:14.216135 | Updating git repos
2026-09-10 01:48:22.473077 | Cloning repos into workspace
2026-09-10 01:48:39.762681 | Restoring repo states
2026-09-10 01:48:51.988833 | Merging changes
2026-09-10 01:48:53.183191 | Checking out repos
2026-09-10 01:48:54.848655 | Preparing playbooks
2026-09-10 01:48:57.481052 | Running Ansible setup
2026-09-10 01:49:01.238057 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-10 01:49:01.851410 | 
2026-09-10 01:49:01.851572 | PLAY [localhost]
2026-09-10 01:49:01.858662 | 
2026-09-10 01:49:01.858727 | TASK [Gathering Facts]
2026-09-10 01:49:02.789589 | localhost | ok
2026-09-10 01:49:02.802246 | 
2026-09-10 01:49:02.802403 | TASK [Setup log path fact]
2026-09-10 01:49:02.824800 | localhost | ok
2026-09-10 01:49:02.844140 | 
2026-09-10 01:49:02.844279 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-10 01:49:02.884885 | localhost | ok
2026-09-10 01:49:02.896049 | 
2026-09-10 01:49:02.896185 | TASK [emit-job-header : Print job information]
2026-09-10 01:49:02.947963 | # Job Information
2026-09-10 01:49:02.948218 | Ansible Version: 2.16.18
2026-09-10 01:49:02.948281 | Job: atmosphere-molecule-csi-rbd
2026-09-10 01:49:02.948322 | Pipeline: check
2026-09-10 01:49:02.948360 | Executor: 2d72f0692154
2026-09-10 01:49:02.948397 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-09-10 01:49:02.948443 | Event ID: 31e84970-acb9-11f1-92ed-bc7e91a3efc1
2026-09-10 01:49:02.953723 | 
2026-09-10 01:49:02.953853 | LOOP [emit-job-header : Print node information]
2026-09-10 01:49:03.068779 | localhost | ok:
2026-09-10 01:49:03.069058 | localhost | # Node Information
2026-09-10 01:49:03.069157 | localhost | Inventory Hostname: instance
2026-09-10 01:49:03.069279 | localhost | Hostname: np0000192455
2026-09-10 01:49:03.069322 | localhost | Username: zuul
2026-09-10 01:49:03.069367 | localhost | Distro: Ubuntu 22.04
2026-09-10 01:49:03.069407 | localhost | Provider: yul1
2026-09-10 01:49:03.069444 | localhost | Region: ca-ymq-1
2026-09-10 01:49:03.069479 | localhost | Label: ubuntu-jammy
2026-09-10 01:49:03.069634 | localhost | Product Name: OpenStack Nova
2026-09-10 01:49:03.069685 | localhost | Interface IP: 162.253.55.113
2026-09-10 01:49:03.087573 | 
2026-09-10 01:49:03.087828 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-10 01:49:03.498880 | localhost -> localhost | changed
2026-09-10 01:49:03.505275 | 
2026-09-10 01:49:03.505387 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-10 01:49:04.452023 | localhost -> localhost | changed
2026-09-10 01:49:04.466815 | 
2026-09-10 01:49:04.466930 | PLAY [all]
2026-09-10 01:49:04.483928 | 
2026-09-10 01:49:04.484065 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-10 01:49:04.707879 | instance -> localhost | ok
2026-09-10 01:49:04.719022 | 
2026-09-10 01:49:04.719146 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-10 01:49:04.754623 | instance | ok
2026-09-10 01:49:04.777581 | instance | included: /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-10 01:49:04.785075 | 
2026-09-10 01:49:04.785166 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-10 01:49:06.629317 | instance -> localhost | Generating public/private rsa key pair.
2026-09-10 01:49:06.629608 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/8835ed877f534ea69d658496073b052e_id_rsa
2026-09-10 01:49:06.629654 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/8835ed877f534ea69d658496073b052e_id_rsa.pub
2026-09-10 01:49:06.629684 | instance -> localhost | The key fingerprint is:
2026-09-10 01:49:06.629710 | instance -> localhost | SHA256:2OXrqL1grUlnTBfFXc5EVzS04FLw7BGudDMpDdk4i6g zuul-build-sshkey
2026-09-10 01:49:06.629749 | instance -> localhost | The key's randomart image is:
2026-09-10 01:49:06.629776 | instance -> localhost | +---[RSA 3072]----+
2026-09-10 01:49:06.629980 | instance -> localhost | |           +*=.*O|
2026-09-10 01:49:06.630007 | instance -> localhost | |           =X.=++|
2026-09-10 01:49:06.630383 | instance -> localhost | |        . ++o% .o|
2026-09-10 01:49:06.630441 | instance -> localhost | |       + +.o* +  |
2026-09-10 01:49:06.630471 | instance -> localhost | |      o S o. .   |
2026-09-10 01:49:06.630496 | instance -> localhost | |     E + . .     |
2026-09-10 01:49:06.630538 | instance -> localhost | |      + = .      |
2026-09-10 01:49:06.630564 | instance -> localhost | |     o B o       |
2026-09-10 01:49:06.630592 | instance -> localhost | |      +.+..      |
2026-09-10 01:49:06.630616 | instance -> localhost | +----[SHA256]-----+
2026-09-10 01:49:06.630749 | instance -> localhost | ok: Runtime: 0:00:01.388704
2026-09-10 01:49:06.639703 | 
2026-09-10 01:49:06.639802 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-10 01:49:06.673816 | instance | ok
2026-09-10 01:49:06.686001 | instance | included: /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-10 01:49:06.696592 | 
2026-09-10 01:49:06.696678 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-10 01:49:06.721162 | instance | skipping: Conditional result was False
2026-09-10 01:49:06.729744 | 
2026-09-10 01:49:06.729848 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-10 01:49:07.228657 | instance | changed
2026-09-10 01:49:07.246501 | 
2026-09-10 01:49:07.246663 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-10 01:49:07.457030 | instance | ok
2026-09-10 01:49:07.469794 | 
2026-09-10 01:49:07.470810 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-10 01:49:07.999877 | instance | changed
2026-09-10 01:49:08.015740 | 
2026-09-10 01:49:08.015831 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-10 01:49:08.515614 | instance | changed
2026-09-10 01:49:08.537887 | 
2026-09-10 01:49:08.537994 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-10 01:49:08.563255 | instance | skipping: Conditional result was False
2026-09-10 01:49:08.574961 | 
2026-09-10 01:49:08.575092 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-10 01:49:08.997733 | instance -> localhost | changed
2026-09-10 01:49:09.020249 | 
2026-09-10 01:49:09.020626 | TASK [add-build-sshkey : Add back temp key]
2026-09-10 01:49:09.348133 | instance -> localhost | Identity added: /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/8835ed877f534ea69d658496073b052e_id_rsa (zuul-build-sshkey)
2026-09-10 01:49:09.348401 | instance -> localhost | ok: Runtime: 0:00:00.016343
2026-09-10 01:49:09.355310 | 
2026-09-10 01:49:09.355423 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-10 01:49:09.739300 | instance | ok
2026-09-10 01:49:09.744951 | 
2026-09-10 01:49:09.745053 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-10 01:49:09.780282 | instance | skipping: Conditional result was False
2026-09-10 01:49:09.799707 | 
2026-09-10 01:49:09.799815 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-10 01:49:10.147528 | instance | ok
2026-09-10 01:49:10.170874 | 
2026-09-10 01:49:10.171144 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-10 01:49:13.713780 | instance | Output suppressed because no_log was given
2026-09-10 01:49:13.729709 | 
2026-09-10 01:49:13.729836 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-10 01:49:13.964731 | instance | ok: "logs"
2026-09-10 01:49:13.965169 | instance | ok: All items complete
2026-09-10 01:49:13.965244 | 
2026-09-10 01:49:14.111807 | instance | ok: "artifacts"
2026-09-10 01:49:14.297336 | instance | ok: "docs"
2026-09-10 01:49:14.316654 | 
2026-09-10 01:49:14.316902 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-10 01:49:14.549246 | instance | changed: "logs"
2026-09-10 01:49:14.721733 | instance | changed: "artifacts"
2026-09-10 01:49:14.882438 | instance | changed: "docs"
2026-09-10 01:49:14.898738 | 
2026-09-10 01:49:14.898902 | PLAY RECAP
2026-09-10 01:49:14.898991 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-10 01:49:14.899045 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 01:49:14.899087 | 
2026-09-10 01:49:15.043076 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-10 01:49:15.047970 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-10 01:49:15.641797 | 
2026-09-10 01:49:15.641963 | PLAY [all]
2026-09-10 01:49:15.652409 | 
2026-09-10 01:49:15.652486 | TASK [setup-uv : Extract archive]
2026-09-10 01:49:17.966822 | instance | changed
2026-09-10 01:49:17.977333 | 
2026-09-10 01:49:17.977483 | TASK [setup-uv : Print version]
2026-09-10 01:49:18.372410 | instance | uv 0.8.13
2026-09-10 01:49:18.518288 | instance | ok: Runtime: 0:00:00.017989
2026-09-10 01:49:18.525976 | 
2026-09-10 01:49:18.526038 | TASK [Install Ansible collection siblings]
2026-09-10 01:49:31.790502 | instance | changed:
2026-09-10 01:49:31.790811 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-10 01:49:31.790924 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-10 01:49:31.790998 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-10 01:49:31.791049 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-10 01:49:31.791089 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-10 01:49:31.791131 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-10 01:49:31.791180 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-10 01:49:31.791246 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-10 01:49:31.791295 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-10 01:49:31.791334 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-10 01:49:31.791371 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-10 01:49:31.791407 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-10 01:49:31.791441 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-10 01:49:31.791475 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-10 01:49:31.791511 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-10 01:49:31.791576 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-10 01:49:31.791612 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-10 01:49:31.791647 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-10 01:49:31.791682 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-10 01:49:31.791717 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-10 01:49:31.791751 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-10 01:49:31.791786 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-10 01:49:31.791823 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-10 01:49:31.791876 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-10 01:49:31.791913 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-10 01:49:31.791948 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-10 01:49:31.791982 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-10 01:49:31.792016 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-10 01:49:31.792050 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-10 01:49:31.792083 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-10 01:49:31.792116 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-10 01:49:31.792152 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-10 01:49:31.792187 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-10 01:49:31.792223 | 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-10 01:49:31.792270 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.792306 | instance | Process install dependency map
2026-09-10 01:49:31.792341 | instance | Starting collection install process
2026-09-10 01:49:31.792375 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-10 01:49:31.792409 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-10 01:49:31.792443 | instance | ansible.netcommon:* was installed successfully
2026-09-10 01:49:31.792478 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-10 01:49:31.792569 | instance | Creating virtual environment at: .venv
2026-09-10 01:49:31.792624 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-10 01:49:31.792682 | instance | Downloading netaddr (2.2MiB)
2026-09-10 01:49:31.792725 | instance | Downloading pygments (1.2MiB)
2026-09-10 01:49:31.792768 | instance | Downloading kubernetes (1.9MiB)
2026-09-10 01:49:31.792804 | instance | Downloading openstacksdk (1.7MiB)
2026-09-10 01:49:31.792839 | instance | Downloading setuptools (1.1MiB)
2026-09-10 01:49:31.792876 | instance | Downloading rjsonnet (1.2MiB)
2026-09-10 01:49:31.792955 | instance | Downloading ansible-core (2.1MiB)
2026-09-10 01:49:31.793038 | instance | Downloading cryptography (4.2MiB)
2026-09-10 01:49:31.793082 | instance |    Building pyperclip==1.9.0
2026-09-10 01:49:31.793119 | instance |  Downloading rjsonnet
2026-09-10 01:49:31.793160 | instance |  Downloading pygments
2026-09-10 01:49:31.793198 | instance |  Downloading netaddr
2026-09-10 01:49:31.793233 | instance |  Downloading setuptools
2026-09-10 01:49:31.793271 | instance |  Downloading cryptography
2026-09-10 01:49:31.793306 | instance |  Downloading kubernetes
2026-09-10 01:49:31.793341 | instance |  Downloading ansible-core
2026-09-10 01:49:31.793375 | instance |  Downloading openstacksdk
2026-09-10 01:49:31.793410 | instance |       Built pyperclip==1.9.0
2026-09-10 01:49:31.793445 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-10 01:49:31.793482 | instance | Installed 79 packages in 59ms
2026-09-10 01:49:31.793518 | instance | Checked out ansible.posix to 1.6.0
2026-09-10 01:49:31.793710 | 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-10 01:49:31.793756 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.793793 | instance | Process install dependency map
2026-09-10 01:49:31.793829 | instance | Starting collection install process
2026-09-10 01:49:31.793864 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-10 01:49:31.793911 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-10 01:49:31.793947 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-10 01:49:31.793981 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.794016 | instance | 2.17.12
2026-09-10 01:49:31.794052 | instance | Checked out ansible.utils to v6.1.0
2026-09-10 01:49:31.794087 | 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-10 01:49:31.794122 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.794155 | instance | Process install dependency map
2026-09-10 01:49:31.794190 | instance | Starting collection install process
2026-09-10 01:49:31.794224 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-10 01:49:31.794259 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-10 01:49:31.794295 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-10 01:49:31.794333 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.794370 | instance | 2.17.12
2026-09-10 01:49:31.794406 | instance | Checked out atmosphere.common to v0.7.0
2026-09-10 01:49:31.794441 | 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-10 01:49:31.794476 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.794512 | instance | Process install dependency map
2026-09-10 01:49:31.794569 | instance | Starting collection install process
2026-09-10 01:49:31.794605 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-10 01:49:31.794939 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-10 01:49:31.795003 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-10 01:49:31.795042 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.795078 | instance | 2.17.12
2026-09-10 01:49:31.795114 | instance | Checked out community.crypto to 2.2.3
2026-09-10 01:49:31.795241 | 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-10 01:49:31.795294 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.795330 | instance | Process install dependency map
2026-09-10 01:49:31.795366 | instance | Starting collection install process
2026-09-10 01:49:31.795400 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-10 01:49:31.795434 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-10 01:49:31.795468 | instance | community.crypto:2.2.3 was installed successfully
2026-09-10 01:49:31.795502 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.795561 | instance | 2.17.12
2026-09-10 01:49:31.795597 | instance | Checked out community.general to 7.3.0
2026-09-10 01:49:31.795632 | 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-10 01:49:31.795668 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.795716 | instance | Process install dependency map
2026-09-10 01:49:31.795753 | instance | Starting collection install process
2026-09-10 01:49:31.795787 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-10 01:49:31.795822 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-10 01:49:31.795855 | instance | community.general:7.3.0 was installed successfully
2026-09-10 01:49:31.795889 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.795923 | instance | 2.17.12
2026-09-10 01:49:31.795958 | instance | Checked out community.mysql to 3.6.0
2026-09-10 01:49:31.795993 | 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-10 01:49:31.796028 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.796067 | instance | Process install dependency map
2026-09-10 01:49:31.796104 | instance | Starting collection install process
2026-09-10 01:49:31.796139 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-10 01:49:31.796174 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-10 01:49:31.796208 | instance | community.mysql:3.6.0 was installed successfully
2026-09-10 01:49:31.796242 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.796277 | instance | 2.17.12
2026-09-10 01:49:31.796321 | instance | Checked out kubernetes.core to 2.4.0
2026-09-10 01:49:31.796380 | 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-10 01:49:31.796437 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.796476 | instance | Process install dependency map
2026-09-10 01:49:31.796561 | instance | Starting collection install process
2026-09-10 01:49:31.796601 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-10 01:49:31.796638 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-10 01:49:31.796673 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-10 01:49:31.796709 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.796743 | instance | 2.17.12
2026-09-10 01:49:31.796778 | instance | Checked out openstack.cloud to 2.6.0
2026-09-10 01:49:31.796813 | 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-10 01:49:31.796848 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.796882 | instance | Process install dependency map
2026-09-10 01:49:31.796916 | instance | Starting collection install process
2026-09-10 01:49:31.796950 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-10 01:49:31.796985 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-10 01:49:31.797020 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-10 01:49:31.797054 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.797087 | instance | 2.17.12
2026-09-10 01:49:31.797121 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-10 01:49:31.797155 | 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-10 01:49:31.797206 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.797243 | instance | Process install dependency map
2026-09-10 01:49:31.797278 | instance | Starting collection install process
2026-09-10 01:49:31.797315 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-10 01:49:31.797350 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-10 01:49:31.797384 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-10 01:49:31.797419 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.797453 | instance | 2.17.12
2026-09-10 01:49:31.797487 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-10 01:49:31.797540 | 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-10 01:49:31.797579 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.797613 | instance | Process install dependency map
2026-09-10 01:49:31.797648 | instance | Starting collection install process
2026-09-10 01:49:31.797684 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-10 01:49:31.797719 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-10 01:49:31.797753 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-10 01:49:31.797788 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.797821 | instance | 2.17.12
2026-09-10 01:49:31.797856 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-10 01:49:31.797891 | 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-10 01:49:31.797926 | instance | Starting galaxy collection install process
2026-09-10 01:49:31.797960 | instance | Process install dependency map
2026-09-10 01:49:31.797994 | instance | Starting collection install process
2026-09-10 01:49:31.798029 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-10 01:49:31.798063 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-10 01:49:31.798096 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-10 01:49:31.798256 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 01:49:31.798311 | instance | 2.17.12
2026-09-10 01:49:31.809166 | 
2026-09-10 01:49:31.809260 | PLAY RECAP
2026-09-10 01:49:31.809508 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 01:49:31.809635 | 
2026-09-10 01:49:31.949195 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-10 01:49:31.952840 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-10 01:49:32.523178 | 
2026-09-10 01:49:32.523304 | PLAY [all]
2026-09-10 01:49:32.533799 | 
2026-09-10 01:49:32.533867 | TASK [Install "jq" for log collection]
2026-09-10 01:49:42.213456 | instance | changed
2026-09-10 01:49:42.216697 | 
2026-09-10 01:49:42.216815 | PLAY RECAP
2026-09-10 01:49:42.216916 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 01:49:42.217016 | 
2026-09-10 01:49:42.348355 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-10 01:49:42.353738 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-10 01:49:42.925106 | 
2026-09-10 01:49:42.925512 | PLAY [all]
2026-09-10 01:49:42.936297 | 
2026-09-10 01:49:42.936371 | LOOP [Check inventory directories]
2026-09-10 01:49:43.295390 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-10 01:49:43.468975 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-10 01:49:43.665887 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-10 01:49:43.677507 | 
2026-09-10 01:49:43.701375 | LOOP [Copy inventory file for Zuul]
2026-09-10 01:49:44.598443 | instance | changed:
2026-09-10 01:49:44.598793 | instance | {
2026-09-10 01:49:44.598971 | instance |   "ansible_loop_var": "item",
2026-09-10 01:49:44.599056 | instance |   "changed": false,
2026-09-10 01:49:44.599104 | instance |   "failed": false,
2026-09-10 01:49:44.599155 | instance |   "invocation": {
2026-09-10 01:49:44.599195 | instance |     "module_args": {
2026-09-10 01:49:44.599236 | instance |       "checksum_algorithm": "sha1",
2026-09-10 01:49:44.599276 | instance |       "follow": true,
2026-09-10 01:49:44.599347 | instance |       "get_attributes": true,
2026-09-10 01:49:44.599391 | instance |       "get_checksum": true,
2026-09-10 01:49:44.599431 | instance |       "get_mime": true,
2026-09-10 01:49:44.599470 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-10 01:49:44.599505 | instance |     }
2026-09-10 01:49:44.599566 | instance |   },
2026-09-10 01:49:44.599607 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-10 01:49:44.599647 | instance |   "stat": {
2026-09-10 01:49:44.599687 | instance |     "atime": 1789004964.5479765,
2026-09-10 01:49:44.599727 | instance |     "attr_flags": "e",
2026-09-10 01:49:44.599766 | instance |     "attributes": [
2026-09-10 01:49:44.599806 | instance |       "extents"
2026-09-10 01:49:44.599844 | instance |     ],
2026-09-10 01:49:44.599888 | instance |     "block_size": 4096,
2026-09-10 01:49:44.599921 | instance |     "blocks": 8,
2026-09-10 01:49:44.599960 | instance |     "charset": "unknown",
2026-09-10 01:49:44.600002 | instance |     "ctime": 1789004959.4718833,
2026-09-10 01:49:44.600041 | instance |     "dev": 64513,
2026-09-10 01:49:44.600079 | instance |     "device_type": 0,
2026-09-10 01:49:44.600117 | instance |     "executable": true,
2026-09-10 01:49:44.600155 | instance |     "exists": true,
2026-09-10 01:49:44.600192 | instance |     "gid": 1000,
2026-09-10 01:49:44.600230 | instance |     "gr_name": "zuul",
2026-09-10 01:49:44.600267 | instance |     "inode": 1048852,
2026-09-10 01:49:44.600305 | instance |     "isblk": false,
2026-09-10 01:49:44.600344 | instance |     "ischr": false,
2026-09-10 01:49:44.600383 | instance |     "isdir": true,
2026-09-10 01:49:44.600421 | instance |     "isfifo": false,
2026-09-10 01:49:44.600471 | instance |     "isgid": false,
2026-09-10 01:49:44.600548 | instance |     "islnk": false,
2026-09-10 01:49:44.600589 | instance |     "isreg": false,
2026-09-10 01:49:44.600628 | instance |     "issock": false,
2026-09-10 01:49:44.600683 | instance |     "isuid": false,
2026-09-10 01:49:44.600722 | instance |     "mimetype": "unknown",
2026-09-10 01:49:44.600760 | instance |     "mode": "0755",
2026-09-10 01:49:44.600798 | instance |     "mtime": 1789004959.4718833,
2026-09-10 01:49:44.600834 | instance |     "nlink": 22,
2026-09-10 01:49:44.600871 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-10 01:49:44.600908 | instance |     "pw_name": "zuul",
2026-09-10 01:49:44.600948 | instance |     "readable": true,
2026-09-10 01:49:44.600986 | instance |     "rgrp": true,
2026-09-10 01:49:44.601023 | instance |     "roth": true,
2026-09-10 01:49:44.601060 | instance |     "rusr": true,
2026-09-10 01:49:44.601097 | instance |     "size": 4096,
2026-09-10 01:49:44.601134 | instance |     "uid": 1000,
2026-09-10 01:49:44.601207 | instance |     "version": "1600640234",
2026-09-10 01:49:44.601250 | instance |     "wgrp": false,
2026-09-10 01:49:44.601292 | instance |     "woth": false,
2026-09-10 01:49:44.601350 | instance |     "writeable": true,
2026-09-10 01:49:44.601390 | instance |     "wusr": true,
2026-09-10 01:49:44.601429 | instance |     "xgrp": true,
2026-09-10 01:49:44.601466 | instance |     "xoth": true,
2026-09-10 01:49:44.601504 | instance |     "xusr": true
2026-09-10 01:49:44.601573 | instance |   }
2026-09-10 01:49:44.601621 | instance | }
2026-09-10 01:49:44.601704 | instance | ok: All items complete
2026-09-10 01:49:44.601750 | 
2026-09-10 01:49:44.604422 | instance | skipping: Conditional result was False
2026-09-10 01:49:44.605963 | instance | skipping: Conditional result was False
2026-09-10 01:49:44.628148 | 
2026-09-10 01:49:44.628345 | LOOP [Switch "ansible_host" to private IP]
2026-09-10 01:49:44.985485 | instance | changed: 1 replacements made
2026-09-10 01:49:44.993126 | instance | skipping: Conditional result was False
2026-09-10 01:49:45.001918 | instance | skipping: Conditional result was False
2026-09-10 01:49:45.017051 | 
2026-09-10 01:49:45.017171 | TASK [Run Molecule scenario]
2026-09-10 01:49:45.985353 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-10 01:49:46.409247 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-10 01:49:46.415113 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-10 01:49:57.504605 | instance | INFO     [csi > dependency] Executing
2026-09-10 01:49:57.504835 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-10 01:49:57.505115 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-10 01:49:57.505293 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-10 01:49:57.516824 | instance | INFO     [csi > cleanup] Executing
2026-09-10 01:49:57.517301 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-10 01:49:57.527867 | instance | INFO     [csi > destroy] Executing
2026-09-10 01:49:57.527933 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-10 01:49:57.528053 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-10 01:49:57.538372 | instance | INFO     [csi > syntax] Executing
2026-09-10 01:49:58.943421 | instance |
2026-09-10 01:49:58.943579 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-10 01:49:59.008698 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-10 01:49:59.024550 | instance | INFO     [csi > create] Executing
2026-09-10 01:49:59.028338 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-10 01:49:59.042730 | instance | INFO     [csi > prepare] Executing
2026-09-10 01:49:59.812506 | instance |
2026-09-10 01:49:59.813369 | instance | PLAY [Prepare] *****************************************************************
2026-09-10 01:49:59.813385 | instance |
2026-09-10 01:49:59.813414 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 01:49:59.813428 | instance | Thursday 10 September 2026  01:49:59 +0000 (0:00:00.026)       0:00:00.026 ****
2026-09-10 01:50:01.165073 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-10 01:50:01.165286 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-10 01:50:01.165538 | instance | interpreter could change the meaning of that path. See
2026-09-10 01:50:01.165791 | instance | https://docs.ansible.com/ansible-
2026-09-10 01:50:01.166064 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-10 01:50:01.173856 | instance | ok: [instance]
2026-09-10 01:50:01.174061 | instance |
2026-09-10 01:50:01.174324 | instance | TASK [Configure short hostname] ************************************************
2026-09-10 01:50:01.174565 | instance | Thursday 10 September 2026  01:50:01 +0000 (0:00:01.362)       0:00:01.388 ****
2026-09-10 01:50:02.025312 | instance | changed: [instance]
2026-09-10 01:50:02.025610 | instance |
2026-09-10 01:50:02.025740 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-10 01:50:02.026034 | instance | Thursday 10 September 2026  01:50:02 +0000 (0:00:00.850)       0:00:02.239 ****
2026-09-10 01:50:02.310309 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-10 01:50:02.310576 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-10 01:50:02.310883 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-10 01:50:02.321068 | instance | changed: [instance]
2026-09-10 01:50:02.321301 | instance |
2026-09-10 01:50:02.321551 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-10 01:50:02.321857 | instance | Thursday 10 September 2026  01:50:02 +0000 (0:00:00.296)       0:00:02.535 ****
2026-09-10 01:50:03.166351 | instance | ok: [instance]
2026-09-10 01:50:03.166565 | instance |
2026-09-10 01:50:03.166912 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-10 01:50:03.167212 | instance |
2026-09-10 01:50:03.167594 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 01:50:03.168179 | instance | Thursday 10 September 2026  01:50:03 +0000 (0:00:00.844)       0:00:03.380 ****
2026-09-10 01:50:03.953481 | instance | ok: [instance]
2026-09-10 01:50:03.953693 | instance |
2026-09-10 01:50:03.953984 | instance | TASK [Install depedencies] *****************************************************
2026-09-10 01:50:03.954237 | instance | Thursday 10 September 2026  01:50:03 +0000 (0:00:00.786)       0:00:04.167 ****
2026-09-10 01:50:29.628320 | instance | changed: [instance]
2026-09-10 01:50:29.629126 | instance |
2026-09-10 01:50:29.629195 | instance | TASK [Start up service] ********************************************************
2026-09-10 01:50:29.629210 | instance | Thursday 10 September 2026  01:50:29 +0000 (0:00:25.674)       0:00:29.842 ****
2026-09-10 01:50:30.226013 | instance | ok: [instance]
2026-09-10 01:50:30.226746 | instance |
2026-09-10 01:50:30.226812 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-10 01:50:30.226824 | instance | Thursday 10 September 2026  01:50:30 +0000 (0:00:00.597)       0:00:30.440 ****
2026-09-10 01:50:30.557466 | instance | ok: [instance]
2026-09-10 01:50:30.557564 | instance |
2026-09-10 01:50:30.557629 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-10 01:50:30.557764 | instance | Thursday 10 September 2026  01:50:30 +0000 (0:00:00.332)       0:00:30.772 ****
2026-09-10 01:50:31.285179 | instance | changed: [instance]
2026-09-10 01:50:31.285904 | instance |
2026-09-10 01:50:31.285997 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-10 01:50:31.286202 | instance | Thursday 10 September 2026  01:50:31 +0000 (0:00:00.727)       0:00:31.499 ****
2026-09-10 01:50:31.496589 | instance | ok: [instance]
2026-09-10 01:50:31.497271 | instance |
2026-09-10 01:50:31.497334 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-10 01:50:31.497346 | instance | Thursday 10 September 2026  01:50:31 +0000 (0:00:00.211)       0:00:31.710 ****
2026-09-10 01:50:31.524792 | instance | skipping: [instance]
2026-09-10 01:50:31.525051 | instance |
2026-09-10 01:50:31.525486 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-10 01:50:31.525814 | instance | Thursday 10 September 2026  01:50:31 +0000 (0:00:00.028)       0:00:31.739 ****
2026-09-10 01:50:32.148686 | instance | changed: [instance] => (item=osd0)
2026-09-10 01:50:32.148758 | instance | changed: [instance] => (item=osd1)
2026-09-10 01:50:32.149607 | instance | changed: [instance] => (item=osd2)
2026-09-10 01:50:32.149684 | instance |
2026-09-10 01:50:32.149698 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-10 01:50:32.149709 | instance | Thursday 10 September 2026  01:50:32 +0000 (0:00:00.623)       0:00:32.362 ****
2026-09-10 01:50:32.813623 | instance | changed: [instance] => (item=osd0)
2026-09-10 01:50:32.813702 | instance | changed: [instance] => (item=osd1)
2026-09-10 01:50:32.813718 | instance | changed: [instance] => (item=osd2)
2026-09-10 01:50:32.813732 | instance |
2026-09-10 01:50:32.813742 | instance | TASK [Start loop devices] ******************************************************
2026-09-10 01:50:32.813752 | instance | Thursday 10 September 2026  01:50:32 +0000 (0:00:00.663)       0:00:33.026 ****
2026-09-10 01:50:33.596696 | instance | changed: [instance] => (item=osd0)
2026-09-10 01:50:33.596759 | instance | changed: [instance] => (item=osd1)
2026-09-10 01:50:33.596768 | instance | changed: [instance] => (item=osd2)
2026-09-10 01:50:33.596775 | instance |
2026-09-10 01:50:33.596782 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-10 01:50:33.596789 | instance | Thursday 10 September 2026  01:50:33 +0000 (0:00:00.784)       0:00:33.810 ****
2026-09-10 01:50:36.801935 | instance | changed: [instance] => (item=osd0)
2026-09-10 01:50:36.803129 | instance | changed: [instance] => (item=osd1)
2026-09-10 01:50:36.803204 | instance | changed: [instance] => (item=osd2)
2026-09-10 01:50:36.803216 | instance |
2026-09-10 01:50:36.803226 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-10 01:50:36.803237 | instance | Thursday 10 September 2026  01:50:36 +0000 (0:00:03.205)       0:00:37.016 ****
2026-09-10 01:50:38.798158 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-10 01:50:38.799231 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-10 01:50:38.799450 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-10 01:50:38.799466 | instance |
2026-09-10 01:50:38.799480 | instance | PLAY RECAP *********************************************************************
2026-09-10 01:50:38.799500 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-10 01:50:38.799710 | instance |
2026-09-10 01:50:38.803734 | instance | Thursday 10 September 2026  01:50:38 +0000 (0:00:01.996)       0:00:39.013 ****
2026-09-10 01:50:38.803818 | instance | ===============================================================================
2026-09-10 01:50:38.803826 | instance | Install depedencies ---------------------------------------------------- 25.68s
2026-09-10 01:50:38.803832 | instance | Create a volume group for each loop device ------------------------------ 3.21s
2026-09-10 01:50:38.803837 | instance | Create a logical volume for each loop device ---------------------------- 2.00s
2026-09-10 01:50:38.803845 | instance | Gathering Facts --------------------------------------------------------- 1.36s
2026-09-10 01:50:38.803851 | instance | Configure short hostname ------------------------------------------------ 0.85s
2026-09-10 01:50:38.803856 | instance | Purge "snapd" package --------------------------------------------------- 0.84s
2026-09-10 01:50:38.803862 | instance | Gathering Facts --------------------------------------------------------- 0.79s
2026-09-10 01:50:38.803867 | instance | Start loop devices ------------------------------------------------------ 0.78s
2026-09-10 01:50:38.803895 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s
2026-09-10 01:50:38.803901 | instance | Set permissions on loopback devices ------------------------------------- 0.66s
2026-09-10 01:50:38.803906 | instance | Create devices for Ceph ------------------------------------------------- 0.62s
2026-09-10 01:50:38.803912 | instance | Start up service -------------------------------------------------------- 0.60s
2026-09-10 01:50:38.803917 | instance | Generate lvm.conf ------------------------------------------------------- 0.33s
2026-09-10 01:50:38.803923 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-10 01:50:38.803937 | instance | Get list of all loopback devices ---------------------------------------- 0.21s
2026-09-10 01:50:38.804094 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-10 01:50:38.906006 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-10 01:50:38.920989 | instance | INFO     [csi > converge] Executing
2026-09-10 01:50:40.358158 | instance |
2026-09-10 01:50:40.358556 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-10 01:50:40.358851 | instance |
2026-09-10 01:50:40.359185 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 01:50:40.359489 | instance | Thursday 10 September 2026  01:50:40 +0000 (0:00:00.007)       0:00:00.007 ****
2026-09-10 01:50:41.435799 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-10 01:50:41.436232 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-10 01:50:41.436550 | instance | interpreter could change the meaning of that path. See
2026-09-10 01:50:41.436883 | instance | https://docs.ansible.com/ansible-
2026-09-10 01:50:41.437200 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-10 01:50:41.450089 | instance | ok: [instance]
2026-09-10 01:50:41.450394 | instance |
2026-09-10 01:50:41.450697 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-10 01:50:41.451021 | instance | Thursday 10 September 2026  01:50:41 +0000 (0:00:01.091)       0:00:01.099 ****
2026-09-10 01:50:41.519808 | instance | ok: [instance] => {
2026-09-10 01:50:41.520226 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-10 01:50:41.520521 | instance | }
2026-09-10 01:50:41.520801 | instance |
2026-09-10 01:50:41.521117 | instance | PLAY [all] *********************************************************************
2026-09-10 01:50:41.521395 | instance |
2026-09-10 01:50:41.521688 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 01:50:41.522119 | instance | Thursday 10 September 2026  01:50:41 +0000 (0:00:00.069)       0:00:01.169 ****
2026-09-10 01:50:42.478451 | instance | ok: [instance]
2026-09-10 01:50:42.478723 | instance |
2026-09-10 01:50:42.478962 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-10 01:50:42.479173 | instance | Thursday 10 September 2026  01:50:42 +0000 (0:00:00.958)       0:00:02.128 ****
2026-09-10 01:50:42.700656 | instance | ok: [instance]
2026-09-10 01:50:42.701034 | instance |
2026-09-10 01:50:42.701339 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-10 01:50:42.701615 | instance |
2026-09-10 01:50:42.701930 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 01:50:42.702228 | instance | Thursday 10 September 2026  01:50:42 +0000 (0:00:00.221)       0:00:02.349 ****
2026-09-10 01:50:43.692072 | instance | ok: [instance]
2026-09-10 01:50:43.694391 | instance |
2026-09-10 01:50:43.694417 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 01:50:43.694435 | instance | Thursday 10 September 2026  01:50:43 +0000 (0:00:00.988)       0:00:03.338 ****
2026-09-10 01:50:44.014884 | instance | ok: [instance]
2026-09-10 01:50:44.014969 | instance |
2026-09-10 01:50:44.015162 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 01:50:44.015409 | instance | Thursday 10 September 2026  01:50:44 +0000 (0:00:00.326)       0:00:03.664 ****
2026-09-10 01:50:44.079073 | instance | skipping: [instance]
2026-09-10 01:50:44.079320 | instance |
2026-09-10 01:50:44.079542 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-10 01:50:44.079786 | instance | Thursday 10 September 2026  01:50:44 +0000 (0:00:00.061)       0:00:03.725 ****
2026-09-10 01:50:44.483428 | instance | changed: [instance]
2026-09-10 01:50:44.483913 | instance |
2026-09-10 01:50:44.484285 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 01:50:44.484614 | instance | Thursday 10 September 2026  01:50:44 +0000 (0:00:00.407)       0:00:04.132 ****
2026-09-10 01:50:44.574168 | instance | ok: [instance] => {
2026-09-10 01:50:44.574561 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-10 01:50:44.574884 | instance | }
2026-09-10 01:50:44.575174 | instance |
2026-09-10 01:50:44.575474 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 01:50:44.575900 | instance | Thursday 10 September 2026  01:50:44 +0000 (0:00:00.090)       0:00:04.223 ****
2026-09-10 01:50:45.298567 | instance | changed: [instance]
2026-09-10 01:50:45.298611 | instance |
2026-09-10 01:50:45.298620 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 01:50:45.298627 | instance | Thursday 10 September 2026  01:50:45 +0000 (0:00:00.724)       0:00:04.948 ****
2026-09-10 01:50:45.346354 | instance | skipping: [instance]
2026-09-10 01:50:45.346403 | instance |
2026-09-10 01:50:45.346409 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 01:50:45.346413 | instance | Thursday 10 September 2026  01:50:45 +0000 (0:00:00.048)       0:00:04.996 ****
2026-09-10 01:50:45.393314 | instance | skipping: [instance]
2026-09-10 01:50:45.393358 | instance |
2026-09-10 01:50:45.393363 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 01:50:45.393367 | instance | Thursday 10 September 2026  01:50:45 +0000 (0:00:00.047)       0:00:05.043 ****
2026-09-10 01:50:45.611237 | instance | ok: [instance]
2026-09-10 01:50:45.611306 | instance |
2026-09-10 01:50:45.611318 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 01:50:45.611328 | instance | Thursday 10 September 2026  01:50:45 +0000 (0:00:00.216)       0:00:05.259 ****
2026-09-10 01:50:47.080724 | instance | ok: [instance]
2026-09-10 01:50:47.080788 | instance |
2026-09-10 01:50:47.080800 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 01:50:47.080837 | instance | Thursday 10 September 2026  01:50:47 +0000 (0:00:01.469)       0:00:06.729 ****
2026-09-10 01:50:47.166972 | instance | ok: [instance] => {
2026-09-10 01:50:47.167037 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-10 01:50:47.167066 | instance | }
2026-09-10 01:50:47.167076 | instance |
2026-09-10 01:50:47.167084 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 01:50:47.167093 | instance | Thursday 10 September 2026  01:50:47 +0000 (0:00:00.085)       0:00:06.815 ****
2026-09-10 01:50:47.907693 | instance | changed: [instance]
2026-09-10 01:50:47.908119 | instance |
2026-09-10 01:50:47.908423 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 01:50:47.908713 | instance | Thursday 10 September 2026  01:50:47 +0000 (0:00:00.741)       0:00:07.557 ****
2026-09-10 01:50:50.867692 | instance | changed: [instance]
2026-09-10 01:50:50.867965 | instance |
2026-09-10 01:50:50.868153 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-10 01:50:50.868333 | instance | Thursday 10 September 2026  01:50:50 +0000 (0:00:02.960)       0:00:10.517 ****
2026-09-10 01:50:50.908111 | instance | skipping: [instance]
2026-09-10 01:50:50.908533 | instance |
2026-09-10 01:50:50.908871 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-10 01:50:50.909175 | instance | Thursday 10 September 2026  01:50:50 +0000 (0:00:00.040)       0:00:10.557 ****
2026-09-10 01:50:50.949371 | instance | skipping: [instance]
2026-09-10 01:50:50.949697 | instance |
2026-09-10 01:50:50.950412 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-10 01:50:50.950729 | instance | Thursday 10 September 2026  01:50:50 +0000 (0:00:00.041)       0:00:10.599 ****
2026-09-10 01:50:50.990105 | instance | skipping: [instance]
2026-09-10 01:50:50.990435 | instance |
2026-09-10 01:50:50.990754 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-10 01:50:50.991090 | instance | Thursday 10 September 2026  01:50:50 +0000 (0:00:00.041)       0:00:10.640 ****
2026-09-10 01:50:57.295749 | instance | changed: [instance]
2026-09-10 01:50:57.296073 | instance |
2026-09-10 01:50:57.296693 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-10 01:50:57.296794 | instance | Thursday 10 September 2026  01:50:57 +0000 (0:00:06.304)       0:00:16.944 ****
2026-09-10 01:50:57.982503 | instance | changed: [instance]
2026-09-10 01:50:57.983269 | instance |
2026-09-10 01:50:57.983344 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-10 01:50:57.983356 | instance | Thursday 10 September 2026  01:50:57 +0000 (0:00:00.687)       0:00:17.632 ****
2026-09-10 01:50:59.069122 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-10 01:50:59.070724 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-10 01:50:59.070937 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-10 01:50:59.070949 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-10 01:50:59.070959 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-10 01:50:59.070970 | instance |
2026-09-10 01:50:59.070987 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-10 01:50:59.070996 | instance | Thursday 10 September 2026  01:50:59 +0000 (0:00:01.086)       0:00:18.718 ****
2026-09-10 01:50:59.736715 | instance | changed: [instance]
2026-09-10 01:50:59.736808 | instance |
2026-09-10 01:50:59.737614 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-10 01:50:59.737694 | instance | Thursday 10 September 2026  01:50:59 +0000 (0:00:00.638)       0:00:19.357 ****
2026-09-10 01:50:59.737702 | instance |
2026-09-10 01:50:59.737709 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-10 01:50:59.737715 | instance | Thursday 10 September 2026  01:50:59 +0000 (0:00:00.029)       0:00:19.386 ****
2026-09-10 01:51:00.674512 | instance | ok: [instance]
2026-09-10 01:51:00.674691 | instance |
2026-09-10 01:51:00.675427 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-10 01:51:00.675498 | instance | Thursday 10 September 2026  01:51:00 +0000 (0:00:00.936)       0:00:20.322 ****
2026-09-10 01:51:01.206480 | instance | changed: [instance]
2026-09-10 01:51:01.207230 | instance |
2026-09-10 01:51:01.207296 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-10 01:51:01.207309 | instance | Thursday 10 September 2026  01:51:01 +0000 (0:00:00.533)       0:00:20.856 ****
2026-09-10 01:51:01.834315 | instance | changed: [instance]
2026-09-10 01:51:01.834433 | instance |
2026-09-10 01:51:01.834767 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 01:51:01.834791 | instance | Thursday 10 September 2026  01:51:01 +0000 (0:00:00.628)       0:00:21.484 ****
2026-09-10 01:51:02.083041 | instance | ok: [instance]
2026-09-10 01:51:02.083780 | instance |
2026-09-10 01:51:02.083874 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 01:51:02.083896 | instance | Thursday 10 September 2026  01:51:02 +0000 (0:00:00.248)       0:00:21.732 ****
2026-09-10 01:51:02.165840 | instance | ok: [instance] => {
2026-09-10 01:51:02.166002 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-10 01:51:02.167188 | instance | }
2026-09-10 01:51:02.167397 | instance |
2026-09-10 01:51:02.167670 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 01:51:02.167917 | instance | Thursday 10 September 2026  01:51:02 +0000 (0:00:00.083)       0:00:21.815 ****
2026-09-10 01:51:10.124730 | instance | changed: [instance]
2026-09-10 01:51:10.124823 | instance |
2026-09-10 01:51:10.124889 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 01:51:10.125069 | instance | Thursday 10 September 2026  01:51:10 +0000 (0:00:07.958)       0:00:29.774 ****
2026-09-10 01:51:14.566168 | instance | changed: [instance]
2026-09-10 01:51:14.566400 | instance |
2026-09-10 01:51:14.566412 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-10 01:51:14.566422 | instance | Thursday 10 September 2026  01:51:14 +0000 (0:00:04.440)       0:00:34.215 ****
2026-09-10 01:51:15.858383 | instance | ok: [instance]
2026-09-10 01:51:15.859290 | instance |
2026-09-10 01:51:15.859325 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-10 01:51:15.859339 | instance | Thursday 10 September 2026  01:51:15 +0000 (0:00:01.292)       0:00:35.508 ****
2026-09-10 01:51:16.275029 | instance | changed: [instance]
2026-09-10 01:51:16.275637 | instance |
2026-09-10 01:51:16.275662 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-10 01:51:16.275670 | instance | Thursday 10 September 2026  01:51:16 +0000 (0:00:00.417)       0:00:35.925 ****
2026-09-10 01:51:16.809938 | instance | changed: [instance]
2026-09-10 01:51:16.810751 | instance |
2026-09-10 01:51:16.810812 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-10 01:51:16.810825 | instance | Thursday 10 September 2026  01:51:16 +0000 (0:00:00.534)       0:00:36.459 ****
2026-09-10 01:51:17.469945 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-10 01:51:17.471160 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-10 01:51:17.471222 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-10 01:51:17.471233 | instance |
2026-09-10 01:51:17.471243 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-10 01:51:17.471252 | instance | Thursday 10 September 2026  01:51:17 +0000 (0:00:00.659)       0:00:37.119 ****
2026-09-10 01:51:17.996227 | instance | changed: [instance]
2026-09-10 01:51:17.996999 | instance |
2026-09-10 01:51:17.997067 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-10 01:51:17.997079 | instance | Thursday 10 September 2026  01:51:17 +0000 (0:00:00.526)       0:00:37.645 ****
2026-09-10 01:51:18.545815 | instance | changed: [instance]
2026-09-10 01:51:18.545895 | instance |
2026-09-10 01:51:18.546677 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-10 01:51:18.546741 | instance | Thursday 10 September 2026  01:51:18 +0000 (0:00:00.522)       0:00:38.168 ****
2026-09-10 01:51:18.546749 | instance |
2026-09-10 01:51:18.546756 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-10 01:51:18.546762 | instance | Thursday 10 September 2026  01:51:18 +0000 (0:00:00.027)       0:00:38.195 ****
2026-09-10 01:51:19.380476 | instance | ok: [instance]
2026-09-10 01:51:19.381176 | instance |
2026-09-10 01:51:19.381208 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-10 01:51:19.381229 | instance | Thursday 10 September 2026  01:51:19 +0000 (0:00:00.834)       0:00:39.030 ****
2026-09-10 01:51:20.563335 | instance | changed: [instance]
2026-09-10 01:51:20.563434 | instance |
2026-09-10 01:51:20.563701 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-10 01:51:20.563872 | instance | Thursday 10 September 2026  01:51:20 +0000 (0:00:01.183)       0:00:40.213 ****
2026-09-10 01:51:21.185169 | instance | changed: [instance]
2026-09-10 01:51:21.185256 | instance |
2026-09-10 01:51:21.185621 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-10 01:51:21.185673 | instance | Thursday 10 September 2026  01:51:21 +0000 (0:00:00.621)       0:00:40.835 ****
2026-09-10 01:51:21.250521 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-10 01:51:21.250598 | instance |
2026-09-10 01:51:21.250856 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-10 01:51:21.250916 | instance | Thursday 10 September 2026  01:51:21 +0000 (0:00:00.065)       0:00:40.900 ****
2026-09-10 01:51:28.414320 | instance | changed: [instance]
2026-09-10 01:51:28.414564 | instance |
2026-09-10 01:51:28.414577 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-10 01:51:28.414753 | instance | Thursday 10 September 2026  01:51:28 +0000 (0:00:07.163)       0:00:48.064 ****
2026-09-10 01:51:29.090869 | instance | ok: [instance] => (item=chronyd)
2026-09-10 01:51:29.090931 | instance | ok: [instance] => (item=sshd)
2026-09-10 01:51:29.090943 | instance |
2026-09-10 01:51:29.090952 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-10 01:51:29.090962 | instance | Thursday 10 September 2026  01:51:29 +0000 (0:00:00.675)       0:00:48.739 ****
2026-09-10 01:51:39.931256 | instance | changed: [instance]
2026-09-10 01:51:39.931790 | instance |
2026-09-10 01:51:39.931980 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-10 01:51:39.931997 | instance | Thursday 10 September 2026  01:51:39 +0000 (0:00:10.841)       0:00:59.580 ****
2026-09-10 01:51:40.169692 | instance | ok: [instance]
2026-09-10 01:51:40.170521 | instance |
2026-09-10 01:51:40.170601 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-10 01:51:40.170615 | instance | Thursday 10 September 2026  01:51:40 +0000 (0:00:00.238)       0:00:59.818 ****
2026-09-10 01:51:40.723154 | instance | changed: [instance]
2026-09-10 01:51:40.723722 | instance |
2026-09-10 01:51:40.723806 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-10 01:51:40.723999 | instance | Thursday 10 September 2026  01:51:40 +0000 (0:00:00.553)       0:01:00.372 ****
2026-09-10 01:51:41.134608 | instance | changed: [instance]
2026-09-10 01:51:41.134688 | instance |
2026-09-10 01:51:41.135030 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-10 01:51:41.135098 | instance | Thursday 10 September 2026  01:51:41 +0000 (0:00:00.411)       0:01:00.783 ****
2026-09-10 01:51:41.280595 | instance | ok: [instance]
2026-09-10 01:51:41.281426 | instance |
2026-09-10 01:51:41.281496 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-10 01:51:41.281510 | instance | Thursday 10 September 2026  01:51:41 +0000 (0:00:00.145)       0:01:00.929 ****
2026-09-10 01:51:41.559135 | instance | ok: [instance] => (item=instance)
2026-09-10 01:51:41.559206 | instance |
2026-09-10 01:51:41.559218 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-10 01:51:41.559228 | instance | Thursday 10 September 2026  01:51:41 +0000 (0:00:00.278)       0:01:01.207 ****
2026-09-10 01:51:41.627569 | instance | ok: [instance]
2026-09-10 01:51:41.627706 | instance |
2026-09-10 01:51:41.628039 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-10 01:51:41.628065 | instance | Thursday 10 September 2026  01:51:41 +0000 (0:00:00.069)       0:01:01.277 ****
2026-09-10 01:51:41.713383 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-10 01:51:41.713426 | instance |
2026-09-10 01:51:41.713889 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-10 01:51:41.713952 | instance | Thursday 10 September 2026  01:51:41 +0000 (0:00:00.085)       0:01:01.363 ****
2026-09-10 01:51:42.097503 | instance | changed: [instance]
2026-09-10 01:51:42.098530 | instance |
2026-09-10 01:51:42.098601 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-10 01:51:42.098613 | instance | Thursday 10 September 2026  01:51:42 +0000 (0:00:00.383)       0:01:01.746 ****
2026-09-10 01:51:42.879079 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-10 01:51:42.879179 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-10 01:51:42.879257 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-10 01:51:42.879640 | instance |
2026-09-10 01:51:42.879706 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-10 01:51:42.879713 | instance | Thursday 10 September 2026  01:51:42 +0000 (0:00:00.782)       0:01:02.529 ****
2026-09-10 01:53:18.618825 | instance | ok: [instance]
2026-09-10 01:53:18.619516 | instance |
2026-09-10 01:53:18.619535 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-10 01:53:18.619546 | instance | Thursday 10 September 2026  01:53:18 +0000 (0:01:35.739)       0:02:38.269 ****
2026-09-10 01:53:18.867687 | instance | changed: [instance]
2026-09-10 01:53:18.867747 | instance |
2026-09-10 01:53:18.868280 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-10 01:53:18.868302 | instance | Thursday 10 September 2026  01:53:18 +0000 (0:00:00.248)       0:02:38.517 ****
2026-09-10 01:53:18.952206 | instance | ok: [instance]
2026-09-10 01:53:18.952250 | instance |
2026-09-10 01:53:18.952256 | instance | TASK [Install Ceph host] *******************************************************
2026-09-10 01:53:18.952260 | instance | Thursday 10 September 2026  01:53:18 +0000 (0:00:00.085)       0:02:38.602 ****
2026-09-10 01:53:19.039089 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-10 01:53:19.039150 | instance |
2026-09-10 01:53:19.039161 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-10 01:53:19.039172 | instance | Thursday 10 September 2026  01:53:19 +0000 (0:00:00.086)       0:02:38.688 ****
2026-09-10 01:53:20.606292 | instance | ok: [instance]
2026-09-10 01:53:20.606370 | instance |
2026-09-10 01:53:20.606387 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-10 01:53:20.606402 | instance | Thursday 10 September 2026  01:53:20 +0000 (0:00:01.566)       0:02:40.255 ****
2026-09-10 01:53:20.654987 | instance | ok: [instance] => (item=instance)
2026-09-10 01:53:20.655054 | instance |
2026-09-10 01:53:20.655072 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-10 01:53:20.655086 | instance | Thursday 10 September 2026  01:53:20 +0000 (0:00:00.048)       0:02:40.303 ****
2026-09-10 01:53:21.006046 | instance | ok: [instance]
2026-09-10 01:53:21.006096 | instance |
2026-09-10 01:53:21.006108 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-10 01:53:21.006119 | instance | Thursday 10 September 2026  01:53:21 +0000 (0:00:00.351)       0:02:40.655 ****
2026-09-10 01:53:23.266984 | instance | ok: [instance]
2026-09-10 01:53:23.267060 | instance |
2026-09-10 01:53:23.267071 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-10 01:53:23.267081 | instance | Thursday 10 September 2026  01:53:23 +0000 (0:00:02.260)       0:02:42.915 ****
2026-09-10 01:54:17.888312 | 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-10 01:54:17.889210 | 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_vcdud8y9/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_vcdud8y9/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_vcdud8y9/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_vcdud8y9/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-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBjDaJqX5/5BCAAln5sVhIYgWSQC8NmIN1zznFylJNIedB/2fpdFHARZyA=: Malformed input [buffer:3]\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBjDaJqX5/5BCAAln5sVhIYgWSQC8NmIN1zznFylJNIedB/2fpdFHARZyA=: Malformed input [buffer:3]\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBjDaJqX5/5BCAAln5sVhIYgWSQC8NmIN1zznFylJNIedB/2fpdFHARZyA=: Malformed input [buffer:3]\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T01:54:17.713+0000 7f5e2eeb6640 -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-10 01:54:17.892462 | instance |
2026-09-10 01:54:17.895745 | instance | PLAY RECAP *********************************************************************
2026-09-10 01:54:17.895819 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-10 01:54:17.895832 | instance |
2026-09-10 01:54:17.895843 | instance | Thursday 10 September 2026  01:54:17 +0000 (0:00:54.627)       0:03:37.543 ****
2026-09-10 01:54:17.895852 | instance | ===============================================================================
2026-09-10 01:54:17.895861 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 95.74s
2026-09-10 01:54:17.895870 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 54.63s
2026-09-10 01:54:17.895879 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 10.84s
2026-09-10 01:54:17.895888 | instance | vexxhost.containers.download_artifact : Download item ------------------- 7.96s
2026-09-10 01:54:17.895896 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 7.16s
2026-09-10 01:54:17.895905 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.30s
2026-09-10 01:54:17.895914 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.44s
2026-09-10 01:54:17.895922 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.96s
2026-09-10 01:54:17.895949 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.26s
2026-09-10 01:54:17.895964 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.77s
2026-09-10 01:54:17.898039 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.57s
2026-09-10 01:54:17.898073 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.47s
2026-09-10 01:54:17.898083 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.29s
2026-09-10 01:54:17.898092 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.18s
2026-09-10 01:54:17.898101 | instance | Gathering Facts --------------------------------------------------------- 1.09s
2026-09-10 01:54:17.898110 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.09s
2026-09-10 01:54:17.898118 | instance | Gathering Facts --------------------------------------------------------- 0.99s
2026-09-10 01:54:17.898127 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-10 01:54:17.898135 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.78s
2026-09-10 01:54:17.898144 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.74s
2026-09-10 01:54:18.011219 | 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-10 01:54:18.011574 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-10 01:54:18.011821 | 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-10 01:54:18.418898 | instance | ERROR
2026-09-10 01:54:18.419703 | instance | {
2026-09-10 01:54:18.419764 | instance |   "delta": "0:04:32.676436",
2026-09-10 01:54:18.419795 | instance |   "end": "2026-09-10 01:54:18.086792",
2026-09-10 01:54:18.419820 | instance |   "msg": "non-zero return code",
2026-09-10 01:54:18.419843 | instance |   "rc": 2,
2026-09-10 01:54:18.419866 | instance |   "start": "2026-09-10 01:49:45.410356"
2026-09-10 01:54:18.419889 | instance | }
failure
2026-09-10 01:54:18.426016 | 
2026-09-10 01:54:18.426075 | PLAY RECAP
2026-09-10 01:54:18.426133 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-10 01:54:18.426164 | 
2026-09-10 01:54:18.567765 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-10 01:54:18.572830 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-10 01:54:19.212727 | 
2026-09-10 01:54:19.213459 | PLAY [all]
2026-09-10 01:54:19.226720 | 
2026-09-10 01:54:19.226796 | TASK [gather-host-logs : creating directory for system status]
2026-09-10 01:54:19.655028 | instance | changed
2026-09-10 01:54:19.665361 | 
2026-09-10 01:54:19.665522 | TASK [gather-host-logs : Get logs for each host]
2026-09-10 01:54:20.052448 | instance | + systemd-cgls --full --all --no-pager
2026-09-10 01:54:20.068522 | instance | + ip addr
2026-09-10 01:54:20.071051 | instance | + ip route
2026-09-10 01:54:20.073911 | instance | + lsblk
2026-09-10 01:54:20.079083 | instance | + mount
2026-09-10 01:54:20.082570 | instance | + docker images
2026-09-10 01:54:20.106538 | instance | + brctl show
2026-09-10 01:54:20.107157 | instance | /bin/bash: line 8: brctl: command not found
2026-09-10 01:54:20.107473 | instance | + ps aux --sort=-%mem
2026-09-10 01:54:20.128503 | instance | + dpkg -l
2026-09-10 01:54:20.141421 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-10 01:54:20.142062 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-10 01:54:20.162090 | instance | + '[' '!' -z '' ']'
2026-09-10 01:54:20.212404 | instance | ok: Runtime: 0:00:00.115518
2026-09-10 01:54:20.220670 | 
2026-09-10 01:54:20.220755 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-10 01:54:20.893224 | instance | changed:
2026-09-10 01:54:20.893481 | instance | created directory /var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/logs/instance
2026-09-10 01:54:20.893537 | instance | cd+++++++++ system/
2026-09-10 01:54:20.893580 | instance | >f+++++++++ system/brctl-show.txt
2026-09-10 01:54:20.893639 | instance | >f+++++++++ system/docker-images.txt
2026-09-10 01:54:20.893682 | instance | >f+++++++++ system/ip-addr.txt
2026-09-10 01:54:20.893726 | instance | >f+++++++++ system/ip-route.txt
2026-09-10 01:54:20.893767 | instance | >f+++++++++ system/lsblk.txt
2026-09-10 01:54:20.893807 | instance | >f+++++++++ system/mount.txt
2026-09-10 01:54:20.893844 | instance | >f+++++++++ system/packages.txt
2026-09-10 01:54:20.893882 | instance | >f+++++++++ system/ps.txt
2026-09-10 01:54:20.893924 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-10 01:54:20.912671 | 
2026-09-10 01:54:20.912902 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-10 01:54:21.132454 | instance | changed: "values"
2026-09-10 01:54:21.321246 | instance | changed: "releases"
2026-09-10 01:54:21.336375 | 
2026-09-10 01:54:21.336638 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-10 01:54:21.586188 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-10 01:54:21.886813 | instance | ok: Runtime: 0:00:00.004954
2026-09-10 01:54:21.896983 | 
2026-09-10 01:54:21.897122 | TASK [helm-release-status : Downloads logs to executor]
2026-09-10 01:54:22.471666 | instance | changed:
2026-09-10 01:54:22.471941 | instance | cd+++++++++ helm/
2026-09-10 01:54:22.471996 | instance | cd+++++++++ helm/releases/
2026-09-10 01:54:22.472039 | instance | cd+++++++++ helm/values/
2026-09-10 01:54:22.490218 | 
2026-09-10 01:54:22.490364 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-10 01:54:22.741586 | instance | changed
2026-09-10 01:54:22.753564 | 
2026-09-10 01:54:22.753732 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-10 01:54:23.104299 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 01:54:23.104487 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 01:54:23.110351 | instance | environment: line 1: kubectl: command not found
2026-09-10 01:54:23.111887 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 01:54:23.112235 | instance | environment: line 1: kubectl: command not found
2026-09-10 01:54:23.113718 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 01:54:23.115490 | instance | environment: line 1: kubectl: command not found
2026-09-10 01:54:23.117309 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 01:54:23.118100 | instance | environment: line 1: kubectl: command not found
2026-09-10 01:54:23.119662 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 01:54:23.122247 | instance | environment: line 1: kubectl: command not found
2026-09-10 01:54:23.123926 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 01:54:23.318593 | instance | ok: Runtime: 0:00:00.030798
2026-09-10 01:54:23.328389 | 
2026-09-10 01:54:23.328544 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-10 01:54:23.566301 | instance | changed
2026-09-10 01:54:23.576538 | 
2026-09-10 01:54:23.576727 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-10 01:54:23.837584 | instance | environment: line 5: kubectl: command not found
2026-09-10 01:54:23.838623 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 01:54:23.839056 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 01:54:23.839822 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 01:54:24.123792 | instance | ok: Runtime: 0:00:00.010035
2026-09-10 01:54:24.134488 | 
2026-09-10 01:54:24.134744 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-10 01:54:24.677037 | instance | changed:
2026-09-10 01:54:24.677317 | instance | cd+++++++++ objects/
2026-09-10 01:54:24.677371 | instance | cd+++++++++ objects/cluster/
2026-09-10 01:54:24.677413 | instance | cd+++++++++ objects/namespaced/
2026-09-10 01:54:24.695812 | 
2026-09-10 01:54:24.695944 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-10 01:54:24.927215 | instance | changed
2026-09-10 01:54:24.939436 | 
2026-09-10 01:54:24.939567 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-10 01:54:25.141806 | instance | changed
2026-09-10 01:54:25.145965 | 
2026-09-10 01:54:25.146067 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-10 01:54:25.382580 | instance | environment: line 3: kubectl: command not found
2026-09-10 01:54:25.678131 | instance | ok: Runtime: 0:00:00.010624
2026-09-10 01:54:25.687418 | 
2026-09-10 01:54:25.687542 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-10 01:54:26.196855 | instance | changed:
2026-09-10 01:54:26.197114 | instance | cd+++++++++ pod-logs/
2026-09-10 01:54:26.197199 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-10 01:54:26.215936 | 
2026-09-10 01:54:26.216041 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-10 01:54:26.437977 | instance | changed
2026-09-10 01:54:26.442542 | 
2026-09-10 01:54:26.442610 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-10 01:54:26.685049 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-10 01:54:26.975647 | instance | ok: Runtime: 0:00:00.052930
2026-09-10 01:54:26.984855 | 
2026-09-10 01:54:26.984989 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-10 01:54:27.217938 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-10 01:54:27.273978 | instance | ceph-mgr endpoints:
2026-09-10 01:54:27.533744 | instance | ok: Runtime: 0:00:00.062119
2026-09-10 01:54:27.546133 | 
2026-09-10 01:54:27.546297 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-10 01:54:27.804464 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-10 01:54:28.100891 | instance | ok: Runtime: 0:00:00.025759
2026-09-10 01:54:28.113654 | 
2026-09-10 01:54:28.113886 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-10 01:54:28.662751 | instance | changed: cd+++++++++ prometheus/
2026-09-10 01:54:28.682725 | 
2026-09-10 01:54:28.682856 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-10 01:54:28.895133 | instance | changed
2026-09-10 01:54:28.906889 | 
2026-09-10 01:54:28.907026 | TASK [gather-selenium-data : Get selenium data]
2026-09-10 01:54:29.196959 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-10 01:54:29.198508 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-10 01:54:29.450003 | instance | ERROR
2026-09-10 01:54:29.450235 | instance | {
2026-09-10 01:54:29.450297 | instance |   "delta": "0:00:00.007130",
2026-09-10 01:54:29.450339 | instance |   "end": "2026-09-10 01:54:29.198961",
2026-09-10 01:54:29.450383 | instance |   "msg": "non-zero return code",
2026-09-10 01:54:29.450425 | instance |   "rc": 1,
2026-09-10 01:54:29.450479 | instance |   "start": "2026-09-10 01:54:29.191831"
2026-09-10 01:54:29.450539 | instance | }
2026-09-10 01:54:29.450601 | instance | ERROR: Ignoring Errors
2026-09-10 01:54:29.459759 | 
2026-09-10 01:54:29.459908 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-10 01:54:29.982941 | instance | changed: cd+++++++++ selenium/
2026-09-10 01:54:29.994354 | 
2026-09-10 01:54:29.994494 | PLAY RECAP
2026-09-10 01:54:29.994579 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-10 01:54:29.994621 | 
2026-09-10 01:54:30.251141 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-10 01:54:30.255154 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-10 01:54:30.873264 | 
2026-09-10 01:54:30.873659 | PLAY [all]
2026-09-10 01:54:30.884534 | 
2026-09-10 01:54:30.884608 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-10 01:54:30.949271 | instance | skipping: Conditional result was False
2026-09-10 01:54:30.956711 | 
2026-09-10 01:54:30.956828 | TASK [fetch-output : Set log path for single node]
2026-09-10 01:54:30.987192 | instance | ok
2026-09-10 01:54:30.993088 | 
2026-09-10 01:54:30.993190 | LOOP [fetch-output : Ensure local output dirs]
2026-09-10 01:54:31.409884 | instance -> localhost | ok: "/var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/logs"
2026-09-10 01:54:31.671946 | instance -> localhost | changed: "/var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/artifacts"
2026-09-10 01:54:31.907894 | instance -> localhost | changed: "/var/lib/zuul/builds/8835ed877f534ea69d658496073b052e/work/docs"
2026-09-10 01:54:31.926405 | 
2026-09-10 01:54:31.926661 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-10 01:54:32.636081 | instance | changed: .d..t...... ./
2026-09-10 01:54:32.636426 | instance | changed: All items complete
2026-09-10 01:54:32.636541 | 
2026-09-10 01:54:33.146150 | instance | changed: .d..t...... ./
2026-09-10 01:54:33.704449 | instance | changed: .d..t...... ./
2026-09-10 01:54:33.744821 | 
2026-09-10 01:54:33.745072 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-10 01:54:34.243685 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008308
2026-09-10 01:54:34.497590 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006746
2026-09-10 01:54:34.507650 | 
2026-09-10 01:54:34.507739 | PLAY [all]
2026-09-10 01:54:34.512953 | 
2026-09-10 01:54:34.513026 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-10 01:54:34.994434 | instance | changed
2026-09-10 01:54:35.004536 | 
2026-09-10 01:54:35.004666 | PLAY RECAP
2026-09-10 01:54:35.004756 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-10 01:54:35.004987 | 
2026-09-10 01:54:35.154052 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-10 01:54:35.158403 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-10 01:54:35.772059 | 
2026-09-10 01:54:35.772194 | PLAY [localhost]
2026-09-10 01:54:35.781821 | 
2026-09-10 01:54:35.781893 | TASK [Generate Zuul manifest]
2026-09-10 01:54:35.798339 | localhost | ok
2026-09-10 01:54:35.813519 | 
2026-09-10 01:54:35.813610 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-10 01:54:36.199207 | localhost | changed
2026-09-10 01:54:36.222615 | 
2026-09-10 01:54:36.222817 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-10 01:54:36.257009 | localhost | ok
2026-09-10 01:54:36.271087 | 
2026-09-10 01:54:36.271216 | TASK [Upload logs]
2026-09-10 01:54:36.297923 | localhost | ok
2026-09-10 01:54:36.370223 | 
2026-09-10 01:54:36.370369 | TASK [Set zuul-log-path fact]
2026-09-10 01:54:36.389365 | localhost | ok
2026-09-10 01:54:36.400269 | 
2026-09-10 01:54:36.400340 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-10 01:54:36.438152 | localhost | ok
2026-09-10 01:54:36.444406 | 
2026-09-10 01:54:36.444477 | TASK [upload-logs : Create log directories]
2026-09-10 01:54:36.894519 | localhost | changed
2026-09-10 01:54:36.905092 | 
2026-09-10 01:54:36.905238 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-10 01:54:37.350049 | localhost -> localhost | ok: Runtime: 0:00:00.006074
2026-09-10 01:54:37.356216 | 
2026-09-10 01:54:37.356301 | TASK [upload-logs : Upload logs to log server]
2026-09-10 01:54:37.875355 | localhost | Output suppressed because no_log was given
2026-09-10 01:54:37.945446 | 
2026-09-10 01:54:37.945599 | LOOP [upload-logs : Compress console log and json output]
2026-09-10 01:54:38.009840 | localhost | skipping: Conditional result was False
2026-09-10 01:54:38.019506 | localhost | skipping: Conditional result was False
2026-09-10 01:54:38.030282 | 
2026-09-10 01:54:38.030505 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-10 01:54:38.076160 | localhost | skipping: Conditional result was False
2026-09-10 01:54:38.076584 | 
2026-09-10 01:54:38.079665 | localhost | skipping: Conditional result was False
2026-09-10 01:54:38.096471 | 
2026-09-10 01:54:38.096798 | LOOP [upload-logs : Upload console log and json output]