2026-09-11 17:18:14.337089 | Job console starting
2026-09-11 17:18:14.347547 | Updating git repos
2026-09-11 17:18:22.904280 | Cloning repos into workspace
2026-09-11 17:18:39.432219 | Restoring repo states
2026-09-11 17:18:57.334874 | Merging changes
2026-09-11 17:18:59.084030 | Checking out repos
2026-09-11 17:19:01.027136 | Preparing playbooks
2026-09-11 17:19:03.417671 | Running Ansible setup
2026-09-11 17:19:06.951032 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:19:07.502326 | 
2026-09-11 17:19:07.502430 | PLAY [localhost]
2026-09-11 17:19:07.508926 | 
2026-09-11 17:19:07.508987 | TASK [Gathering Facts]
2026-09-11 17:19:08.351584 | localhost | ok
2026-09-11 17:19:08.361273 | 
2026-09-11 17:19:08.361432 | TASK [Setup log path fact]
2026-09-11 17:19:08.379536 | localhost | ok
2026-09-11 17:19:08.400475 | 
2026-09-11 17:19:08.400703 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:19:08.440991 | localhost | ok
2026-09-11 17:19:08.448259 | 
2026-09-11 17:19:08.448376 | TASK [emit-job-header : Print job information]
2026-09-11 17:19:08.488028 | # Job Information
2026-09-11 17:19:08.488168 | Ansible Version: 2.16.18
2026-09-11 17:19:08.488203 | Job: atmosphere-molecule-csi-rbd
2026-09-11 17:19:08.488227 | Pipeline: check
2026-09-11 17:19:08.488248 | Executor: 2d72f0692154
2026-09-11 17:19:08.488269 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090
2026-09-11 17:19:08.488295 | Event ID: 3f57b1d0-ae04-11f1-8047-b9bc690674be
2026-09-11 17:19:08.491616 | 
2026-09-11 17:19:08.491686 | LOOP [emit-job-header : Print node information]
2026-09-11 17:19:08.575175 | localhost | ok:
2026-09-11 17:19:08.575421 | localhost | # Node Information
2026-09-11 17:19:08.575476 | localhost | Inventory Hostname: instance
2026-09-11 17:19:08.575517 | localhost | Hostname: np0000192597
2026-09-11 17:19:08.575555 | localhost | Username: zuul
2026-09-11 17:19:08.575597 | localhost | Distro: Ubuntu 22.04
2026-09-11 17:19:08.575635 | localhost | Provider: yul1
2026-09-11 17:19:08.575670 | localhost | Region: ca-ymq-1
2026-09-11 17:19:08.575705 | localhost | Label: ubuntu-jammy
2026-09-11 17:19:08.575740 | localhost | Product Name: OpenStack Nova
2026-09-11 17:19:08.575794 | localhost | Interface IP: 162.253.55.113
2026-09-11 17:19:08.581658 | 
2026-09-11 17:19:08.581752 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-11 17:19:09.000284 | localhost -> localhost | changed
2026-09-11 17:19:09.010785 | 
2026-09-11 17:19:09.010978 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-11 17:19:09.839384 | localhost -> localhost | changed
2026-09-11 17:19:09.855865 | 
2026-09-11 17:19:09.855975 | PLAY [all]
2026-09-11 17:19:09.871082 | 
2026-09-11 17:19:09.871216 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-11 17:19:10.089282 | instance -> localhost | ok
2026-09-11 17:19:10.100037 | 
2026-09-11 17:19:10.100164 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-11 17:19:10.133114 | instance | ok
2026-09-11 17:19:10.158921 | instance | included: /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-11 17:19:10.165564 | 
2026-09-11 17:19:10.165638 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-11 17:19:11.259492 | instance -> localhost | Generating public/private rsa key pair.
2026-09-11 17:19:11.259775 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/8aea3ed5cd274f7784702c12a618cd2d_id_rsa
2026-09-11 17:19:11.259820 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/8aea3ed5cd274f7784702c12a618cd2d_id_rsa.pub
2026-09-11 17:19:11.259853 | instance -> localhost | The key fingerprint is:
2026-09-11 17:19:11.259884 | instance -> localhost | SHA256:DYeOIiLVY3Sha9rSTCG7DwDSpQYLS/fLPQa+ljcxMfI zuul-build-sshkey
2026-09-11 17:19:11.259938 | instance -> localhost | The key's randomart image is:
2026-09-11 17:19:11.259971 | instance -> localhost | +---[RSA 3072]----+
2026-09-11 17:19:11.260015 | instance -> localhost | |o. .o o.         |
2026-09-11 17:19:11.260047 | instance -> localhost | |o=.=.o   .       |
2026-09-11 17:19:11.260074 | instance -> localhost | |= * *+ oo .      |
2026-09-11 17:19:11.260101 | instance -> localhost | |oo +o+*oo+       |
2026-09-11 17:19:11.260127 | instance -> localhost | |+ o =+.ES .      |
2026-09-11 17:19:11.260153 | instance -> localhost | |.o X .+ +        |
2026-09-11 17:19:11.260179 | instance -> localhost | |  = ++ o         |
2026-09-11 17:19:11.260204 | instance -> localhost | |   +. . .        |
2026-09-11 17:19:11.260232 | instance -> localhost | |    .            |
2026-09-11 17:19:11.260259 | instance -> localhost | +----[SHA256]-----+
2026-09-11 17:19:11.260328 | instance -> localhost | ok: Runtime: 0:00:00.689412
2026-09-11 17:19:11.269432 | 
2026-09-11 17:19:11.269595 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-11 17:19:11.302557 | instance | ok
2026-09-11 17:19:11.315668 | instance | included: /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-11 17:19:11.323064 | 
2026-09-11 17:19:11.323198 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-11 17:19:11.347591 | instance | skipping: Conditional result was False
2026-09-11 17:19:11.355666 | 
2026-09-11 17:19:11.355823 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-11 17:19:11.778294 | instance | changed
2026-09-11 17:19:11.788024 | 
2026-09-11 17:19:11.788182 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-11 17:19:12.007953 | instance | ok
2026-09-11 17:19:12.019222 | 
2026-09-11 17:19:12.019483 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-11 17:19:12.552911 | instance | changed
2026-09-11 17:19:12.559586 | 
2026-09-11 17:19:12.559689 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-11 17:19:13.064403 | instance | changed
2026-09-11 17:19:13.071115 | 
2026-09-11 17:19:13.071194 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-11 17:19:13.096302 | instance | skipping: Conditional result was False
2026-09-11 17:19:13.101109 | 
2026-09-11 17:19:13.101168 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-11 17:19:13.480648 | instance -> localhost | changed
2026-09-11 17:19:13.499805 | 
2026-09-11 17:19:13.499928 | TASK [add-build-sshkey : Add back temp key]
2026-09-11 17:19:13.802875 | instance -> localhost | Identity added: /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/8aea3ed5cd274f7784702c12a618cd2d_id_rsa (zuul-build-sshkey)
2026-09-11 17:19:13.803099 | instance -> localhost | ok: Runtime: 0:00:00.014797
2026-09-11 17:19:13.807674 | 
2026-09-11 17:19:13.807787 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-11 17:19:14.171285 | instance | ok
2026-09-11 17:19:14.184169 | 
2026-09-11 17:19:14.184349 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-11 17:19:14.220522 | instance | skipping: Conditional result was False
2026-09-11 17:19:14.249687 | 
2026-09-11 17:19:14.249869 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-11 17:19:14.690691 | instance | ok
2026-09-11 17:19:14.701904 | 
2026-09-11 17:19:14.702070 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-11 17:19:18.390099 | instance | Output suppressed because no_log was given
2026-09-11 17:19:18.401110 | 
2026-09-11 17:19:18.401202 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-11 17:19:18.627127 | instance | ok: "logs"
2026-09-11 17:19:18.627537 | instance | ok: All items complete
2026-09-11 17:19:18.627693 | 
2026-09-11 17:19:18.786894 | instance | ok: "artifacts"
2026-09-11 17:19:18.943866 | instance | ok: "docs"
2026-09-11 17:19:18.952747 | 
2026-09-11 17:19:18.952892 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-11 17:19:19.140649 | instance | changed: "logs"
2026-09-11 17:19:19.309664 | instance | changed: "artifacts"
2026-09-11 17:19:19.473986 | instance | changed: "docs"
2026-09-11 17:19:19.488171 | 
2026-09-11 17:19:19.488318 | PLAY RECAP
2026-09-11 17:19:19.488407 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-11 17:19:19.488685 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:19:19.488727 | 
2026-09-11 17:19:19.609063 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-11 17:19:19.612551 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:19:20.265569 | 
2026-09-11 17:19:20.265795 | PLAY [all]
2026-09-11 17:19:20.276985 | 
2026-09-11 17:19:20.277102 | TASK [setup-uv : Extract archive]
2026-09-11 17:19:22.646230 | instance | changed
2026-09-11 17:19:22.656750 | 
2026-09-11 17:19:22.656935 | TASK [setup-uv : Print version]
2026-09-11 17:19:23.046969 | instance | uv 0.8.13
2026-09-11 17:19:23.198752 | instance | ok: Runtime: 0:00:00.012986
2026-09-11 17:19:23.236470 | 
2026-09-11 17:19:23.265936 | TASK [Install Ansible collection siblings]
2026-09-11 17:19:36.604390 | instance | changed:
2026-09-11 17:19:36.604639 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-11 17:19:36.604695 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-11 17:19:36.604738 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-11 17:19:36.604789 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-11 17:19:36.604824 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-11 17:19:36.604862 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-11 17:19:36.604894 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-11 17:19:36.604931 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-11 17:19:36.604969 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-11 17:19:36.605009 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-11 17:19:36.605049 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-11 17:19:36.605090 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-11 17:19:36.605131 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-11 17:19:36.605170 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-11 17:19:36.605206 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-11 17:19:36.605237 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-11 17:19:36.605263 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-11 17:19:36.605286 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-11 17:19:36.605312 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-11 17:19:36.605345 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-11 17:19:36.605376 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-11 17:19:36.605404 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-11 17:19:36.605435 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:19:36.605469 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-11 17:19:36.605492 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-11 17:19:36.605514 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:19:36.605535 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:19:36.605557 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-11 17:19:36.605586 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-11 17:19:36.605619 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-11 17:19:36.605648 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-11 17:19:36.605680 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-11 17:19:36.605712 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-11 17:19:36.605742 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-11 17:19:36.605802 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.605835 | instance | Process install dependency map
2026-09-11 17:19:36.605859 | instance | Starting collection install process
2026-09-11 17:19:36.605880 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-11 17:19:36.605909 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-11 17:19:36.605941 | instance | ansible.netcommon:* was installed successfully
2026-09-11 17:19:36.605970 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-11 17:19:36.605998 | instance | Creating virtual environment at: .venv
2026-09-11 17:19:36.606027 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:19:36.606055 | instance | Downloading rjsonnet (1.2MiB)
2026-09-11 17:19:36.606083 | instance | Downloading kubernetes (1.9MiB)
2026-09-11 17:19:36.606112 | instance | Downloading pygments (1.2MiB)
2026-09-11 17:19:36.606139 | instance | Downloading openstacksdk (1.7MiB)
2026-09-11 17:19:36.606166 | instance | Downloading setuptools (1.1MiB)
2026-09-11 17:19:36.606193 | instance | Downloading cryptography (4.2MiB)
2026-09-11 17:19:36.606220 | instance | Downloading netaddr (2.2MiB)
2026-09-11 17:19:36.606247 | instance | Downloading ansible-core (2.1MiB)
2026-09-11 17:19:36.606274 | instance |    Building pyperclip==1.9.0
2026-09-11 17:19:36.606301 | instance |  Downloading rjsonnet
2026-09-11 17:19:36.606330 | instance |  Downloading netaddr
2026-09-11 17:19:36.606358 | instance |  Downloading pygments
2026-09-11 17:19:36.606384 | instance |  Downloading cryptography
2026-09-11 17:19:36.606411 | instance |  Downloading setuptools
2026-09-11 17:19:36.606438 | instance |  Downloading kubernetes
2026-09-11 17:19:36.606465 | instance |  Downloading ansible-core
2026-09-11 17:19:36.606491 | instance |  Downloading openstacksdk
2026-09-11 17:19:36.606519 | instance |       Built pyperclip==1.9.0
2026-09-11 17:19:36.606546 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-11 17:19:36.606574 | instance | Installed 79 packages in 49ms
2026-09-11 17:19:36.606606 | instance | Checked out ansible.posix to 1.6.0
2026-09-11 17:19:36.606635 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-11 17:19:36.606663 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.606690 | instance | Process install dependency map
2026-09-11 17:19:36.606718 | instance | Starting collection install process
2026-09-11 17:19:36.606744 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-11 17:19:36.606800 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-11 17:19:36.606832 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-11 17:19:36.606860 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.606887 | instance | 2.17.12
2026-09-11 17:19:36.606915 | instance | Checked out ansible.utils to v6.1.0
2026-09-11 17:19:36.606943 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-11 17:19:36.606971 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.606998 | instance | Process install dependency map
2026-09-11 17:19:36.607026 | instance | Starting collection install process
2026-09-11 17:19:36.607053 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-11 17:19:36.607080 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-11 17:19:36.607107 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-11 17:19:36.607134 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.607161 | instance | 2.17.12
2026-09-11 17:19:36.607188 | instance | Checked out atmosphere.common to v0.7.0
2026-09-11 17:19:36.607215 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-11 17:19:36.607242 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.607269 | instance | Process install dependency map
2026-09-11 17:19:36.607297 | instance | Starting collection install process
2026-09-11 17:19:36.607324 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-11 17:19:36.607352 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-11 17:19:36.607379 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-11 17:19:36.607405 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.607434 | instance | 2.17.12
2026-09-11 17:19:36.607464 | instance | Checked out community.crypto to 2.2.3
2026-09-11 17:19:36.607492 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-11 17:19:36.607520 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.607546 | instance | Process install dependency map
2026-09-11 17:19:36.607567 | instance | Starting collection install process
2026-09-11 17:19:36.607588 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-11 17:19:36.607609 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-11 17:19:36.607629 | instance | community.crypto:2.2.3 was installed successfully
2026-09-11 17:19:36.607650 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.607670 | instance | 2.17.12
2026-09-11 17:19:36.607691 | instance | Checked out community.general to 7.3.0
2026-09-11 17:19:36.607711 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-11 17:19:36.607732 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.607759 | instance | Process install dependency map
2026-09-11 17:19:36.607802 | instance | Starting collection install process
2026-09-11 17:19:36.607824 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-11 17:19:36.607846 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-11 17:19:36.607867 | instance | community.general:7.3.0 was installed successfully
2026-09-11 17:19:36.607888 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.607908 | instance | 2.17.12
2026-09-11 17:19:36.607929 | instance | Checked out community.mysql to 3.6.0
2026-09-11 17:19:36.607951 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-11 17:19:36.607972 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.607995 | instance | Process install dependency map
2026-09-11 17:19:36.608016 | instance | Starting collection install process
2026-09-11 17:19:36.608038 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-11 17:19:36.608059 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-11 17:19:36.608080 | instance | community.mysql:3.6.0 was installed successfully
2026-09-11 17:19:36.608100 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.608122 | instance | 2.17.12
2026-09-11 17:19:36.608143 | instance | Checked out kubernetes.core to 2.4.0
2026-09-11 17:19:36.608164 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-11 17:19:36.608185 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.608206 | instance | Process install dependency map
2026-09-11 17:19:36.608227 | instance | Starting collection install process
2026-09-11 17:19:36.608247 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-11 17:19:36.608268 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-11 17:19:36.608289 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-11 17:19:36.608310 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.608330 | instance | 2.17.12
2026-09-11 17:19:36.608351 | instance | Checked out openstack.cloud to 2.6.0
2026-09-11 17:19:36.608371 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-11 17:19:36.608392 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.608412 | instance | Process install dependency map
2026-09-11 17:19:36.608432 | instance | Starting collection install process
2026-09-11 17:19:36.608452 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-11 17:19:36.608471 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-11 17:19:36.608582 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-11 17:19:36.608625 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.608649 | instance | 2.17.12
2026-09-11 17:19:36.608671 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-11 17:19:36.608692 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-11 17:19:36.608721 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.608745 | instance | Process install dependency map
2026-09-11 17:19:36.608808 | instance | Starting collection install process
2026-09-11 17:19:36.608863 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-11 17:19:36.608889 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-11 17:19:36.608911 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-11 17:19:36.608933 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.608954 | instance | 2.17.12
2026-09-11 17:19:36.608974 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-11 17:19:36.608995 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-11 17:19:36.609016 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.609036 | instance | Process install dependency map
2026-09-11 17:19:36.609056 | instance | Starting collection install process
2026-09-11 17:19:36.609077 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-11 17:19:36.609097 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-11 17:19:36.609117 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-11 17:19:36.609137 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.609157 | instance | 2.17.12
2026-09-11 17:19:36.609178 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-11 17:19:36.609198 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-11 17:19:36.609219 | instance | Starting galaxy collection install process
2026-09-11 17:19:36.609239 | instance | Process install dependency map
2026-09-11 17:19:36.609259 | instance | Starting collection install process
2026-09-11 17:19:36.609279 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-11 17:19:36.609300 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-11 17:19:36.609320 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-11 17:19:36.609341 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-11 17:19:36.609362 | instance | 2.17.12
2026-09-11 17:19:36.615721 | 
2026-09-11 17:19:36.615807 | PLAY RECAP
2026-09-11 17:19:36.615863 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:19:36.615888 | 
2026-09-11 17:19:36.723180 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-11 17:19:36.847667 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:19:37.383507 | 
2026-09-11 17:19:37.383608 | PLAY [all]
2026-09-11 17:19:37.393037 | 
2026-09-11 17:19:37.393104 | TASK [Install "jq" for log collection]
2026-09-11 17:19:47.019702 | instance | changed
2026-09-11 17:19:47.024015 | 
2026-09-11 17:19:47.024133 | PLAY RECAP
2026-09-11 17:19:47.024228 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:19:47.024478 | 
2026-09-11 17:19:47.191885 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-11 17:19:47.427482 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:19:48.025650 | 
2026-09-11 17:19:48.224705 | PLAY [all]
2026-09-11 17:19:48.247813 | 
2026-09-11 17:19:48.248054 | LOOP [Check inventory directories]
2026-09-11 17:19:48.621598 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-11 17:19:48.782854 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-11 17:19:48.933521 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-11 17:19:48.946027 | 
2026-09-11 17:19:48.946255 | LOOP [Copy inventory file for Zuul]
2026-09-11 17:19:49.805505 | instance | changed:
2026-09-11 17:19:49.805928 | instance | {
2026-09-11 17:19:49.806035 | instance |   "ansible_loop_var": "item",
2026-09-11 17:19:49.806115 | instance |   "changed": false,
2026-09-11 17:19:49.806169 | instance |   "failed": false,
2026-09-11 17:19:49.806226 | instance |   "invocation": {
2026-09-11 17:19:49.806273 | instance |     "module_args": {
2026-09-11 17:19:49.806318 | instance |       "checksum_algorithm": "sha1",
2026-09-11 17:19:49.806382 | instance |       "follow": true,
2026-09-11 17:19:49.806438 | instance |       "get_attributes": true,
2026-09-11 17:19:49.806486 | instance |       "get_checksum": true,
2026-09-11 17:19:49.806531 | instance |       "get_mime": true,
2026-09-11 17:19:49.806573 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-11 17:19:49.806614 | instance |     }
2026-09-11 17:19:49.806856 | instance |   },
2026-09-11 17:19:49.806927 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:19:49.806973 | instance |   "stat": {
2026-09-11 17:19:49.807014 | instance |     "atime": 1789147169.327323,
2026-09-11 17:19:49.807058 | instance |     "attr_flags": "e",
2026-09-11 17:19:49.807100 | instance |     "attributes": [
2026-09-11 17:19:49.807140 | instance |       "extents"
2026-09-11 17:19:49.807182 | instance |     ],
2026-09-11 17:19:49.807224 | instance |     "block_size": 4096,
2026-09-11 17:19:49.807267 | instance |     "blocks": 8,
2026-09-11 17:19:49.807310 | instance |     "charset": "unknown",
2026-09-11 17:19:49.807449 | instance |     "ctime": 1789147165.242953,
2026-09-11 17:19:49.807573 | instance |     "dev": 64513,
2026-09-11 17:19:49.807621 | instance |     "device_type": 0,
2026-09-11 17:19:49.807657 | instance |     "executable": true,
2026-09-11 17:19:49.807691 | instance |     "exists": true,
2026-09-11 17:19:49.807724 | instance |     "gid": 1000,
2026-09-11 17:19:49.807757 | instance |     "gr_name": "zuul",
2026-09-11 17:19:49.807827 | instance |     "inode": 1048290,
2026-09-11 17:19:49.807865 | instance |     "isblk": false,
2026-09-11 17:19:49.807902 | instance |     "ischr": false,
2026-09-11 17:19:49.807936 | instance |     "isdir": true,
2026-09-11 17:19:49.807972 | instance |     "isfifo": false,
2026-09-11 17:19:49.808005 | instance |     "isgid": false,
2026-09-11 17:19:49.808037 | instance |     "islnk": false,
2026-09-11 17:19:49.808070 | instance |     "isreg": false,
2026-09-11 17:19:49.808101 | instance |     "issock": false,
2026-09-11 17:19:49.808134 | instance |     "isuid": false,
2026-09-11 17:19:49.808167 | instance |     "mimetype": "unknown",
2026-09-11 17:19:49.808201 | instance |     "mode": "0755",
2026-09-11 17:19:49.808233 | instance |     "mtime": 1789147165.242953,
2026-09-11 17:19:49.808265 | instance |     "nlink": 21,
2026-09-11 17:19:49.808297 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-11 17:19:49.808336 | instance |     "pw_name": "zuul",
2026-09-11 17:19:49.808393 | instance |     "readable": true,
2026-09-11 17:19:49.808431 | instance |     "rgrp": true,
2026-09-11 17:19:49.808467 | instance |     "roth": true,
2026-09-11 17:19:49.808534 | instance |     "rusr": true,
2026-09-11 17:19:49.808571 | instance |     "size": 4096,
2026-09-11 17:19:49.808604 | instance |     "uid": 1000,
2026-09-11 17:19:49.808656 | instance |     "version": "4243043587",
2026-09-11 17:19:49.808693 | instance |     "wgrp": false,
2026-09-11 17:19:49.808731 | instance |     "woth": false,
2026-09-11 17:19:49.808787 | instance |     "writeable": true,
2026-09-11 17:19:49.808825 | instance |     "wusr": true,
2026-09-11 17:19:49.808858 | instance |     "xgrp": true,
2026-09-11 17:19:49.808893 | instance |     "xoth": true,
2026-09-11 17:19:49.808927 | instance |     "xusr": true
2026-09-11 17:19:49.808960 | instance |   }
2026-09-11 17:19:49.808993 | instance | }
2026-09-11 17:19:49.809056 | instance | ok: All items complete
2026-09-11 17:19:49.809097 | 
2026-09-11 17:19:49.811461 | instance | skipping: Conditional result was False
2026-09-11 17:19:49.812688 | instance | skipping: Conditional result was False
2026-09-11 17:19:49.826540 | 
2026-09-11 17:19:49.826685 | LOOP [Switch "ansible_host" to private IP]
2026-09-11 17:19:50.207257 | instance | changed: 1 replacements made
2026-09-11 17:19:50.212283 | instance | skipping: Conditional result was False
2026-09-11 17:19:50.220037 | instance | skipping: Conditional result was False
2026-09-11 17:19:50.241444 | 
2026-09-11 17:19:50.241633 | TASK [Run Molecule scenario]
2026-09-11 17:19:51.333632 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-11 17:19:51.762624 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-11 17:19:51.762725 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-11 17:20:03.015421 | instance | INFO     [csi > dependency] Executing
2026-09-11 17:20:03.015832 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-11 17:20:03.016321 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-11 17:20:03.016548 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-11 17:20:03.030357 | instance | INFO     [csi > cleanup] Executing
2026-09-11 17:20:03.030831 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:20:03.041701 | instance | INFO     [csi > destroy] Executing
2026-09-11 17:20:03.041830 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-11 17:20:03.041950 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-11 17:20:03.054697 | instance | INFO     [csi > syntax] Executing
2026-09-11 17:20:04.684620 | instance |
2026-09-11 17:20:04.684798 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:20:04.773310 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-11 17:20:04.783430 | instance | INFO     [csi > create] Executing
2026-09-11 17:20:04.785406 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-11 17:20:04.793785 | instance | INFO     [csi > prepare] Executing
2026-09-11 17:20:05.573721 | instance |
2026-09-11 17:20:05.573909 | instance | PLAY [Prepare] *****************************************************************
2026-09-11 17:20:05.574076 | instance |
2026-09-11 17:20:05.574237 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:05.574412 | instance | Friday 11 September 2026  17:20:05 +0000 (0:00:00.025)       0:00:00.025 ******
2026-09-11 17:20:06.845917 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:20:06.846156 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:20:06.846399 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:20:06.846633 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:20:06.846893 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:20:06.857577 | instance | ok: [instance]
2026-09-11 17:20:06.857931 | instance |
2026-09-11 17:20:06.858290 | instance | TASK [Configure short hostname] ************************************************
2026-09-11 17:20:06.858593 | instance | Friday 11 September 2026  17:20:06 +0000 (0:00:01.284)       0:00:01.309 ******
2026-09-11 17:20:07.614509 | instance | changed: [instance]
2026-09-11 17:20:07.614902 | instance |
2026-09-11 17:20:07.615327 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-11 17:20:07.615607 | instance | Friday 11 September 2026  17:20:07 +0000 (0:00:00.756)       0:00:02.066 ******
2026-09-11 17:20:07.914730 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-11 17:20:07.914998 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-11 17:20:07.915297 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-11 17:20:07.924765 | instance | changed: [instance]
2026-09-11 17:20:07.924989 | instance |
2026-09-11 17:20:07.925287 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-11 17:20:07.925524 | instance | Friday 11 September 2026  17:20:07 +0000 (0:00:00.311)       0:00:02.377 ******
2026-09-11 17:20:08.816473 | instance | ok: [instance]
2026-09-11 17:20:08.816616 | instance |
2026-09-11 17:20:08.816904 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-11 17:20:08.817156 | instance |
2026-09-11 17:20:08.817409 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:08.817713 | instance | Friday 11 September 2026  17:20:08 +0000 (0:00:00.891)       0:00:03.269 ******
2026-09-11 17:20:09.553746 | instance | ok: [instance]
2026-09-11 17:20:09.554000 | instance |
2026-09-11 17:20:09.554202 | instance | TASK [Install depedencies] *****************************************************
2026-09-11 17:20:09.554433 | instance | Friday 11 September 2026  17:20:09 +0000 (0:00:00.736)       0:00:04.005 ******
2026-09-11 17:20:33.939795 | instance | changed: [instance]
2026-09-11 17:20:33.939986 | instance |
2026-09-11 17:20:33.940315 | instance | TASK [Start up service] ********************************************************
2026-09-11 17:20:33.940565 | instance | Friday 11 September 2026  17:20:33 +0000 (0:00:24.385)       0:00:28.390 ******
2026-09-11 17:20:34.547039 | instance | ok: [instance]
2026-09-11 17:20:34.547289 | instance |
2026-09-11 17:20:34.547759 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-11 17:20:34.548049 | instance | Friday 11 September 2026  17:20:34 +0000 (0:00:00.608)       0:00:28.998 ******
2026-09-11 17:20:34.891808 | instance | ok: [instance]
2026-09-11 17:20:34.892045 | instance |
2026-09-11 17:20:34.892530 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-11 17:20:34.892877 | instance | Friday 11 September 2026  17:20:34 +0000 (0:00:00.344)       0:00:29.343 ******
2026-09-11 17:20:35.624933 | instance | changed: [instance]
2026-09-11 17:20:35.625085 | instance |
2026-09-11 17:20:35.625323 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-11 17:20:35.625513 | instance | Friday 11 September 2026  17:20:35 +0000 (0:00:00.733)       0:00:30.077 ******
2026-09-11 17:20:35.850071 | instance | ok: [instance]
2026-09-11 17:20:35.850440 | instance |
2026-09-11 17:20:35.850844 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-11 17:20:35.851251 | instance | Friday 11 September 2026  17:20:35 +0000 (0:00:00.224)       0:00:30.301 ******
2026-09-11 17:20:35.872862 | instance | skipping: [instance]
2026-09-11 17:20:35.873104 | instance |
2026-09-11 17:20:35.873418 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-11 17:20:35.873731 | instance | Friday 11 September 2026  17:20:35 +0000 (0:00:00.023)       0:00:30.325 ******
2026-09-11 17:20:36.439346 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:20:36.439409 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:20:36.439552 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:20:36.439656 | instance |
2026-09-11 17:20:36.439777 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-11 17:20:36.439937 | instance | Friday 11 September 2026  17:20:36 +0000 (0:00:00.566)       0:00:30.891 ******
2026-09-11 17:20:37.110383 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:20:37.110430 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:20:37.110436 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:20:37.110440 | instance |
2026-09-11 17:20:37.110445 | instance | TASK [Start loop devices] ******************************************************
2026-09-11 17:20:37.110450 | instance | Friday 11 September 2026  17:20:37 +0000 (0:00:00.670)       0:00:31.562 ******
2026-09-11 17:20:37.853067 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:20:37.853110 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:20:37.853115 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:20:37.853119 | instance |
2026-09-11 17:20:37.853124 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-11 17:20:37.853258 | instance | Friday 11 September 2026  17:20:37 +0000 (0:00:00.742)       0:00:32.304 ******
2026-09-11 17:20:41.103803 | instance | changed: [instance] => (item=osd0)
2026-09-11 17:20:41.105091 | instance | changed: [instance] => (item=osd1)
2026-09-11 17:20:41.105165 | instance | changed: [instance] => (item=osd2)
2026-09-11 17:20:41.105177 | instance |
2026-09-11 17:20:41.105187 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-11 17:20:41.105197 | instance | Friday 11 September 2026  17:20:41 +0000 (0:00:03.251)       0:00:35.555 ******
2026-09-11 17:20:43.122431 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-11 17:20:43.122853 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-11 17:20:43.126894 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-11 17:20:43.126972 | instance |
2026-09-11 17:20:43.126983 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:20:43.126995 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-11 17:20:43.127004 | instance |
2026-09-11 17:20:43.127013 | instance | Friday 11 September 2026  17:20:43 +0000 (0:00:02.019)       0:00:37.575 ******
2026-09-11 17:20:43.127022 | instance | ===============================================================================
2026-09-11 17:20:43.127031 | instance | Install depedencies ---------------------------------------------------- 24.39s
2026-09-11 17:20:43.127039 | instance | Create a volume group for each loop device ------------------------------ 3.25s
2026-09-11 17:20:43.127048 | instance | Create a logical volume for each loop device ---------------------------- 2.02s
2026-09-11 17:20:43.127058 | instance | Gathering Facts --------------------------------------------------------- 1.28s
2026-09-11 17:20:43.127067 | instance | Purge "snapd" package --------------------------------------------------- 0.89s
2026-09-11 17:20:43.127076 | instance | Configure short hostname ------------------------------------------------ 0.76s
2026-09-11 17:20:43.127084 | instance | Start loop devices ------------------------------------------------------ 0.74s
2026-09-11 17:20:43.127093 | instance | Gathering Facts --------------------------------------------------------- 0.74s
2026-09-11 17:20:43.127101 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s
2026-09-11 17:20:43.127120 | instance | Set permissions on loopback devices ------------------------------------- 0.67s
2026-09-11 17:20:43.127131 | instance | Start up service -------------------------------------------------------- 0.61s
2026-09-11 17:20:43.127390 | instance | Create devices for Ceph ------------------------------------------------- 0.57s
2026-09-11 17:20:43.127811 | instance | Generate lvm.conf ------------------------------------------------------- 0.34s
2026-09-11 17:20:43.128115 | instance | Ensure hostname inside hosts file --------------------------------------- 0.31s
2026-09-11 17:20:43.128407 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-11 17:20:43.128724 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-09-11 17:20:43.237188 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-11 17:20:43.244072 | instance | INFO     [csi > converge] Executing
2026-09-11 17:20:44.763208 | instance |
2026-09-11 17:20:44.763458 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-11 17:20:44.763644 | instance |
2026-09-11 17:20:44.763854 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:44.764033 | instance | Friday 11 September 2026  17:20:44 +0000 (0:00:00.009)       0:00:00.009 ******
2026-09-11 17:20:45.878316 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-11 17:20:45.878712 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-11 17:20:45.879057 | instance | interpreter could change the meaning of that path. See
2026-09-11 17:20:45.879426 | instance | https://docs.ansible.com/ansible-
2026-09-11 17:20:45.879842 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-11 17:20:45.895360 | instance | ok: [instance]
2026-09-11 17:20:45.895831 | instance |
2026-09-11 17:20:45.896270 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-11 17:20:45.896661 | instance | Friday 11 September 2026  17:20:45 +0000 (0:00:01.130)       0:00:01.139 ******
2026-09-11 17:20:45.967670 | instance | ok: [instance] => {
2026-09-11 17:20:45.968053 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-11 17:20:45.968356 | instance | }
2026-09-11 17:20:45.968670 | instance |
2026-09-11 17:20:45.968996 | instance | PLAY [all] *********************************************************************
2026-09-11 17:20:45.969281 | instance |
2026-09-11 17:20:45.969600 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:45.969924 | instance | Friday 11 September 2026  17:20:45 +0000 (0:00:00.073)       0:00:01.213 ******
2026-09-11 17:20:46.931565 | instance | ok: [instance]
2026-09-11 17:20:46.931734 | instance |
2026-09-11 17:20:46.932081 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-11 17:20:46.932385 | instance | Friday 11 September 2026  17:20:46 +0000 (0:00:00.962)       0:00:02.176 ******
2026-09-11 17:20:47.130139 | instance | ok: [instance]
2026-09-11 17:20:47.130348 | instance |
2026-09-11 17:20:47.130522 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-11 17:20:47.130659 | instance |
2026-09-11 17:20:47.130841 | instance | TASK [Gathering Facts] *********************************************************
2026-09-11 17:20:47.130984 | instance | Friday 11 September 2026  17:20:47 +0000 (0:00:00.200)       0:00:02.376 ******
2026-09-11 17:20:48.086170 | instance | ok: [instance]
2026-09-11 17:20:48.086227 | instance |
2026-09-11 17:20:48.086238 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:20:48.086258 | instance | Friday 11 September 2026  17:20:48 +0000 (0:00:00.955)       0:00:03.332 ******
2026-09-11 17:20:48.424268 | instance | ok: [instance]
2026-09-11 17:20:48.424328 | instance |
2026-09-11 17:20:48.424339 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:20:48.424349 | instance | Friday 11 September 2026  17:20:48 +0000 (0:00:00.338)       0:00:03.670 ******
2026-09-11 17:20:48.481964 | instance | skipping: [instance]
2026-09-11 17:20:48.482011 | instance |
2026-09-11 17:20:48.482022 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-11 17:20:48.482031 | instance | Friday 11 September 2026  17:20:48 +0000 (0:00:00.057)       0:00:03.728 ******
2026-09-11 17:20:48.811548 | instance | changed: [instance]
2026-09-11 17:20:48.811603 | instance |
2026-09-11 17:20:48.811614 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:20:48.811623 | instance | Friday 11 September 2026  17:20:48 +0000 (0:00:00.329)       0:00:04.057 ******
2026-09-11 17:20:48.918008 | instance | ok: [instance] => {
2026-09-11 17:20:48.918502 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-11 17:20:48.918968 | instance | }
2026-09-11 17:20:48.919301 | instance |
2026-09-11 17:20:48.919677 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:20:48.920017 | instance | Friday 11 September 2026  17:20:48 +0000 (0:00:00.107)       0:00:04.164 ******
2026-09-11 17:20:49.808935 | instance | changed: [instance]
2026-09-11 17:20:49.809385 | instance |
2026-09-11 17:20:49.809781 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:20:49.810104 | instance | Friday 11 September 2026  17:20:49 +0000 (0:00:00.890)       0:00:05.055 ******
2026-09-11 17:20:49.879636 | instance | skipping: [instance]
2026-09-11 17:20:49.879720 | instance |
2026-09-11 17:20:49.879918 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:20:49.880177 | instance | Friday 11 September 2026  17:20:49 +0000 (0:00:00.070)       0:00:05.126 ******
2026-09-11 17:20:49.959143 | instance | skipping: [instance]
2026-09-11 17:20:49.959485 | instance |
2026-09-11 17:20:49.959749 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:20:49.960004 | instance | Friday 11 September 2026  17:20:49 +0000 (0:00:00.077)       0:00:05.204 ******
2026-09-11 17:20:50.204490 | instance | ok: [instance]
2026-09-11 17:20:50.204557 | instance |
2026-09-11 17:20:50.204566 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-11 17:20:50.204574 | instance | Friday 11 September 2026  17:20:50 +0000 (0:00:00.246)       0:00:05.450 ******
2026-09-11 17:20:51.554735 | instance | ok: [instance]
2026-09-11 17:20:51.554965 | instance |
2026-09-11 17:20:51.554978 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:20:51.554988 | instance | Friday 11 September 2026  17:20:51 +0000 (0:00:01.349)       0:00:06.800 ******
2026-09-11 17:20:51.618855 | instance | ok: [instance] => {
2026-09-11 17:20:51.618912 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-11 17:20:51.619867 | instance | }
2026-09-11 17:20:51.619910 | instance |
2026-09-11 17:20:51.619917 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:20:51.620091 | instance | Friday 11 September 2026  17:20:51 +0000 (0:00:00.065)       0:00:06.866 ******
2026-09-11 17:20:52.279896 | instance | changed: [instance]
2026-09-11 17:20:52.280108 | instance |
2026-09-11 17:20:52.280411 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:20:52.280663 | instance | Friday 11 September 2026  17:20:52 +0000 (0:00:00.660)       0:00:07.526 ******
2026-09-11 17:20:55.212901 | instance | changed: [instance]
2026-09-11 17:20:55.213250 | instance |
2026-09-11 17:20:55.213472 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-11 17:20:55.213680 | instance | Friday 11 September 2026  17:20:55 +0000 (0:00:02.933)       0:00:10.459 ******
2026-09-11 17:20:55.253338 | instance | skipping: [instance]
2026-09-11 17:20:55.253603 | instance |
2026-09-11 17:20:55.254014 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-11 17:20:55.254553 | instance | Friday 11 September 2026  17:20:55 +0000 (0:00:00.040)       0:00:10.500 ******
2026-09-11 17:20:55.299784 | instance | skipping: [instance]
2026-09-11 17:20:55.300144 | instance |
2026-09-11 17:20:55.300863 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-11 17:20:55.301263 | instance | Friday 11 September 2026  17:20:55 +0000 (0:00:00.044)       0:00:10.544 ******
2026-09-11 17:20:55.339723 | instance | skipping: [instance]
2026-09-11 17:20:55.339822 | instance |
2026-09-11 17:20:55.340015 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-11 17:20:55.340282 | instance | Friday 11 September 2026  17:20:55 +0000 (0:00:00.039)       0:00:10.583 ******
2026-09-11 17:21:01.340142 | instance | changed: [instance]
2026-09-11 17:21:01.340189 | instance |
2026-09-11 17:21:01.340197 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-11 17:21:01.340204 | instance | Friday 11 September 2026  17:21:01 +0000 (0:00:06.002)       0:00:16.586 ******
2026-09-11 17:21:01.995909 | instance | changed: [instance]
2026-09-11 17:21:01.996009 | instance |
2026-09-11 17:21:01.996516 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-11 17:21:01.996539 | instance | Friday 11 September 2026  17:21:01 +0000 (0:00:00.656)       0:00:17.243 ******
2026-09-11 17:21:03.058978 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-11 17:21:03.061553 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-11 17:21:03.061642 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-11 17:21:03.061662 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-11 17:21:03.061679 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-11 17:21:03.061693 | instance |
2026-09-11 17:21:03.061717 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-11 17:21:03.061732 | instance | Friday 11 September 2026  17:21:03 +0000 (0:00:01.062)       0:00:18.306 ******
2026-09-11 17:21:03.723067 | instance | changed: [instance]
2026-09-11 17:21:03.723168 | instance |
2026-09-11 17:21:03.723343 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-11 17:21:03.723531 | instance | Friday 11 September 2026  17:21:03 +0000 (0:00:00.635)       0:00:18.941 ******
2026-09-11 17:21:03.723686 | instance |
2026-09-11 17:21:03.723845 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:21:03.724023 | instance | Friday 11 September 2026  17:21:03 +0000 (0:00:00.028)       0:00:18.970 ******
2026-09-11 17:21:04.808749 | instance | ok: [instance]
2026-09-11 17:21:04.808868 | instance |
2026-09-11 17:21:04.809089 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-11 17:21:04.809319 | instance | Friday 11 September 2026  17:21:04 +0000 (0:00:01.084)       0:00:20.055 ******
2026-09-11 17:21:05.290457 | instance | changed: [instance]
2026-09-11 17:21:05.290873 | instance |
2026-09-11 17:21:05.290891 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-11 17:21:05.291218 | instance | Friday 11 September 2026  17:21:05 +0000 (0:00:00.482)       0:00:20.537 ******
2026-09-11 17:21:05.919484 | instance | changed: [instance]
2026-09-11 17:21:05.919531 | instance |
2026-09-11 17:21:05.919536 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-11 17:21:05.919541 | instance | Friday 11 September 2026  17:21:05 +0000 (0:00:00.629)       0:00:21.166 ******
2026-09-11 17:21:06.183510 | instance | ok: [instance]
2026-09-11 17:21:06.183620 | instance |
2026-09-11 17:21:06.183639 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-11 17:21:06.183804 | instance | Friday 11 September 2026  17:21:06 +0000 (0:00:00.264)       0:00:21.430 ******
2026-09-11 17:21:06.276841 | instance | ok: [instance] => {
2026-09-11 17:21:06.276937 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-11 17:21:06.276953 | instance | }
2026-09-11 17:21:06.276965 | instance |
2026-09-11 17:21:06.277010 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-11 17:21:06.277025 | instance | Friday 11 September 2026  17:21:06 +0000 (0:00:00.090)       0:00:21.521 ******
2026-09-11 17:21:07.173608 | instance | changed: [instance]
2026-09-11 17:21:07.173723 | instance |
2026-09-11 17:21:07.173788 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-11 17:21:07.174015 | instance | Friday 11 September 2026  17:21:07 +0000 (0:00:00.898)       0:00:22.420 ******
2026-09-11 17:21:11.659215 | instance | changed: [instance]
2026-09-11 17:21:11.660003 | instance |
2026-09-11 17:21:11.660058 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-11 17:21:11.660069 | instance | Friday 11 September 2026  17:21:11 +0000 (0:00:04.486)       0:00:26.906 ******
2026-09-11 17:21:12.790420 | instance | ok: [instance]
2026-09-11 17:21:12.790966 | instance |
2026-09-11 17:21:12.791041 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-11 17:21:12.791201 | instance | Friday 11 September 2026  17:21:12 +0000 (0:00:01.130)       0:00:28.037 ******
2026-09-11 17:21:13.160233 | instance | changed: [instance]
2026-09-11 17:21:13.160346 | instance |
2026-09-11 17:21:13.160357 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-11 17:21:13.160541 | instance | Friday 11 September 2026  17:21:13 +0000 (0:00:00.370)       0:00:28.408 ******
2026-09-11 17:21:13.683429 | instance | changed: [instance]
2026-09-11 17:21:13.683538 | instance |
2026-09-11 17:21:13.683936 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-11 17:21:13.684023 | instance | Friday 11 September 2026  17:21:13 +0000 (0:00:00.522)       0:00:28.930 ******
2026-09-11 17:21:14.325452 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-11 17:21:14.325561 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-11 17:21:14.326075 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-11 17:21:14.326145 | instance |
2026-09-11 17:21:14.326151 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-11 17:21:14.326157 | instance | Friday 11 September 2026  17:21:14 +0000 (0:00:00.642)       0:00:29.572 ******
2026-09-11 17:21:14.850126 | instance | changed: [instance]
2026-09-11 17:21:14.850905 | instance |
2026-09-11 17:21:14.851017 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-11 17:21:14.851041 | instance | Friday 11 September 2026  17:21:14 +0000 (0:00:00.524)       0:00:30.096 ******
2026-09-11 17:21:15.413483 | instance | changed: [instance]
2026-09-11 17:21:15.413568 | instance |
2026-09-11 17:21:15.414302 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-11 17:21:15.414373 | instance | Friday 11 September 2026  17:21:15 +0000 (0:00:00.536)       0:00:30.633 ******
2026-09-11 17:21:15.414384 | instance |
2026-09-11 17:21:15.414395 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-11 17:21:15.414409 | instance | Friday 11 September 2026  17:21:15 +0000 (0:00:00.027)       0:00:30.661 ******
2026-09-11 17:21:16.246197 | instance | ok: [instance]
2026-09-11 17:21:16.246915 | instance |
2026-09-11 17:21:16.247020 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-11 17:21:16.247062 | instance | Friday 11 September 2026  17:21:16 +0000 (0:00:00.832)       0:00:31.493 ******
2026-09-11 17:21:17.350440 | instance | changed: [instance]
2026-09-11 17:21:17.350526 | instance |
2026-09-11 17:21:17.350841 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-11 17:21:17.350883 | instance | Friday 11 September 2026  17:21:17 +0000 (0:00:01.104)       0:00:32.597 ******
2026-09-11 17:21:18.005631 | instance | changed: [instance]
2026-09-11 17:21:18.005712 | instance |
2026-09-11 17:21:18.005720 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-11 17:21:18.005727 | instance | Friday 11 September 2026  17:21:17 +0000 (0:00:00.652)       0:00:33.249 ******
2026-09-11 17:21:18.076146 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-11 17:21:18.076267 | instance |
2026-09-11 17:21:18.076281 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-11 17:21:18.076338 | instance | Friday 11 September 2026  17:21:18 +0000 (0:00:00.073)       0:00:33.323 ******
2026-09-11 17:21:23.642828 | instance | changed: [instance]
2026-09-11 17:21:23.643399 | instance |
2026-09-11 17:21:23.643583 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-11 17:21:23.643778 | instance | Friday 11 September 2026  17:21:23 +0000 (0:00:05.566)       0:00:38.890 ******
2026-09-11 17:21:24.324333 | instance | ok: [instance] => (item=chronyd)
2026-09-11 17:21:24.324814 | instance | ok: [instance] => (item=sshd)
2026-09-11 17:21:24.324968 | instance |
2026-09-11 17:21:24.325316 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-11 17:21:24.325632 | instance | Friday 11 September 2026  17:21:24 +0000 (0:00:00.680)       0:00:39.571 ******
2026-09-11 17:21:37.058515 | instance | changed: [instance]
2026-09-11 17:21:37.058831 | instance |
2026-09-11 17:21:37.059120 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-11 17:21:37.059376 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:12.733)       0:00:52.305 ******
2026-09-11 17:21:37.274742 | instance | ok: [instance]
2026-09-11 17:21:37.275066 | instance |
2026-09-11 17:21:37.275326 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-11 17:21:37.275636 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:00.216)       0:00:52.522 ******
2026-09-11 17:21:37.826284 | instance | changed: [instance]
2026-09-11 17:21:37.826504 | instance |
2026-09-11 17:21:37.826756 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-11 17:21:37.827082 | instance | Friday 11 September 2026  17:21:37 +0000 (0:00:00.551)       0:00:53.073 ******
2026-09-11 17:21:38.173776 | instance | changed: [instance]
2026-09-11 17:21:38.174010 | instance |
2026-09-11 17:21:38.174262 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-11 17:21:38.174504 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.348)       0:00:53.421 ******
2026-09-11 17:21:38.272079 | instance | ok: [instance]
2026-09-11 17:21:38.272280 | instance |
2026-09-11 17:21:38.272537 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-11 17:21:38.272765 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.097)       0:00:53.519 ******
2026-09-11 17:21:38.507174 | instance | ok: [instance] => (item=instance)
2026-09-11 17:21:38.507390 | instance |
2026-09-11 17:21:38.507650 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-11 17:21:38.507902 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.234)       0:00:53.754 ******
2026-09-11 17:21:38.568023 | instance | ok: [instance]
2026-09-11 17:21:38.568248 | instance |
2026-09-11 17:21:38.568507 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-11 17:21:38.568758 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.061)       0:00:53.815 ******
2026-09-11 17:21:38.645330 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-11 17:21:38.645478 | instance |
2026-09-11 17:21:38.645716 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-11 17:21:38.645962 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.077)       0:00:53.892 ******
2026-09-11 17:21:38.988537 | instance | changed: [instance]
2026-09-11 17:21:38.988699 | instance |
2026-09-11 17:21:38.989032 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-11 17:21:38.989184 | instance | Friday 11 September 2026  17:21:38 +0000 (0:00:00.342)       0:00:54.235 ******
2026-09-11 17:21:39.695297 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-11 17:21:39.695620 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-11 17:21:39.695917 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-11 17:21:39.696179 | instance |
2026-09-11 17:21:39.696467 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-11 17:21:39.696815 | instance | Friday 11 September 2026  17:21:39 +0000 (0:00:00.706)       0:00:54.942 ******
2026-09-11 17:23:21.015652 | instance | ok: [instance]
2026-09-11 17:23:21.015748 | instance |
2026-09-11 17:23:21.016834 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-11 17:23:21.016867 | instance | Friday 11 September 2026  17:23:21 +0000 (0:01:41.319)       0:02:36.262 ******
2026-09-11 17:23:21.254520 | instance | changed: [instance]
2026-09-11 17:23:21.254694 | instance |
2026-09-11 17:23:21.254907 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-11 17:23:21.255133 | instance | Friday 11 September 2026  17:23:21 +0000 (0:00:00.239)       0:02:36.501 ******
2026-09-11 17:23:21.301607 | instance | ok: [instance]
2026-09-11 17:23:21.301877 | instance |
2026-09-11 17:23:21.302193 | instance | TASK [Install Ceph host] *******************************************************
2026-09-11 17:23:21.302445 | instance | Friday 11 September 2026  17:23:21 +0000 (0:00:00.046)       0:02:36.548 ******
2026-09-11 17:23:21.378613 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-11 17:23:21.378864 | instance |
2026-09-11 17:23:21.379132 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-11 17:23:21.379435 | instance | Friday 11 September 2026  17:23:21 +0000 (0:00:00.077)       0:02:36.625 ******
2026-09-11 17:23:23.071921 | instance | ok: [instance]
2026-09-11 17:23:23.071979 | instance |
2026-09-11 17:23:23.071987 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-11 17:23:23.071994 | instance | Friday 11 September 2026  17:23:23 +0000 (0:00:01.692)       0:02:38.318 ******
2026-09-11 17:23:23.158664 | instance | ok: [instance] => (item=instance)
2026-09-11 17:23:23.158906 | instance |
2026-09-11 17:23:23.159183 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-11 17:23:23.159437 | instance | Friday 11 September 2026  17:23:23 +0000 (0:00:00.087)       0:02:38.405 ******
2026-09-11 17:23:23.566442 | instance | ok: [instance]
2026-09-11 17:23:23.566520 | instance |
2026-09-11 17:23:23.566642 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-11 17:23:23.566744 | instance | Friday 11 September 2026  17:23:23 +0000 (0:00:00.408)       0:02:38.814 ******
2026-09-11 17:23:25.954159 | instance | ok: [instance]
2026-09-11 17:23:25.954347 | instance |
2026-09-11 17:23:25.954699 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-11 17:23:25.955025 | instance | Friday 11 September 2026  17:23:25 +0000 (0:00:02.387)       0:02:41.201 ******
2026-09-11 17:24:13.251261 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-11 17:24:13.251474 | 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_dljbt__2/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_dljbt__2/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_dljbt__2/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_dljbt__2/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-11T17:24:13.081+0000 7f21dda15640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDUOKRqzUfRICAAQiN00TmGgn3019AafcKAR5joFZxRpwj4XmhhElvvIMs=: Malformed input [buffer:3]\n2026-09-11T17:24:13.081+0000 7f21dda15640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:13.085+0000 7f21dda15640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDUOKRqzUfRICAAQiN00TmGgn3019AafcKAR5joFZxRpwj4XmhhElvvIMs=: Malformed input [buffer:3]\n2026-09-11T17:24:13.085+0000 7f21dda15640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:13.085+0000 7f21dda15640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDUOKRqzUfRICAAQiN00TmGgn3019AafcKAR5joFZxRpwj4XmhhElvvIMs=: Malformed input [buffer:3]\n2026-09-11T17:24:13.085+0000 7f21dda15640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-11T17:24:13.085+0000 7f21dda15640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-11 17:24:13.251663 | instance |
2026-09-11 17:24:13.251834 | instance | PLAY RECAP *********************************************************************
2026-09-11 17:24:13.252040 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-11 17:24:13.252136 | instance |
2026-09-11 17:24:13.252299 | instance | Friday 11 September 2026  17:24:13 +0000 (0:00:47.297)       0:03:28.498 ******
2026-09-11 17:24:13.252434 | instance | ===============================================================================
2026-09-11 17:24:13.252567 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 101.32s
2026-09-11 17:24:13.252707 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 47.30s
2026-09-11 17:24:13.252873 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 12.73s
2026-09-11 17:24:13.253014 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.00s
2026-09-11 17:24:13.253156 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.57s
2026-09-11 17:24:13.253301 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.49s
2026-09-11 17:24:13.253444 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.93s
2026-09-11 17:24:13.253590 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.39s
2026-09-11 17:24:13.253735 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.92s
2026-09-11 17:24:13.253897 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.69s
2026-09-11 17:24:13.254036 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.35s
2026-09-11 17:24:13.254175 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.13s
2026-09-11 17:24:13.254317 | instance | Gathering Facts --------------------------------------------------------- 1.13s
2026-09-11 17:24:13.254465 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.10s
2026-09-11 17:24:13.254610 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.06s
2026-09-11 17:24:13.254753 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-11 17:24:13.254976 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-11 17:24:13.255119 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.90s
2026-09-11 17:24:13.255264 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.89s
2026-09-11 17:24:13.255409 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.71s
2026-09-11 17:24:13.368034 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:24:13.368171 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-11 17:24:13.368293 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-11 17:24:13.661560 | instance | ERROR
2026-09-11 17:24:13.661830 | instance | {
2026-09-11 17:24:13.661905 | instance |   "delta": "0:04:22.775093",
2026-09-11 17:24:13.661948 | instance |   "end": "2026-09-11 17:24:13.454072",
2026-09-11 17:24:13.661984 | instance |   "msg": "non-zero return code",
2026-09-11 17:24:13.662018 | instance |   "rc": 2,
2026-09-11 17:24:13.662052 | instance |   "start": "2026-09-11 17:19:50.678979"
2026-09-11 17:24:13.662086 | instance | }
failure
2026-09-11 17:24:13.671145 | 
2026-09-11 17:24:13.671242 | PLAY RECAP
2026-09-11 17:24:13.671317 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-11 17:24:13.671358 | 
2026-09-11 17:24:13.813734 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-11 17:24:13.818503 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:24:14.424314 | 
2026-09-11 17:24:14.424441 | PLAY [all]
2026-09-11 17:24:14.441165 | 
2026-09-11 17:24:14.441301 | TASK [gather-host-logs : creating directory for system status]
2026-09-11 17:24:14.859932 | instance | changed
2026-09-11 17:24:14.871397 | 
2026-09-11 17:24:14.871649 | TASK [gather-host-logs : Get logs for each host]
2026-09-11 17:24:15.278536 | instance | + systemd-cgls --full --all --no-pager
2026-09-11 17:24:15.287857 | instance | + ip addr
2026-09-11 17:24:15.291397 | instance | + ip route
2026-09-11 17:24:15.292722 | instance | + lsblk
2026-09-11 17:24:15.295265 | instance | + mount
2026-09-11 17:24:15.298081 | instance | + docker images
2026-09-11 17:24:15.323569 | instance | + brctl show
2026-09-11 17:24:15.324150 | instance | /bin/bash: line 8: brctl: command not found
2026-09-11 17:24:15.324456 | instance | + ip neigh
2026-09-11 17:24:15.326862 | instance | + bridge fdb show
2026-09-11 17:24:15.330042 | instance | + ps aux --sort=-%mem
2026-09-11 17:24:15.342430 | instance | + dpkg -l
2026-09-11 17:24:15.353554 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-11 17:24:15.353962 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-11 17:24:15.375633 | instance | + '[' '!' -z '' ']'
2026-09-11 17:24:15.426968 | instance | ok: Runtime: 0:00:00.101397
2026-09-11 17:24:15.437973 | 
2026-09-11 17:24:15.438104 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-11 17:24:16.113139 | instance | changed:
2026-09-11 17:24:16.113458 | instance | created directory /var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/logs/instance
2026-09-11 17:24:16.113523 | instance | cd+++++++++ system/
2026-09-11 17:24:16.113570 | instance | >f+++++++++ system/brctl-show.txt
2026-09-11 17:24:16.113624 | instance | >f+++++++++ system/bridge-fdb.txt
2026-09-11 17:24:16.113667 | instance | >f+++++++++ system/docker-images.txt
2026-09-11 17:24:16.113720 | instance | >f+++++++++ system/ip-addr.txt
2026-09-11 17:24:16.113775 | instance | >f+++++++++ system/ip-neigh.txt
2026-09-11 17:24:16.113849 | instance | >f+++++++++ system/ip-route.txt
2026-09-11 17:24:16.113910 | instance | >f+++++++++ system/lsblk.txt
2026-09-11 17:24:16.113953 | instance | >f+++++++++ system/mount.txt
2026-09-11 17:24:16.114001 | instance | >f+++++++++ system/packages.txt
2026-09-11 17:24:16.114050 | instance | >f+++++++++ system/ps.txt
2026-09-11 17:24:16.114089 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-11 17:24:16.132013 | 
2026-09-11 17:24:16.132150 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-11 17:24:16.340924 | instance | changed: "values"
2026-09-11 17:24:16.535747 | instance | changed: "releases"
2026-09-11 17:24:16.559131 | 
2026-09-11 17:24:16.559319 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-11 17:24:16.838498 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-11 17:24:17.122754 | instance | ok: Runtime: 0:00:00.005508
2026-09-11 17:24:17.133832 | 
2026-09-11 17:24:17.133967 | TASK [helm-release-status : Downloads logs to executor]
2026-09-11 17:24:17.669382 | instance | changed:
2026-09-11 17:24:17.669524 | instance | cd+++++++++ helm/
2026-09-11 17:24:17.669550 | instance | cd+++++++++ helm/releases/
2026-09-11 17:24:17.669569 | instance | cd+++++++++ helm/values/
2026-09-11 17:24:17.677060 | 
2026-09-11 17:24:17.677119 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-11 17:24:17.898386 | instance | changed
2026-09-11 17:24:17.928320 | 
2026-09-11 17:24:17.928435 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-11 17:24:18.269768 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:18.270299 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:18.275802 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:18.276911 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:18.278812 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:18.279892 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:18.280678 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:18.282201 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:18.282829 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:18.284035 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:18.285663 | instance | environment: line 1: kubectl: command not found
2026-09-11 17:24:18.286380 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-11 17:24:18.490544 | instance | ok: Runtime: 0:00:00.023912
2026-09-11 17:24:18.499351 | 
2026-09-11 17:24:18.499467 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-11 17:24:18.734208 | instance | changed
2026-09-11 17:24:18.743517 | 
2026-09-11 17:24:18.743648 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-11 17:24:19.011180 | instance | environment: line 5: kubectl: command not found
2026-09-11 17:24:19.011890 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:19.012616 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:19.012817 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-11 17:24:19.292262 | instance | ok: Runtime: 0:00:00.009684
2026-09-11 17:24:19.305070 | 
2026-09-11 17:24:19.305841 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-11 17:24:19.860021 | instance | changed:
2026-09-11 17:24:19.860255 | instance | cd+++++++++ objects/
2026-09-11 17:24:19.860310 | instance | cd+++++++++ objects/cluster/
2026-09-11 17:24:19.860351 | instance | cd+++++++++ objects/namespaced/
2026-09-11 17:24:19.878294 | 
2026-09-11 17:24:19.878421 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-11 17:24:20.098432 | instance | changed
2026-09-11 17:24:20.108541 | 
2026-09-11 17:24:20.108681 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-11 17:24:20.349926 | instance | changed
2026-09-11 17:24:20.360847 | 
2026-09-11 17:24:20.360995 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-11 17:24:20.630270 | instance | environment: line 3: kubectl: command not found
2026-09-11 17:24:20.902924 | instance | ok: Runtime: 0:00:00.005411
2026-09-11 17:24:20.917371 | 
2026-09-11 17:24:20.917552 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-11 17:24:21.418365 | instance | changed:
2026-09-11 17:24:21.419033 | instance | cd+++++++++ pod-logs/
2026-09-11 17:24:21.419093 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-11 17:24:21.438013 | 
2026-09-11 17:24:21.438325 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-11 17:24:21.673821 | instance | changed
2026-09-11 17:24:21.683611 | 
2026-09-11 17:24:21.683785 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-11 17:24:21.939766 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:24:22.230561 | instance | ok: Runtime: 0:00:00.055823
2026-09-11 17:24:22.239975 | 
2026-09-11 17:24:22.240105 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-11 17:24:22.510498 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-11 17:24:22.560169 | instance | ceph-mgr endpoints:
2026-09-11 17:24:22.789014 | instance | ok: Runtime: 0:00:00.056617
2026-09-11 17:24:22.795933 | 
2026-09-11 17:24:22.796028 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-11 17:24:23.080158 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-11 17:24:23.338491 | instance | ok: Runtime: 0:00:00.054872
2026-09-11 17:24:23.347705 | 
2026-09-11 17:24:23.347857 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-11 17:24:23.910379 | instance | changed: cd+++++++++ prometheus/
2026-09-11 17:24:23.935315 | 
2026-09-11 17:24:23.935459 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-11 17:24:24.144267 | instance | changed
2026-09-11 17:24:24.153487 | 
2026-09-11 17:24:24.153618 | TASK [gather-selenium-data : Get selenium data]
2026-09-11 17:24:24.450423 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-11 17:24:24.452250 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-11 17:24:24.701989 | instance | ERROR
2026-09-11 17:24:24.702441 | instance | {
2026-09-11 17:24:24.702509 | instance |   "delta": "0:00:00.008300",
2026-09-11 17:24:24.702553 | instance |   "end": "2026-09-11 17:24:24.452682",
2026-09-11 17:24:24.702591 | instance |   "msg": "non-zero return code",
2026-09-11 17:24:24.702627 | instance |   "rc": 1,
2026-09-11 17:24:24.702662 | instance |   "start": "2026-09-11 17:24:24.444382"
2026-09-11 17:24:24.702697 | instance | }
2026-09-11 17:24:24.702743 | instance | ERROR: Ignoring Errors
2026-09-11 17:24:24.711444 | 
2026-09-11 17:24:24.711563 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-11 17:24:25.224385 | instance | changed: cd+++++++++ selenium/
2026-09-11 17:24:25.233235 | 
2026-09-11 17:24:25.233366 | PLAY RECAP
2026-09-11 17:24:25.233442 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-11 17:24:25.233481 | 
2026-09-11 17:24:25.424729 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-11 17:24:25.432264 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:24:26.259842 | 
2026-09-11 17:24:26.259961 | PLAY [all]
2026-09-11 17:24:26.271018 | 
2026-09-11 17:24:26.271118 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-11 17:24:26.324892 | instance | skipping: Conditional result was False
2026-09-11 17:24:26.331406 | 
2026-09-11 17:24:26.331509 | TASK [fetch-output : Set log path for single node]
2026-09-11 17:24:26.373966 | instance | ok
2026-09-11 17:24:26.439087 | 
2026-09-11 17:24:26.439305 | LOOP [fetch-output : Ensure local output dirs]
2026-09-11 17:24:26.895428 | instance -> localhost | ok: "/var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/logs"
2026-09-11 17:24:27.271870 | instance -> localhost | changed: "/var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/artifacts"
2026-09-11 17:24:27.512821 | instance -> localhost | changed: "/var/lib/zuul/builds/8aea3ed5cd274f7784702c12a618cd2d/work/docs"
2026-09-11 17:24:27.528245 | 
2026-09-11 17:24:27.528309 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-11 17:24:28.202823 | instance | changed: .d..t...... ./
2026-09-11 17:24:28.203175 | instance | changed: All items complete
2026-09-11 17:24:28.203238 | 
2026-09-11 17:24:28.663962 | instance | changed: .d..t...... ./
2026-09-11 17:24:29.146826 | instance | changed: .d..t...... ./
2026-09-11 17:24:29.191623 | 
2026-09-11 17:24:29.192272 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-11 17:24:29.637981 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.012274
2026-09-11 17:24:29.974564 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006720
2026-09-11 17:24:29.994539 | 
2026-09-11 17:24:29.994691 | PLAY [all]
2026-09-11 17:24:30.010771 | 
2026-09-11 17:24:30.010995 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-11 17:24:30.420152 | instance | changed
2026-09-11 17:24:30.429923 | 
2026-09-11 17:24:30.430017 | PLAY RECAP
2026-09-11 17:24:30.430095 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-11 17:24:30.430139 | 
2026-09-11 17:24:30.602023 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-11 17:24:30.606418 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-11 17:24:31.204402 | 
2026-09-11 17:24:31.325990 | PLAY [localhost]
2026-09-11 17:24:31.347227 | 
2026-09-11 17:24:31.347397 | TASK [Generate Zuul manifest]
2026-09-11 17:24:31.368179 | localhost | ok
2026-09-11 17:24:31.601984 | 
2026-09-11 17:24:31.602180 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-11 17:24:32.091238 | localhost | changed
2026-09-11 17:24:32.108636 | 
2026-09-11 17:24:32.108729 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-11 17:24:32.153948 | localhost | ok
2026-09-11 17:24:32.167633 | 
2026-09-11 17:24:32.167752 | TASK [Upload logs]
2026-09-11 17:24:32.191586 | localhost | ok
2026-09-11 17:24:32.300077 | 
2026-09-11 17:24:32.300198 | TASK [Set zuul-log-path fact]
2026-09-11 17:24:32.317836 | localhost | ok
2026-09-11 17:24:32.351215 | 
2026-09-11 17:24:32.351358 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-11 17:24:32.389561 | localhost | ok
2026-09-11 17:24:32.397401 | 
2026-09-11 17:24:32.397467 | TASK [upload-logs : Create log directories]
2026-09-11 17:24:32.852438 | localhost | changed
2026-09-11 17:24:32.858705 | 
2026-09-11 17:24:32.858791 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-11 17:24:33.291981 | localhost -> localhost | ok: Runtime: 0:00:00.005250
2026-09-11 17:24:33.296685 | 
2026-09-11 17:24:33.296751 | TASK [upload-logs : Upload logs to log server]
2026-09-11 17:24:34.115558 | localhost | Output suppressed because no_log was given
2026-09-11 17:24:34.144488 | 
2026-09-11 17:24:34.144631 | LOOP [upload-logs : Compress console log and json output]
2026-09-11 17:24:34.203738 | localhost | skipping: Conditional result was False
2026-09-11 17:24:34.211133 | localhost | skipping: Conditional result was False
2026-09-11 17:24:34.227119 | 
2026-09-11 17:24:34.227296 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-11 17:24:34.296188 | localhost | skipping: Conditional result was False
2026-09-11 17:24:34.296696 | 
2026-09-11 17:24:34.300993 | localhost | skipping: Conditional result was False
2026-09-11 17:24:34.309401 | 
2026-09-11 17:24:34.309626 | LOOP [upload-logs : Upload console log and json output]