2026-08-22 18:38:47.883441 | Job console starting
2026-08-22 18:38:47.894849 | Updating git repos
2026-08-22 18:38:49.484756 | Cloning repos into workspace
2026-08-22 18:39:08.222016 | Restoring repo states
2026-08-22 18:39:15.387371 | Merging changes
2026-08-22 18:39:16.584252 | Checking out repos
2026-08-22 18:39:21.545116 | Preparing playbooks
2026-08-22 18:39:24.581219 | Running Ansible setup
2026-08-22 18:39:28.120010 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 18:39:28.689323 | 
2026-08-22 18:39:28.689435 | PLAY [localhost]
2026-08-22 18:39:28.696419 | 
2026-08-22 18:39:28.696486 | TASK [Gathering Facts]
2026-08-22 18:39:29.606802 | localhost | ok
2026-08-22 18:39:29.615201 | 
2026-08-22 18:39:29.615336 | TASK [Setup log path fact]
2026-08-22 18:39:29.633059 | localhost | ok
2026-08-22 18:39:29.642557 | 
2026-08-22 18:39:29.642621 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 18:39:29.669222 | localhost | ok
2026-08-22 18:39:29.674757 | 
2026-08-22 18:39:29.674823 | TASK [emit-job-header : Print job information]
2026-08-22 18:39:29.712195 | # Job Information
2026-08-22 18:39:29.712332 | Ansible Version: 2.16.18
2026-08-22 18:39:29.712365 | Job: atmosphere-molecule-csi-rbd
2026-08-22 18:39:29.712387 | Pipeline: check
2026-08-22 18:39:29.712407 | Executor: 2d72f0692154
2026-08-22 18:39:29.712426 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092
2026-08-22 18:39:29.712448 | Event ID: 327735a0-9e58-11f1-9956-766f5528ef23
2026-08-22 18:39:29.715150 | 
2026-08-22 18:39:29.715213 | LOOP [emit-job-header : Print node information]
2026-08-22 18:39:29.823068 | localhost | ok:
2026-08-22 18:39:29.996190 | localhost | # Node Information
2026-08-22 18:39:29.996315 | localhost | Inventory Hostname: instance
2026-08-22 18:39:29.996352 | localhost | Hostname: np0000190715
2026-08-22 18:39:29.996392 | localhost | Username: zuul
2026-08-22 18:39:29.996441 | localhost | Distro: Ubuntu 22.04
2026-08-22 18:39:29.996484 | localhost | Provider: yul1
2026-08-22 18:39:29.996526 | localhost | Region: ca-ymq-1
2026-08-22 18:39:29.996566 | localhost | Label: ubuntu-jammy
2026-08-22 18:39:29.996609 | localhost | Product Name: OpenStack Nova
2026-08-22 18:39:29.996655 | localhost | Interface IP: 199.204.45.223
2026-08-22 18:39:30.009180 | 
2026-08-22 18:39:30.009306 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 18:39:30.401956 | localhost -> localhost | changed
2026-08-22 18:39:30.410486 | 
2026-08-22 18:39:30.410579 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 18:39:31.212804 | localhost -> localhost | changed
2026-08-22 18:39:31.221968 | 
2026-08-22 18:39:31.222051 | PLAY [all]
2026-08-22 18:39:31.233112 | 
2026-08-22 18:39:31.233623 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 18:39:31.449769 | instance -> localhost | ok
2026-08-22 18:39:31.455391 | 
2026-08-22 18:39:31.455455 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 18:39:31.486786 | instance | ok
2026-08-22 18:39:31.502323 | instance | included: /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 18:39:31.507855 | 
2026-08-22 18:39:31.507913 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 18:39:32.681956 | instance -> localhost | Generating public/private rsa key pair.
2026-08-22 18:39:32.682115 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/af42aab273444341890122886cdd9a66_id_rsa
2026-08-22 18:39:32.682150 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/af42aab273444341890122886cdd9a66_id_rsa.pub
2026-08-22 18:39:32.682178 | instance -> localhost | The key fingerprint is:
2026-08-22 18:39:32.682200 | instance -> localhost | SHA256:ZVoaNpAsdIzw9y5aC056QLZwriUg8td17AjnHseRluU zuul-build-sshkey
2026-08-22 18:39:32.682231 | instance -> localhost | The key's randomart image is:
2026-08-22 18:39:32.682253 | instance -> localhost | +---[RSA 3072]----+
2026-08-22 18:39:32.682279 | instance -> localhost | |  .o.+o.         |
2026-08-22 18:39:32.682301 | instance -> localhost | |   .o.+.    .    |
2026-08-22 18:39:32.682321 | instance -> localhost | |    ... +.+=     |
2026-08-22 18:39:32.682341 | instance -> localhost | |= +  ..ooOB E    |
2026-08-22 18:39:32.682360 | instance -> localhost | |+B . . =S* .     |
2026-08-22 18:39:32.682379 | instance -> localhost | |. * . ..+ +      |
2026-08-22 18:39:32.682398 | instance -> localhost | | + oo o..o       |
2026-08-22 18:39:32.682417 | instance -> localhost | |.  +.+ o.        |
2026-08-22 18:39:32.682439 | instance -> localhost | |  ..o .          |
2026-08-22 18:39:32.682459 | instance -> localhost | +----[SHA256]-----+
2026-08-22 18:39:32.682501 | instance -> localhost | ok: Runtime: 0:00:00.633586
2026-08-22 18:39:32.688465 | 
2026-08-22 18:39:32.688532 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 18:39:32.720932 | instance | ok
2026-08-22 18:39:32.731001 | instance | included: /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 18:39:32.738192 | 
2026-08-22 18:39:32.738251 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 18:39:32.761619 | instance | skipping: Conditional result was False
2026-08-22 18:39:32.768581 | 
2026-08-22 18:39:32.768664 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 18:39:33.192315 | instance | changed
2026-08-22 18:39:33.199289 | 
2026-08-22 18:39:33.199584 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 18:39:33.370222 | instance | ok
2026-08-22 18:39:33.375160 | 
2026-08-22 18:39:33.375227 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 18:39:33.835318 | instance | changed
2026-08-22 18:39:34.053098 | 
2026-08-22 18:39:34.053241 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 18:39:34.496430 | instance | changed
2026-08-22 18:39:34.503121 | 
2026-08-22 18:39:34.503203 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 18:39:34.519711 | instance | skipping: Conditional result was False
2026-08-22 18:39:34.525917 | 
2026-08-22 18:39:34.526001 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 18:39:35.121117 | instance -> localhost | changed
2026-08-22 18:39:35.134952 | 
2026-08-22 18:39:35.135040 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 18:39:35.457313 | instance -> localhost | Identity added: /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/af42aab273444341890122886cdd9a66_id_rsa (zuul-build-sshkey)
2026-08-22 18:39:35.639192 | instance -> localhost | ok: Runtime: 0:00:00.013330
2026-08-22 18:39:35.648982 | 
2026-08-22 18:39:35.649068 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 18:39:35.967519 | instance | ok
2026-08-22 18:39:35.973899 | 
2026-08-22 18:39:35.973998 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 18:39:35.998018 | instance | skipping: Conditional result was False
2026-08-22 18:39:36.012736 | 
2026-08-22 18:39:36.012823 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 18:39:36.347873 | instance | ok
2026-08-22 18:39:36.517273 | 
2026-08-22 18:39:36.517372 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 18:39:52.895298 | instance | Output suppressed because no_log was given
2026-08-22 18:39:52.904266 | 
2026-08-22 18:39:52.904328 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 18:39:53.085806 | instance | ok: "logs"
2026-08-22 18:39:53.086061 | instance | ok: All items complete
2026-08-22 18:39:53.086251 | 
2026-08-22 18:39:53.237392 | instance | ok: "artifacts"
2026-08-22 18:39:53.408927 | instance | ok: "docs"
2026-08-22 18:39:53.428078 | 
2026-08-22 18:39:53.428232 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 18:39:53.608342 | instance | changed: "logs"
2026-08-22 18:39:53.750843 | instance | changed: "artifacts"
2026-08-22 18:39:53.905687 | instance | changed: "docs"
2026-08-22 18:39:53.923204 | 
2026-08-22 18:39:53.923308 | PLAY RECAP
2026-08-22 18:39:53.923355 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 18:39:53.923385 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:39:53.923405 | 
2026-08-22 18:39:54.046577 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 18:39:54.048912 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 18:39:54.618481 | 
2026-08-22 18:39:54.618606 | PLAY [all]
2026-08-22 18:39:54.629291 | 
2026-08-22 18:39:54.629393 | TASK [setup-uv : Extract archive]
2026-08-22 18:39:56.753056 | instance | changed
2026-08-22 18:39:56.775388 | 
2026-08-22 18:39:56.775502 | TASK [setup-uv : Print version]
2026-08-22 18:39:57.148134 | instance | uv 0.8.13
2026-08-22 18:39:57.315547 | instance | ok: Runtime: 0:00:00.014066
2026-08-22 18:39:57.326865 | 
2026-08-22 18:39:57.326928 | TASK [Install Ansible collection siblings]
2026-08-22 18:40:05.959510 | instance | changed:
2026-08-22 18:40:05.959656 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 18:40:05.959688 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 18:40:05.959712 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 18:40:05.959733 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 18:40:05.959755 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 18:40:05.959780 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 18:40:05.959802 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 18:40:05.959824 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 18:40:05.959846 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 18:40:05.959866 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 18:40:05.959886 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 18:40:05.959905 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 18:40:05.959924 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-22 18:40:05.959945 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-22 18:40:05.959964 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-22 18:40:05.959984 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-22 18:40:05.960005 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-22 18:40:05.960025 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-22 18:40:05.960046 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-22 18:40:05.960066 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-22 18:40:05.960086 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-22 18:40:05.960106 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-22 18:40:05.960128 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 18:40:05.960158 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-22 18:40:05.960179 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-22 18:40:05.960198 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 18:40:05.960218 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 18:40:05.960237 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 18:40:05.960256 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-22 18:40:05.960275 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-22 18:40:05.960294 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 18:40:05.960314 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 18:40:05.960333 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-22 18:40:05.960353 | 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-08-22 18:40:05.960377 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.960396 | instance | Process install dependency map
2026-08-22 18:40:05.960416 | instance | Starting collection install process
2026-08-22 18:40:05.960434 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-22 18:40:05.960453 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-22 18:40:05.960472 | instance | ansible.netcommon:* was installed successfully
2026-08-22 18:40:05.960490 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-22 18:40:05.960509 | instance | Creating virtual environment at: .venv
2026-08-22 18:40:05.960527 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 18:40:05.960546 | instance | Downloading ansible-core (2.1MiB)
2026-08-22 18:40:05.960565 | instance | Downloading openstacksdk (1.7MiB)
2026-08-22 18:40:05.960584 | instance | Downloading kubernetes (1.9MiB)
2026-08-22 18:40:05.960603 | instance | Downloading rjsonnet (1.2MiB)
2026-08-22 18:40:05.960622 | instance | Downloading pygments (1.2MiB)
2026-08-22 18:40:05.960641 | instance | Downloading netaddr (2.2MiB)
2026-08-22 18:40:05.960660 | instance | Downloading setuptools (1.1MiB)
2026-08-22 18:40:05.960679 | instance | Downloading cryptography (4.2MiB)
2026-08-22 18:40:05.960697 | instance |    Building pyperclip==1.9.0
2026-08-22 18:40:05.960716 | instance |  Downloading rjsonnet
2026-08-22 18:40:05.960737 | instance |  Downloading netaddr
2026-08-22 18:40:05.960757 | instance |  Downloading pygments
2026-08-22 18:40:05.960776 | instance |  Downloading cryptography
2026-08-22 18:40:05.960795 | instance |  Downloading setuptools
2026-08-22 18:40:05.960814 | instance |  Downloading kubernetes
2026-08-22 18:40:05.960832 | instance |  Downloading ansible-core
2026-08-22 18:40:05.960850 | instance |  Downloading openstacksdk
2026-08-22 18:40:05.960869 | instance |       Built pyperclip==1.9.0
2026-08-22 18:40:05.960888 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 18:40:05.960907 | instance | Installed 79 packages in 39ms
2026-08-22 18:40:05.960925 | instance | Checked out ansible.posix to 1.6.0
2026-08-22 18:40:05.960944 | 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-08-22 18:40:05.961031 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.961056 | instance | Process install dependency map
2026-08-22 18:40:05.961076 | instance | Starting collection install process
2026-08-22 18:40:05.961095 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-22 18:40:05.961121 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-22 18:40:05.961141 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-22 18:40:05.961160 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.961179 | instance | 2.17.12
2026-08-22 18:40:05.961199 | instance | Checked out ansible.utils to v6.1.0
2026-08-22 18:40:05.961218 | 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-08-22 18:40:05.961237 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.961255 | instance | Process install dependency map
2026-08-22 18:40:05.961276 | instance | Starting collection install process
2026-08-22 18:40:05.961299 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-22 18:40:05.961318 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-22 18:40:05.961337 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-22 18:40:05.961356 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.961375 | instance | 2.17.12
2026-08-22 18:40:05.961394 | instance | Checked out atmosphere.common to v0.7.0
2026-08-22 18:40:05.961413 | 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-08-22 18:40:05.961432 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.961451 | instance | Process install dependency map
2026-08-22 18:40:05.961471 | instance | Starting collection install process
2026-08-22 18:40:05.961490 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-22 18:40:05.961509 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-22 18:40:05.961528 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-22 18:40:05.961546 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.961565 | instance | 2.17.12
2026-08-22 18:40:05.961585 | instance | Checked out community.crypto to 2.2.3
2026-08-22 18:40:05.961606 | 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-08-22 18:40:05.961626 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.961645 | instance | Process install dependency map
2026-08-22 18:40:05.961665 | instance | Starting collection install process
2026-08-22 18:40:05.961684 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-22 18:40:05.961702 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-22 18:40:05.961721 | instance | community.crypto:2.2.3 was installed successfully
2026-08-22 18:40:05.961739 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.961757 | instance | 2.17.12
2026-08-22 18:40:05.961776 | instance | Checked out community.general to 7.3.0
2026-08-22 18:40:05.961795 | 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-08-22 18:40:05.961813 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.961837 | instance | Process install dependency map
2026-08-22 18:40:05.961858 | instance | Starting collection install process
2026-08-22 18:40:05.961877 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-22 18:40:05.961895 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-22 18:40:05.961914 | instance | community.general:7.3.0 was installed successfully
2026-08-22 18:40:05.961932 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.961951 | instance | 2.17.12
2026-08-22 18:40:05.961971 | instance | Checked out community.mysql to 3.6.0
2026-08-22 18:40:05.961990 | 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-08-22 18:40:05.962009 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.962030 | instance | Process install dependency map
2026-08-22 18:40:05.962049 | instance | Starting collection install process
2026-08-22 18:40:05.962069 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-22 18:40:05.962088 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-22 18:40:05.962107 | instance | community.mysql:3.6.0 was installed successfully
2026-08-22 18:40:05.962126 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.962144 | instance | 2.17.12
2026-08-22 18:40:05.962163 | instance | Checked out kubernetes.core to 2.4.0
2026-08-22 18:40:05.962182 | 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-08-22 18:40:05.962201 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.962220 | instance | Process install dependency map
2026-08-22 18:40:05.962239 | instance | Starting collection install process
2026-08-22 18:40:05.962270 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-22 18:40:05.962309 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-22 18:40:05.962331 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-22 18:40:05.962350 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.962369 | instance | 2.17.12
2026-08-22 18:40:05.962388 | instance | Checked out openstack.cloud to 2.6.0
2026-08-22 18:40:05.962407 | 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-08-22 18:40:05.962425 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.962445 | instance | Process install dependency map
2026-08-22 18:40:05.962463 | instance | Starting collection install process
2026-08-22 18:40:05.962481 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-22 18:40:05.962499 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-22 18:40:05.962517 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-22 18:40:05.962536 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.962554 | instance | 2.17.12
2026-08-22 18:40:05.962574 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-22 18:40:05.962594 | 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-08-22 18:40:05.962619 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.962639 | instance | Process install dependency map
2026-08-22 18:40:05.962657 | instance | Starting collection install process
2026-08-22 18:40:05.962675 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-22 18:40:05.962693 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-22 18:40:05.962712 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-22 18:40:05.962730 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.962748 | instance | 2.17.12
2026-08-22 18:40:05.962766 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-22 18:40:05.962785 | 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-08-22 18:40:05.962804 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.962822 | instance | Process install dependency map
2026-08-22 18:40:05.962839 | instance | Starting collection install process
2026-08-22 18:40:05.962875 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-22 18:40:05.962895 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-22 18:40:05.962913 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-22 18:40:05.962931 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.962949 | instance | 2.17.12
2026-08-22 18:40:05.962968 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-22 18:40:05.962987 | 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-08-22 18:40:05.963005 | instance | Starting galaxy collection install process
2026-08-22 18:40:05.963024 | instance | Process install dependency map
2026-08-22 18:40:05.963042 | instance | Starting collection install process
2026-08-22 18:40:05.963060 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-22 18:40:05.963078 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-22 18:40:05.963095 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-22 18:40:05.963113 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:40:05.963131 | instance | 2.17.12
2026-08-22 18:40:05.968853 | 
2026-08-22 18:40:05.968901 | PLAY RECAP
2026-08-22 18:40:05.968947 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:40:05.969052 | 
2026-08-22 18:40:06.077940 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 18:40:06.145105 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 18:40:06.861566 | 
2026-08-22 18:40:06.861673 | PLAY [all]
2026-08-22 18:40:06.872895 | 
2026-08-22 18:40:06.872982 | TASK [Install "jq" for log collection]
2026-08-22 18:40:17.752673 | instance | changed
2026-08-22 18:40:17.755829 | 
2026-08-22 18:40:17.755885 | PLAY RECAP
2026-08-22 18:40:17.755932 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:40:17.755979 | 
2026-08-22 18:40:17.857662 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 18:40:17.860008 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 18:40:18.470482 | 
2026-08-22 18:40:18.470589 | PLAY [all]
2026-08-22 18:40:18.481267 | 
2026-08-22 18:40:18.481343 | LOOP [Check inventory directories]
2026-08-22 18:40:18.845621 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-22 18:40:19.006649 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-22 18:40:19.154523 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-22 18:40:19.174409 | 
2026-08-22 18:40:19.174621 | LOOP [Copy inventory file for Zuul]
2026-08-22 18:40:19.955242 | instance | changed:
2026-08-22 18:40:19.955522 | instance | {
2026-08-22 18:40:19.955578 | instance |   "ansible_loop_var": "item",
2026-08-22 18:40:19.955616 | instance |   "changed": false,
2026-08-22 18:40:19.955647 | instance |   "failed": false,
2026-08-22 18:40:19.955686 | instance |   "invocation": {
2026-08-22 18:40:19.955719 | instance |     "module_args": {
2026-08-22 18:40:19.955749 | instance |       "checksum_algorithm": "sha1",
2026-08-22 18:40:19.955776 | instance |       "follow": true,
2026-08-22 18:40:19.955803 | instance |       "get_attributes": true,
2026-08-22 18:40:19.955833 | instance |       "get_checksum": true,
2026-08-22 18:40:19.955860 | instance |       "get_mime": true,
2026-08-22 18:40:19.955889 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-22 18:40:19.955917 | instance |     }
2026-08-22 18:40:19.955944 | instance |   },
2026-08-22 18:40:19.955970 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-22 18:40:19.955996 | instance |   "stat": {
2026-08-22 18:40:19.956022 | instance |     "atime": 1787423999.077244,
2026-08-22 18:40:19.956050 | instance |     "attr_flags": "e",
2026-08-22 18:40:19.956076 | instance |     "attributes": [
2026-08-22 18:40:19.956104 | instance |       "extents"
2026-08-22 18:40:19.956132 | instance |     ],
2026-08-22 18:40:19.956159 | instance |     "block_size": 4096,
2026-08-22 18:40:19.956185 | instance |     "blocks": 8,
2026-08-22 18:40:19.956213 | instance |     "charset": "unknown",
2026-08-22 18:40:19.956242 | instance |     "ctime": 1787423998.1411743,
2026-08-22 18:40:19.956270 | instance |     "dev": 64513,
2026-08-22 18:40:19.956297 | instance |     "device_type": 0,
2026-08-22 18:40:19.956324 | instance |     "executable": true,
2026-08-22 18:40:19.956350 | instance |     "exists": true,
2026-08-22 18:40:19.956380 | instance |     "gid": 1000,
2026-08-22 18:40:19.956419 | instance |     "gr_name": "zuul",
2026-08-22 18:40:19.956451 | instance |     "inode": 1046735,
2026-08-22 18:40:19.956478 | instance |     "isblk": false,
2026-08-22 18:40:19.956504 | instance |     "ischr": false,
2026-08-22 18:40:19.956530 | instance |     "isdir": true,
2026-08-22 18:40:19.956556 | instance |     "isfifo": false,
2026-08-22 18:40:19.956581 | instance |     "isgid": false,
2026-08-22 18:40:19.956605 | instance |     "islnk": false,
2026-08-22 18:40:19.956630 | instance |     "isreg": false,
2026-08-22 18:40:19.956656 | instance |     "issock": false,
2026-08-22 18:40:19.956681 | instance |     "isuid": false,
2026-08-22 18:40:19.956706 | instance |     "mimetype": "unknown",
2026-08-22 18:40:19.956732 | instance |     "mode": "0755",
2026-08-22 18:40:19.956757 | instance |     "mtime": 1787423998.1411743,
2026-08-22 18:40:19.956783 | instance |     "nlink": 21,
2026-08-22 18:40:19.956808 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-22 18:40:19.956834 | instance |     "pw_name": "zuul",
2026-08-22 18:40:19.956861 | instance |     "readable": true,
2026-08-22 18:40:19.956898 | instance |     "rgrp": true,
2026-08-22 18:40:19.956931 | instance |     "roth": true,
2026-08-22 18:40:19.957043 | instance |     "rusr": true,
2026-08-22 18:40:19.957155 | instance |     "size": 4096,
2026-08-22 18:40:19.957325 | instance |     "uid": 1000,
2026-08-22 18:40:19.957417 | instance |     "version": "3237319625",
2026-08-22 18:40:19.957706 | instance |     "wgrp": false,
2026-08-22 18:40:19.957803 | instance |     "woth": false,
2026-08-22 18:40:19.957846 | instance |     "writeable": true,
2026-08-22 18:40:19.957921 | instance |     "wusr": true,
2026-08-22 18:40:19.957970 | instance |     "xgrp": true,
2026-08-22 18:40:19.958004 | instance |     "xoth": true,
2026-08-22 18:40:19.958078 | instance |     "xusr": true
2026-08-22 18:40:19.958125 | instance |   }
2026-08-22 18:40:19.958160 | instance | }
2026-08-22 18:40:19.958271 | instance | ok: All items complete
2026-08-22 18:40:19.958318 | 
2026-08-22 18:40:19.960419 | instance | skipping: Conditional result was False
2026-08-22 18:40:19.961201 | instance | skipping: Conditional result was False
2026-08-22 18:40:19.978693 | 
2026-08-22 18:40:19.979039 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 18:40:20.612201 | instance | changed: 1 replacements made
2026-08-22 18:40:20.615543 | instance | skipping: Conditional result was False
2026-08-22 18:40:20.620906 | instance | skipping: Conditional result was False
2026-08-22 18:40:20.631384 | 
2026-08-22 18:40:20.631523 | TASK [Run Molecule scenario]
2026-08-22 18:40:21.592391 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-22 18:40:21.968100 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 18:40:21.968178 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-22 18:40:32.489620 | instance | INFO     [csi > dependency] Executing
2026-08-22 18:40:32.490030 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-22 18:40:32.490511 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-22 18:40:32.490785 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 18:40:32.502391 | instance | INFO     [csi > cleanup] Executing
2026-08-22 18:40:32.502824 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 18:40:32.525166 | instance | INFO     [csi > destroy] Executing
2026-08-22 18:40:32.525236 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-22 18:40:32.525305 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-22 18:40:32.535962 | instance | INFO     [csi > syntax] Executing
2026-08-22 18:40:34.083720 | instance |
2026-08-22 18:40:34.084057 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 18:40:34.140499 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-22 18:40:34.153078 | instance | INFO     [csi > create] Executing
2026-08-22 18:40:34.155310 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 18:40:34.163229 | instance | INFO     [csi > prepare] Executing
2026-08-22 18:40:34.897374 | instance |
2026-08-22 18:40:34.897619 | instance | PLAY [Prepare] *****************************************************************
2026-08-22 18:40:34.897915 | instance |
2026-08-22 18:40:34.898251 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:40:34.898543 | instance | Saturday 22 August 2026  18:40:34 +0000 (0:00:00.024)       0:00:00.024 *******
2026-08-22 18:40:36.036977 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 18:40:36.037197 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 18:40:36.037521 | instance | interpreter could change the meaning of that path. See
2026-08-22 18:40:36.037867 | instance | https://docs.ansible.com/ansible-
2026-08-22 18:40:36.038190 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 18:40:36.045772 | instance | ok: [instance]
2026-08-22 18:40:36.046102 | instance |
2026-08-22 18:40:36.046387 | instance | TASK [Configure short hostname] ************************************************
2026-08-22 18:40:36.046734 | instance | Saturday 22 August 2026  18:40:36 +0000 (0:00:01.149)       0:00:01.173 *******
2026-08-22 18:40:36.708270 | instance | changed: [instance]
2026-08-22 18:40:36.708561 | instance |
2026-08-22 18:40:36.708964 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-22 18:40:36.709216 | instance | Saturday 22 August 2026  18:40:36 +0000 (0:00:00.661)       0:00:01.834 *******
2026-08-22 18:40:36.990204 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-22 18:40:36.990492 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-22 18:40:36.990769 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-22 18:40:36.998321 | instance | changed: [instance]
2026-08-22 18:40:36.998601 | instance |
2026-08-22 18:40:36.998882 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-22 18:40:36.999260 | instance | Saturday 22 August 2026  18:40:36 +0000 (0:00:00.290)       0:00:02.125 *******
2026-08-22 18:40:37.732374 | instance | ok: [instance]
2026-08-22 18:40:37.732644 | instance |
2026-08-22 18:40:37.732933 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-22 18:40:37.733184 | instance |
2026-08-22 18:40:37.733453 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:40:37.733757 | instance | Saturday 22 August 2026  18:40:37 +0000 (0:00:00.734)       0:00:02.859 *******
2026-08-22 18:40:38.431589 | instance | ok: [instance]
2026-08-22 18:40:38.431829 | instance |
2026-08-22 18:40:38.432120 | instance | TASK [Install depedencies] *****************************************************
2026-08-22 18:40:38.432465 | instance | Saturday 22 August 2026  18:40:38 +0000 (0:00:00.698)       0:00:03.558 *******
2026-08-22 18:40:59.609316 | instance | changed: [instance]
2026-08-22 18:40:59.609489 | instance |
2026-08-22 18:40:59.609772 | instance | TASK [Start up service] ********************************************************
2026-08-22 18:40:59.610114 | instance | Saturday 22 August 2026  18:40:59 +0000 (0:00:21.177)       0:00:24.736 *******
2026-08-22 18:41:00.168681 | instance | ok: [instance]
2026-08-22 18:41:00.168898 | instance |
2026-08-22 18:41:00.169235 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-22 18:41:00.169506 | instance | Saturday 22 August 2026  18:41:00 +0000 (0:00:00.559)       0:00:25.295 *******
2026-08-22 18:41:00.467534 | instance | ok: [instance]
2026-08-22 18:41:00.467599 | instance |
2026-08-22 18:41:00.467714 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-22 18:41:00.467856 | instance | Saturday 22 August 2026  18:41:00 +0000 (0:00:00.299)       0:00:25.595 *******
2026-08-22 18:41:01.120105 | instance | changed: [instance]
2026-08-22 18:41:01.120164 | instance |
2026-08-22 18:41:01.120177 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-22 18:41:01.120187 | instance | Saturday 22 August 2026  18:41:01 +0000 (0:00:00.651)       0:00:26.246 *******
2026-08-22 18:41:01.302706 | instance | ok: [instance]
2026-08-22 18:41:01.303220 | instance |
2026-08-22 18:41:01.303258 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-22 18:41:01.303266 | instance | Saturday 22 August 2026  18:41:01 +0000 (0:00:00.183)       0:00:26.430 *******
2026-08-22 18:41:01.323878 | instance | skipping: [instance]
2026-08-22 18:41:01.324392 | instance |
2026-08-22 18:41:01.324418 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-22 18:41:01.324426 | instance | Saturday 22 August 2026  18:41:01 +0000 (0:00:00.021)       0:00:26.451 *******
2026-08-22 18:41:01.854708 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:41:01.856069 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:41:01.856107 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:41:01.856112 | instance |
2026-08-22 18:41:01.856118 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-22 18:41:01.856122 | instance | Saturday 22 August 2026  18:41:01 +0000 (0:00:00.530)       0:00:26.981 *******
2026-08-22 18:41:02.441857 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:41:02.442520 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:41:02.442556 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:41:02.442562 | instance |
2026-08-22 18:41:02.442567 | instance | TASK [Start loop devices] ******************************************************
2026-08-22 18:41:02.442572 | instance | Saturday 22 August 2026  18:41:02 +0000 (0:00:00.587)       0:00:27.569 *******
2026-08-22 18:41:03.096567 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:41:03.097375 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:41:03.097405 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:41:03.097413 | instance |
2026-08-22 18:41:03.097419 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-22 18:41:03.097425 | instance | Saturday 22 August 2026  18:41:03 +0000 (0:00:00.654)       0:00:28.223 *******
2026-08-22 18:41:06.434001 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:41:06.434598 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:41:06.434605 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:41:06.434611 | instance |
2026-08-22 18:41:06.434618 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-22 18:41:06.434624 | instance | Saturday 22 August 2026  18:41:06 +0000 (0:00:03.336)       0:00:31.560 *******
2026-08-22 18:41:08.369222 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-22 18:41:08.369987 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-22 18:41:08.370037 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-22 18:41:08.370049 | instance |
2026-08-22 18:41:08.370059 | instance | PLAY RECAP *********************************************************************
2026-08-22 18:41:08.370304 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 18:41:08.370371 | instance |
2026-08-22 18:41:08.370474 | instance | Saturday 22 August 2026  18:41:08 +0000 (0:00:01.936)       0:00:33.497 *******
2026-08-22 18:41:08.371677 | instance | ===============================================================================
2026-08-22 18:41:08.371707 | instance | Install depedencies ---------------------------------------------------- 21.18s
2026-08-22 18:41:08.371718 | instance | Create a volume group for each loop device ------------------------------ 3.34s
2026-08-22 18:41:08.371727 | instance | Create a logical volume for each loop device ---------------------------- 1.94s
2026-08-22 18:41:08.371737 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-08-22 18:41:08.371746 | instance | Purge "snapd" package --------------------------------------------------- 0.73s
2026-08-22 18:41:08.371755 | instance | Gathering Facts --------------------------------------------------------- 0.70s
2026-08-22 18:41:08.373345 | instance | Configure short hostname ------------------------------------------------ 0.66s
2026-08-22 18:41:08.373387 | instance | Start loop devices ------------------------------------------------------ 0.65s
2026-08-22 18:41:08.373394 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-22 18:41:08.373401 | instance | Set permissions on loopback devices ------------------------------------- 0.59s
2026-08-22 18:41:08.373406 | instance | Start up service -------------------------------------------------------- 0.56s
2026-08-22 18:41:08.373412 | instance | Create devices for Ceph ------------------------------------------------- 0.53s
2026-08-22 18:41:08.373418 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s
2026-08-22 18:41:08.373424 | instance | Ensure hostname inside hosts file --------------------------------------- 0.29s
2026-08-22 18:41:08.373429 | instance | Get list of all loopback devices ---------------------------------------- 0.18s
2026-08-22 18:41:08.373435 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-22 18:41:08.433965 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-22 18:41:08.445049 | instance | INFO     [csi > converge] Executing
2026-08-22 18:41:09.883242 | instance |
2026-08-22 18:41:09.883735 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-22 18:41:09.884070 | instance |
2026-08-22 18:41:09.884412 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:41:09.884750 | instance | Saturday 22 August 2026  18:41:09 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-22 18:41:10.846120 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 18:41:10.846696 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 18:41:10.847083 | instance | interpreter could change the meaning of that path. See
2026-08-22 18:41:10.847420 | instance | https://docs.ansible.com/ansible-
2026-08-22 18:41:10.847754 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 18:41:10.857493 | instance | ok: [instance]
2026-08-22 18:41:10.857923 | instance |
2026-08-22 18:41:10.858452 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-22 18:41:10.858966 | instance | Saturday 22 August 2026  18:41:10 +0000 (0:00:00.974)       0:00:00.982 *******
2026-08-22 18:41:10.903472 | instance | ok: [instance] => {
2026-08-22 18:41:10.903907 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-22 18:41:10.904226 | instance | }
2026-08-22 18:41:10.904533 | instance |
2026-08-22 18:41:10.904855 | instance | PLAY [all] *********************************************************************
2026-08-22 18:41:10.905244 | instance |
2026-08-22 18:41:10.905579 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:41:10.905972 | instance | Saturday 22 August 2026  18:41:10 +0000 (0:00:00.045)       0:00:01.027 *******
2026-08-22 18:41:11.761226 | instance | ok: [instance]
2026-08-22 18:41:11.761758 | instance |
2026-08-22 18:41:11.762224 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-22 18:41:11.762720 | instance | Saturday 22 August 2026  18:41:11 +0000 (0:00:00.857)       0:00:01.885 *******
2026-08-22 18:41:11.937817 | instance | ok: [instance]
2026-08-22 18:41:11.938322 | instance |
2026-08-22 18:41:11.938713 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-22 18:41:11.939089 | instance |
2026-08-22 18:41:11.939464 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:41:11.939832 | instance | Saturday 22 August 2026  18:41:11 +0000 (0:00:00.177)       0:00:02.062 *******
2026-08-22 18:41:12.822582 | instance | ok: [instance]
2026-08-22 18:41:12.822688 | instance |
2026-08-22 18:41:12.822768 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:41:12.822907 | instance | Saturday 22 August 2026  18:41:12 +0000 (0:00:00.881)       0:00:02.944 *******
2026-08-22 18:41:13.111550 | instance | ok: [instance]
2026-08-22 18:41:13.111732 | instance |
2026-08-22 18:41:13.111893 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:41:13.112046 | instance | Saturday 22 August 2026  18:41:13 +0000 (0:00:00.289)       0:00:03.233 *******
2026-08-22 18:41:13.153463 | instance | skipping: [instance]
2026-08-22 18:41:13.153493 | instance |
2026-08-22 18:41:13.153498 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-22 18:41:13.153503 | instance | Saturday 22 August 2026  18:41:13 +0000 (0:00:00.044)       0:00:03.278 *******
2026-08-22 18:41:13.520864 | instance | changed: [instance]
2026-08-22 18:41:13.520936 | instance |
2026-08-22 18:41:13.521241 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:41:13.521304 | instance | Saturday 22 August 2026  18:41:13 +0000 (0:00:00.367)       0:00:03.645 *******
2026-08-22 18:41:13.588429 | instance | ok: [instance] => {
2026-08-22 18:41:13.588495 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-22 18:41:13.588502 | instance | }
2026-08-22 18:41:13.588507 | instance |
2026-08-22 18:41:13.588511 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:41:13.588516 | instance | Saturday 22 August 2026  18:41:13 +0000 (0:00:00.066)       0:00:03.711 *******
2026-08-22 18:41:14.337178 | instance | changed: [instance]
2026-08-22 18:41:14.337397 | instance |
2026-08-22 18:41:14.337410 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:41:14.337471 | instance | Saturday 22 August 2026  18:41:14 +0000 (0:00:00.749)       0:00:04.461 *******
2026-08-22 18:41:14.389685 | instance | skipping: [instance]
2026-08-22 18:41:14.389706 | instance |
2026-08-22 18:41:14.389711 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:41:14.389716 | instance | Saturday 22 August 2026  18:41:14 +0000 (0:00:00.052)       0:00:04.514 *******
2026-08-22 18:41:14.437337 | instance | skipping: [instance]
2026-08-22 18:41:14.437370 | instance |
2026-08-22 18:41:14.437375 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:41:14.437380 | instance | Saturday 22 August 2026  18:41:14 +0000 (0:00:00.047)       0:00:04.562 *******
2026-08-22 18:41:14.634448 | instance | ok: [instance]
2026-08-22 18:41:14.634510 | instance |
2026-08-22 18:41:14.634795 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:41:14.634834 | instance | Saturday 22 August 2026  18:41:14 +0000 (0:00:00.197)       0:00:04.759 *******
2026-08-22 18:41:15.810985 | instance | ok: [instance]
2026-08-22 18:41:15.811061 | instance |
2026-08-22 18:41:15.811301 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:41:15.811340 | instance | Saturday 22 August 2026  18:41:15 +0000 (0:00:01.176)       0:00:05.935 *******
2026-08-22 18:41:15.873760 | instance | ok: [instance] => {
2026-08-22 18:41:15.873838 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-22 18:41:15.874368 | instance | }
2026-08-22 18:41:15.874410 | instance |
2026-08-22 18:41:15.874416 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:41:15.874421 | instance | Saturday 22 August 2026  18:41:15 +0000 (0:00:00.062)       0:00:05.998 *******
2026-08-22 18:41:16.524085 | instance | changed: [instance]
2026-08-22 18:41:16.524187 | instance |
2026-08-22 18:41:16.524456 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:41:16.524495 | instance | Saturday 22 August 2026  18:41:16 +0000 (0:00:00.650)       0:00:06.649 *******
2026-08-22 18:41:19.381047 | instance | changed: [instance]
2026-08-22 18:41:19.381081 | instance |
2026-08-22 18:41:19.381086 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-22 18:41:19.381092 | instance | Saturday 22 August 2026  18:41:19 +0000 (0:00:02.856)       0:00:09.505 *******
2026-08-22 18:41:19.419018 | instance | skipping: [instance]
2026-08-22 18:41:19.419053 | instance |
2026-08-22 18:41:19.419058 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-22 18:41:19.419063 | instance | Saturday 22 August 2026  18:41:19 +0000 (0:00:00.037)       0:00:09.543 *******
2026-08-22 18:41:19.451154 | instance | skipping: [instance]
2026-08-22 18:41:19.451921 | instance |
2026-08-22 18:41:19.452080 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-22 18:41:19.452089 | instance | Saturday 22 August 2026  18:41:19 +0000 (0:00:00.032)       0:00:09.575 *******
2026-08-22 18:41:19.489370 | instance | skipping: [instance]
2026-08-22 18:41:19.489748 | instance |
2026-08-22 18:41:19.489787 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-22 18:41:19.489793 | instance | Saturday 22 August 2026  18:41:19 +0000 (0:00:00.038)       0:00:09.614 *******
2026-08-22 18:41:25.155056 | instance | changed: [instance]
2026-08-22 18:41:25.155175 | instance |
2026-08-22 18:41:25.155396 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-22 18:41:25.155428 | instance | Saturday 22 August 2026  18:41:25 +0000 (0:00:05.665)       0:00:15.279 *******
2026-08-22 18:41:25.715907 | instance | changed: [instance]
2026-08-22 18:41:25.715988 | instance |
2026-08-22 18:41:25.716217 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-22 18:41:25.716249 | instance | Saturday 22 August 2026  18:41:25 +0000 (0:00:00.561)       0:00:15.840 *******
2026-08-22 18:41:26.607385 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-22 18:41:26.607486 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-22 18:41:26.608237 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-22 18:41:26.608271 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-22 18:41:26.608277 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-22 18:41:26.608282 | instance |
2026-08-22 18:41:26.608290 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-22 18:41:26.608294 | instance | Saturday 22 August 2026  18:41:26 +0000 (0:00:00.891)       0:00:16.732 *******
2026-08-22 18:41:27.169036 | instance | changed: [instance]
2026-08-22 18:41:27.169805 | instance |
2026-08-22 18:41:27.169847 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-22 18:41:27.169852 | instance | Saturday 22 August 2026  18:41:27 +0000 (0:00:00.543)       0:00:17.276 *******
2026-08-22 18:41:27.169857 | instance |
2026-08-22 18:41:27.169861 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 18:41:27.169865 | instance | Saturday 22 August 2026  18:41:27 +0000 (0:00:00.017)       0:00:17.293 *******
2026-08-22 18:41:28.026239 | instance | ok: [instance]
2026-08-22 18:41:28.026309 | instance |
2026-08-22 18:41:28.026607 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-22 18:41:28.026640 | instance | Saturday 22 August 2026  18:41:28 +0000 (0:00:00.857)       0:00:18.151 *******
2026-08-22 18:41:28.469024 | instance | changed: [instance]
2026-08-22 18:41:28.469124 | instance |
2026-08-22 18:41:28.469394 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-22 18:41:28.469435 | instance | Saturday 22 August 2026  18:41:28 +0000 (0:00:00.442)       0:00:18.593 *******
2026-08-22 18:41:29.024117 | instance | changed: [instance]
2026-08-22 18:41:29.024243 | instance |
2026-08-22 18:41:29.024282 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:41:29.024456 | instance | Saturday 22 August 2026  18:41:29 +0000 (0:00:00.555)       0:00:19.149 *******
2026-08-22 18:41:29.233296 | instance | ok: [instance]
2026-08-22 18:41:29.233357 | instance |
2026-08-22 18:41:29.233647 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:41:29.233684 | instance | Saturday 22 August 2026  18:41:29 +0000 (0:00:00.209)       0:00:19.358 *******
2026-08-22 18:41:29.296005 | instance | ok: [instance] => {
2026-08-22 18:41:29.297317 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-22 18:41:29.297341 | instance | }
2026-08-22 18:41:29.297347 | instance |
2026-08-22 18:41:29.297351 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:41:29.297356 | instance | Saturday 22 August 2026  18:41:29 +0000 (0:00:00.062)       0:00:19.420 *******
2026-08-22 18:41:30.051646 | instance | changed: [instance]
2026-08-22 18:41:30.051717 | instance |
2026-08-22 18:41:30.052000 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:41:30.052042 | instance | Saturday 22 August 2026  18:41:30 +0000 (0:00:00.755)       0:00:20.176 *******
2026-08-22 18:41:34.385911 | instance | changed: [instance]
2026-08-22 18:41:34.385981 | instance |
2026-08-22 18:41:34.386223 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-22 18:41:34.386380 | instance | Saturday 22 August 2026  18:41:34 +0000 (0:00:04.334)       0:00:24.510 *******
2026-08-22 18:41:35.408754 | instance | ok: [instance]
2026-08-22 18:41:35.408850 | instance |
2026-08-22 18:41:35.409036 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-22 18:41:35.409164 | instance | Saturday 22 August 2026  18:41:35 +0000 (0:00:01.023)       0:00:25.533 *******
2026-08-22 18:41:35.752696 | instance | changed: [instance]
2026-08-22 18:41:35.752796 | instance |
2026-08-22 18:41:35.752909 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-22 18:41:35.753040 | instance | Saturday 22 August 2026  18:41:35 +0000 (0:00:00.343)       0:00:25.877 *******
2026-08-22 18:41:36.215163 | instance | changed: [instance]
2026-08-22 18:41:36.215479 | instance |
2026-08-22 18:41:36.215739 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-22 18:41:36.216027 | instance | Saturday 22 August 2026  18:41:36 +0000 (0:00:00.462)       0:00:26.339 *******
2026-08-22 18:41:36.781498 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-22 18:41:36.781704 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-22 18:41:36.781923 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-22 18:41:36.782072 | instance |
2026-08-22 18:41:36.782246 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-22 18:41:36.782426 | instance | Saturday 22 August 2026  18:41:36 +0000 (0:00:00.566)       0:00:26.906 *******
2026-08-22 18:41:37.228438 | instance | changed: [instance]
2026-08-22 18:41:37.228672 | instance |
2026-08-22 18:41:37.228946 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-22 18:41:37.229219 | instance | Saturday 22 August 2026  18:41:37 +0000 (0:00:00.446)       0:00:27.353 *******
2026-08-22 18:41:37.695518 | instance | changed: [instance]
2026-08-22 18:41:37.695611 | instance |
2026-08-22 18:41:37.695702 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-22 18:41:37.695820 | instance | Saturday 22 August 2026  18:41:37 +0000 (0:00:00.449)       0:00:27.802 *******
2026-08-22 18:41:37.695940 | instance |
2026-08-22 18:41:37.696060 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 18:41:37.696182 | instance | Saturday 22 August 2026  18:41:37 +0000 (0:00:00.017)       0:00:27.820 *******
2026-08-22 18:41:38.438045 | instance | ok: [instance]
2026-08-22 18:41:38.438182 | instance |
2026-08-22 18:41:38.438743 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-22 18:41:38.439020 | instance | Saturday 22 August 2026  18:41:38 +0000 (0:00:00.741)       0:00:28.562 *******
2026-08-22 18:41:39.883975 | instance | changed: [instance]
2026-08-22 18:41:39.884034 | instance |
2026-08-22 18:41:39.884040 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-22 18:41:39.884046 | instance | Saturday 22 August 2026  18:41:39 +0000 (0:00:01.445)       0:00:30.007 *******
2026-08-22 18:41:40.461109 | instance | changed: [instance]
2026-08-22 18:41:40.461186 | instance |
2026-08-22 18:41:40.461487 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-22 18:41:40.461542 | instance | Saturday 22 August 2026  18:41:40 +0000 (0:00:00.577)       0:00:30.585 *******
2026-08-22 18:41:40.514653 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-22 18:41:40.514724 | instance |
2026-08-22 18:41:40.515020 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-22 18:41:40.515067 | instance | Saturday 22 August 2026  18:41:40 +0000 (0:00:00.053)       0:00:30.639 *******
2026-08-22 18:41:45.686534 | instance | changed: [instance]
2026-08-22 18:41:45.686615 | instance |
2026-08-22 18:41:45.687019 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-22 18:41:45.687164 | instance | Saturday 22 August 2026  18:41:45 +0000 (0:00:05.172)       0:00:35.811 *******
2026-08-22 18:41:46.337235 | instance | ok: [instance] => (item=chronyd)
2026-08-22 18:41:46.337751 | instance | ok: [instance] => (item=sshd)
2026-08-22 18:41:46.337784 | instance |
2026-08-22 18:41:46.337790 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-22 18:41:46.337795 | instance | Saturday 22 August 2026  18:41:46 +0000 (0:00:00.651)       0:00:36.462 *******
2026-08-22 18:41:47.545132 | instance | changed: [instance]
2026-08-22 18:41:47.545194 | instance |
2026-08-22 18:41:47.545477 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-22 18:41:47.545517 | instance | Saturday 22 August 2026  18:41:47 +0000 (0:00:01.207)       0:00:37.669 *******
2026-08-22 18:41:47.752170 | instance | ok: [instance]
2026-08-22 18:41:47.752243 | instance |
2026-08-22 18:41:47.752509 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-22 18:41:47.752546 | instance | Saturday 22 August 2026  18:41:47 +0000 (0:00:00.206)       0:00:37.876 *******
2026-08-22 18:41:48.179523 | instance | changed: [instance]
2026-08-22 18:41:48.179588 | instance |
2026-08-22 18:41:48.179876 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-22 18:41:48.179914 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.427)       0:00:38.304 *******
2026-08-22 18:41:48.493663 | instance | changed: [instance]
2026-08-22 18:41:48.493759 | instance |
2026-08-22 18:41:48.493977 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-22 18:41:48.494046 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.313)       0:00:38.618 *******
2026-08-22 18:41:48.606592 | instance | ok: [instance]
2026-08-22 18:41:48.606699 | instance |
2026-08-22 18:41:48.606966 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-22 18:41:48.606994 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.112)       0:00:38.731 *******
2026-08-22 18:41:48.835415 | instance | ok: [instance] => (item=instance)
2026-08-22 18:41:48.835491 | instance |
2026-08-22 18:41:48.835784 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-22 18:41:48.835826 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.228)       0:00:38.960 *******
2026-08-22 18:41:48.888770 | instance | ok: [instance]
2026-08-22 18:41:48.888883 | instance |
2026-08-22 18:41:48.889285 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-22 18:41:48.889335 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.053)       0:00:39.013 *******
2026-08-22 18:41:48.953499 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-22 18:41:48.953545 | instance |
2026-08-22 18:41:48.953836 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-22 18:41:48.953869 | instance | Saturday 22 August 2026  18:41:48 +0000 (0:00:00.064)       0:00:39.078 *******
2026-08-22 18:41:49.253947 | instance | changed: [instance]
2026-08-22 18:41:49.254022 | instance |
2026-08-22 18:41:49.254289 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-22 18:41:49.254320 | instance | Saturday 22 August 2026  18:41:49 +0000 (0:00:00.300)       0:00:39.378 *******
2026-08-22 18:41:49.899419 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-22 18:41:49.899529 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-22 18:41:49.900023 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-22 18:41:49.900057 | instance |
2026-08-22 18:41:49.900063 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-22 18:41:49.900067 | instance | Saturday 22 August 2026  18:41:49 +0000 (0:00:00.645)       0:00:40.024 *******
2026-08-22 18:43:27.956278 | instance | ok: [instance]
2026-08-22 18:43:27.956362 | instance |
2026-08-22 18:43:27.956502 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-22 18:43:27.956562 | instance | Saturday 22 August 2026  18:43:27 +0000 (0:01:38.056)       0:02:18.081 *******
2026-08-22 18:43:28.177915 | instance | changed: [instance]
2026-08-22 18:43:28.178129 | instance |
2026-08-22 18:43:28.178314 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-22 18:43:28.178494 | instance | Saturday 22 August 2026  18:43:28 +0000 (0:00:00.221)       0:02:18.302 *******
2026-08-22 18:43:28.263400 | instance | ok: [instance]
2026-08-22 18:43:28.263455 | instance |
2026-08-22 18:43:28.263730 | instance | TASK [Install Ceph host] *******************************************************
2026-08-22 18:43:28.263777 | instance | Saturday 22 August 2026  18:43:28 +0000 (0:00:00.085)       0:02:18.388 *******
2026-08-22 18:43:28.338481 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-22 18:43:28.338551 | instance |
2026-08-22 18:43:28.338790 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-22 18:43:28.338834 | instance | Saturday 22 August 2026  18:43:28 +0000 (0:00:00.074)       0:02:18.463 *******
2026-08-22 18:43:29.970698 | instance | ok: [instance]
2026-08-22 18:43:29.970739 | instance |
2026-08-22 18:43:29.970745 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-22 18:43:29.970751 | instance | Saturday 22 August 2026  18:43:29 +0000 (0:00:01.632)       0:02:20.095 *******
2026-08-22 18:43:30.031528 | instance | ok: [instance] => (item=instance)
2026-08-22 18:43:30.031549 | instance |
2026-08-22 18:43:30.031554 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-22 18:43:30.031559 | instance | Saturday 22 August 2026  18:43:30 +0000 (0:00:00.061)       0:02:20.156 *******
2026-08-22 18:43:30.401136 | instance | ok: [instance]
2026-08-22 18:43:30.401235 | instance |
2026-08-22 18:43:30.401362 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-22 18:43:30.401482 | instance | Saturday 22 August 2026  18:43:30 +0000 (0:00:00.369)       0:02:20.525 *******
2026-08-22 18:43:32.657592 | instance | ok: [instance]
2026-08-22 18:43:32.657800 | instance |
2026-08-22 18:43:32.658173 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-22 18:43:32.658449 | instance | Saturday 22 August 2026  18:43:32 +0000 (0:00:02.255)       0:02:22.781 *******
2026-08-22 18:44:25.726480 | 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-08-22 18:44:25.726896 | 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_6t57w8zf/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_6t57w8zf/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_6t57w8zf/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_6t57w8zf/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-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCd7Ylqm+FwKyAAZz4Emy8AppQG437BxTCBLfIi21YXHyL4yVErpqEZIx8=: Malformed input [buffer:3]\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCd7Ylqm+FwKyAAZz4Emy8AppQG437BxTCBLfIi21YXHyL4yVErpqEZIx8=: Malformed input [buffer:3]\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCd7Ylqm+FwKyAAZz4Emy8AppQG437BxTCBLfIi21YXHyL4yVErpqEZIx8=: Malformed input [buffer:3]\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:44:25.559+0000 7fc4bf558640 -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-08-22 18:44:25.728355 | instance |
2026-08-22 18:44:25.728624 | instance | PLAY RECAP *********************************************************************
2026-08-22 18:44:25.728904 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-22 18:44:25.729142 | instance |
2026-08-22 18:44:25.729406 | instance | Saturday 22 August 2026  18:44:25 +0000 (0:00:53.071)       0:03:15.853 *******
2026-08-22 18:44:25.729655 | instance | ===============================================================================
2026-08-22 18:44:25.729943 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 98.06s
2026-08-22 18:44:25.730207 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 53.07s
2026-08-22 18:44:25.730474 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.67s
2026-08-22 18:44:25.730732 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.17s
2026-08-22 18:44:25.730989 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.33s
2026-08-22 18:44:25.731242 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.86s
2026-08-22 18:44:25.731561 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.26s
2026-08-22 18:44:25.731861 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.63s
2026-08-22 18:44:25.732124 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.60s
2026-08-22 18:44:25.732377 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.45s
2026-08-22 18:44:25.732602 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.21s
2026-08-22 18:44:25.732765 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.18s
2026-08-22 18:44:25.732929 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.02s
2026-08-22 18:44:25.733092 | instance | Gathering Facts --------------------------------------------------------- 0.97s
2026-08-22 18:44:25.733254 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.89s
2026-08-22 18:44:25.733408 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-22 18:44:25.733567 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-08-22 18:44:25.733730 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-22 18:44:25.733972 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.75s
2026-08-22 18:44:25.734140 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.65s
2026-08-22 18:44:25.820800 | 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-08-22 18:44:25.820986 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-22 18:44:25.821126 | 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-08-22 18:44:26.001602 | instance | ERROR
2026-08-22 18:44:26.002109 | instance | {
2026-08-22 18:44:26.002213 | instance |   "delta": "0:04:04.865334",
2026-08-22 18:44:26.002265 | instance |   "end": "2026-08-22 18:44:25.874704",
2026-08-22 18:44:26.002307 | instance |   "msg": "non-zero return code",
2026-08-22 18:44:26.002347 | instance |   "rc": 2,
2026-08-22 18:44:26.002386 | instance |   "start": "2026-08-22 18:40:21.009370"
2026-08-22 18:44:26.002424 | instance | }
failure
2026-08-22 18:44:26.008984 | 
2026-08-22 18:44:26.009039 | PLAY RECAP
2026-08-22 18:44:26.009083 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:44:26.009104 | 
2026-08-22 18:44:26.337533 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 18:44:27.878650 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 18:44:30.254613 | 
2026-08-22 18:44:30.254749 | PLAY [all]
2026-08-22 18:44:30.322755 | 
2026-08-22 18:44:30.322879 | TASK [gather-host-logs : creating directory for system status]
2026-08-22 18:44:31.043076 | instance | changed
2026-08-22 18:44:31.048092 | 
2026-08-22 18:44:31.048168 | TASK [gather-host-logs : Get logs for each host]
2026-08-22 18:44:31.463402 | instance | + systemd-cgls --full --all --no-pager
2026-08-22 18:44:31.482257 | instance | + ip addr
2026-08-22 18:44:31.484808 | instance | + ip route
2026-08-22 18:44:31.488082 | instance | + lsblk
2026-08-22 18:44:31.493367 | instance | + mount
2026-08-22 18:44:31.495983 | instance | + docker images
2026-08-22 18:44:31.516223 | instance | + brctl show
2026-08-22 18:44:31.516835 | instance | /bin/bash: line 8: brctl: command not found
2026-08-22 18:44:31.517152 | instance | + ps aux --sort=-%mem
2026-08-22 18:44:31.533289 | instance | + dpkg -l
2026-08-22 18:44:31.545589 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-22 18:44:31.546128 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-22 18:44:31.565809 | instance | + '[' '!' -z '' ']'
2026-08-22 18:44:31.620972 | instance | ok: Runtime: 0:00:00.108061
2026-08-22 18:44:31.626923 | 
2026-08-22 18:44:31.626989 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-22 18:44:32.359419 | instance | changed:
2026-08-22 18:44:32.359678 | instance | created directory /var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/logs/instance
2026-08-22 18:44:32.359727 | instance | cd+++++++++ system/
2026-08-22 18:44:32.359763 | instance | >f+++++++++ system/brctl-show.txt
2026-08-22 18:44:32.359795 | instance | >f+++++++++ system/docker-images.txt
2026-08-22 18:44:32.359829 | instance | >f+++++++++ system/ip-addr.txt
2026-08-22 18:44:32.359860 | instance | >f+++++++++ system/ip-route.txt
2026-08-22 18:44:32.359888 | instance | >f+++++++++ system/lsblk.txt
2026-08-22 18:44:32.359919 | instance | >f+++++++++ system/mount.txt
2026-08-22 18:44:32.359950 | instance | >f+++++++++ system/packages.txt
2026-08-22 18:44:32.359977 | instance | >f+++++++++ system/ps.txt
2026-08-22 18:44:32.360016 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-22 18:44:32.371150 | 
2026-08-22 18:44:32.371223 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 18:44:32.572086 | instance | changed: "values"
2026-08-22 18:44:32.730002 | instance | changed: "releases"
2026-08-22 18:44:32.748537 | 
2026-08-22 18:44:32.748780 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 18:44:32.961657 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-22 18:44:33.289976 | instance | ok: Runtime: 0:00:00.006732
2026-08-22 18:44:33.296981 | 
2026-08-22 18:44:33.297075 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 18:44:33.768842 | instance | changed:
2026-08-22 18:44:33.769075 | instance | cd+++++++++ helm/
2026-08-22 18:44:33.769106 | instance | cd+++++++++ helm/releases/
2026-08-22 18:44:33.769128 | instance | cd+++++++++ helm/values/
2026-08-22 18:44:33.778390 | 
2026-08-22 18:44:33.778473 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 18:44:33.987548 | instance | changed
2026-08-22 18:44:33.994240 | 
2026-08-22 18:44:33.994320 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 18:44:34.249711 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:44:34.249843 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:44:34.255623 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:44:34.256351 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:44:34.257951 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:44:34.259339 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:44:34.260977 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:44:34.262126 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:44:34.262245 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:44:34.263143 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:44:34.264967 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:44:34.266288 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:44:34.539436 | instance | ok: Runtime: 0:00:00.025890
2026-08-22 18:44:34.546334 | 
2026-08-22 18:44:34.546413 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 18:44:34.741449 | instance | changed
2026-08-22 18:44:34.746573 | 
2026-08-22 18:44:34.746640 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 18:44:34.961191 | instance | environment: line 5: kubectl: command not found
2026-08-22 18:44:34.962200 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:44:34.962498 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:44:34.963139 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:44:35.280935 | instance | ok: Runtime: 0:00:00.010803
2026-08-22 18:44:35.288040 | 
2026-08-22 18:44:35.288128 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 18:44:35.776723 | instance | changed:
2026-08-22 18:44:35.776896 | instance | cd+++++++++ objects/
2026-08-22 18:44:35.776935 | instance | cd+++++++++ objects/cluster/
2026-08-22 18:44:35.777002 | instance | cd+++++++++ objects/namespaced/
2026-08-22 18:44:35.788873 | 
2026-08-22 18:44:35.788933 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 18:44:36.003765 | instance | changed
2026-08-22 18:44:36.010801 | 
2026-08-22 18:44:36.010888 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 18:44:36.210293 | instance | changed
2026-08-22 18:44:36.215398 | 
2026-08-22 18:44:36.215462 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 18:44:36.416742 | instance | environment: line 3: kubectl: command not found
2026-08-22 18:44:36.750356 | instance | ok: Runtime: 0:00:00.009025
2026-08-22 18:44:36.755142 | 
2026-08-22 18:44:36.755205 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 18:44:37.242925 | instance | changed:
2026-08-22 18:44:37.243165 | instance | cd+++++++++ pod-logs/
2026-08-22 18:44:37.243242 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-22 18:44:37.253676 | 
2026-08-22 18:44:37.253738 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-22 18:44:37.456214 | instance | changed
2026-08-22 18:44:37.462773 | 
2026-08-22 18:44:37.462864 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-22 18:44:37.673321 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 18:44:37.997880 | instance | ok: Runtime: 0:00:00.036939
2026-08-22 18:44:38.003197 | 
2026-08-22 18:44:38.003263 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-22 18:44:38.206041 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 18:44:38.236774 | instance | ceph-mgr endpoints:
2026-08-22 18:44:38.537452 | instance | ok: Runtime: 0:00:00.036051
2026-08-22 18:44:38.544626 | 
2026-08-22 18:44:38.544716 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-22 18:44:38.750052 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-22 18:44:39.077470 | instance | ok: Runtime: 0:00:00.036049
2026-08-22 18:44:39.084831 | 
2026-08-22 18:44:39.084918 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-22 18:44:39.558462 | instance | changed: cd+++++++++ prometheus/
2026-08-22 18:44:39.570597 | 
2026-08-22 18:44:39.570659 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-22 18:44:39.766624 | instance | changed
2026-08-22 18:44:39.772520 | 
2026-08-22 18:44:39.772585 | TASK [gather-selenium-data : Get selenium data]
2026-08-22 18:44:40.002811 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-22 18:44:40.003520 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-22 18:44:40.307514 | instance | ERROR
2026-08-22 18:44:40.308039 | instance | {
2026-08-22 18:44:40.308136 | instance |   "delta": "0:00:00.004061",
2026-08-22 18:44:40.308188 | instance |   "end": "2026-08-22 18:44:40.003780",
2026-08-22 18:44:40.308235 | instance |   "msg": "non-zero return code",
2026-08-22 18:44:40.308277 | instance |   "rc": 1,
2026-08-22 18:44:40.308315 | instance |   "start": "2026-08-22 18:44:39.999719"
2026-08-22 18:44:40.308354 | instance | }
2026-08-22 18:44:40.308406 | instance | ERROR: Ignoring Errors
2026-08-22 18:44:40.313644 | 
2026-08-22 18:44:40.313709 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-22 18:44:40.804583 | instance | changed: cd+++++++++ selenium/
2026-08-22 18:44:40.810826 | 
2026-08-22 18:44:40.810877 | PLAY RECAP
2026-08-22 18:44:40.810926 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-22 18:44:40.810947 | 
2026-08-22 18:44:40.921122 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 18:44:40.926279 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 18:44:41.514474 | 
2026-08-22 18:44:41.514580 | PLAY [all]
2026-08-22 18:44:41.526384 | 
2026-08-22 18:44:41.526465 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 18:44:41.570077 | instance | skipping: Conditional result was False
2026-08-22 18:44:41.580432 | 
2026-08-22 18:44:41.580508 | TASK [fetch-output : Set log path for single node]
2026-08-22 18:44:41.623513 | instance | ok
2026-08-22 18:44:41.629863 | 
2026-08-22 18:44:41.629949 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 18:44:42.008221 | instance -> localhost | ok: "/var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/logs"
2026-08-22 18:44:42.207599 | instance -> localhost | changed: "/var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/artifacts"
2026-08-22 18:44:42.416873 | instance -> localhost | changed: "/var/lib/zuul/builds/af42aab273444341890122886cdd9a66/work/docs"
2026-08-22 18:44:42.438566 | 
2026-08-22 18:44:42.438686 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 18:44:43.059450 | instance | changed: .d..t...... ./
2026-08-22 18:44:43.059632 | instance | changed: All items complete
2026-08-22 18:44:43.059668 | 
2026-08-22 18:44:43.503542 | instance | changed: .d..t...... ./
2026-08-22 18:44:43.954688 | instance | changed: .d..t...... ./
2026-08-22 18:44:43.980514 | 
2026-08-22 18:44:43.980666 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 18:44:44.382008 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006437
2026-08-22 18:44:44.605995 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006191
2026-08-22 18:44:44.616273 | 
2026-08-22 18:44:44.616578 | PLAY [all]
2026-08-22 18:44:44.623555 | 
2026-08-22 18:44:44.623617 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 18:44:45.021526 | instance | changed
2026-08-22 18:44:45.028548 | 
2026-08-22 18:44:45.028600 | PLAY RECAP
2026-08-22 18:44:45.028644 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 18:44:45.028666 | 
2026-08-22 18:44:45.141791 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 18:44:45.146296 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 18:44:45.835552 | 
2026-08-22 18:44:45.835698 | PLAY [localhost]
2026-08-22 18:44:45.845643 | 
2026-08-22 18:44:45.845737 | TASK [Generate Zuul manifest]
2026-08-22 18:44:45.865203 | localhost | ok
2026-08-22 18:44:46.068697 | 
2026-08-22 18:44:46.068822 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 18:44:47.311655 | localhost | changed
2026-08-22 18:44:47.327187 | 
2026-08-22 18:44:47.327325 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 18:44:47.444702 | localhost | ok
2026-08-22 18:44:47.452528 | 
2026-08-22 18:44:47.452629 | TASK [Upload logs]
2026-08-22 18:44:47.478938 | localhost | ok
2026-08-22 18:44:47.865031 | 
2026-08-22 18:44:47.865225 | TASK [Set zuul-log-path fact]
2026-08-22 18:44:47.889719 | localhost | ok
2026-08-22 18:44:47.998612 | 
2026-08-22 18:44:47.998830 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 18:44:48.030519 | localhost | ok
2026-08-22 18:44:48.040481 | 
2026-08-22 18:44:48.040578 | TASK [upload-logs : Create log directories]
2026-08-22 18:44:48.415072 | localhost | changed
2026-08-22 18:44:48.420673 | 
2026-08-22 18:44:48.420748 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 18:44:48.824473 | localhost -> localhost | ok: Runtime: 0:00:00.009812
2026-08-22 18:44:48.830075 | 
2026-08-22 18:44:48.830147 | TASK [upload-logs : Upload logs to log server]
2026-08-22 18:44:49.663974 | localhost | Output suppressed because no_log was given
2026-08-22 18:44:49.698461 | 
2026-08-22 18:44:49.698587 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 18:44:49.743439 | localhost | skipping: Conditional result was False
2026-08-22 18:44:49.752147 | localhost | skipping: Conditional result was False
2026-08-22 18:44:49.762876 | 
2026-08-22 18:44:49.763025 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 18:44:49.804476 | localhost | skipping: Conditional result was False
2026-08-22 18:44:49.804873 | 
2026-08-22 18:44:49.809618 | localhost | skipping: Conditional result was False
2026-08-22 18:44:49.825931 | 
2026-08-22 18:44:49.826070 | LOOP [upload-logs : Upload console log and json output]