2026-09-09 00:55:11.891332 | Job console starting
2026-09-09 00:55:11.901118 | Updating git repos
2026-09-09 00:55:19.501903 | Cloning repos into workspace
2026-09-09 00:55:36.438474 | Restoring repo states
2026-09-09 00:55:44.818306 | Merging changes
2026-09-09 00:55:46.473869 | Checking out repos
2026-09-09 00:55:48.485507 | Preparing playbooks
2026-09-09 00:55:51.590234 | Running Ansible setup
2026-09-09 00:55:55.089061 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-09 00:55:55.667106 | 
2026-09-09 00:55:55.667255 | PLAY [localhost]
2026-09-09 00:55:55.674770 | 
2026-09-09 00:55:55.674839 | TASK [Gathering Facts]
2026-09-09 00:55:56.726247 | localhost | ok
2026-09-09 00:55:56.747540 | 
2026-09-09 00:55:56.747758 | TASK [Setup log path fact]
2026-09-09 00:55:56.776701 | localhost | ok
2026-09-09 00:55:56.791976 | 
2026-09-09 00:55:56.792087 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-09 00:55:56.832687 | localhost | ok
2026-09-09 00:55:56.844223 | 
2026-09-09 00:55:56.844386 | TASK [emit-job-header : Print job information]
2026-09-09 00:55:56.896907 | # Job Information
2026-09-09 00:55:56.897166 | Ansible Version: 2.16.18
2026-09-09 00:55:56.897231 | Job: atmosphere-molecule-csi-rbd
2026-09-09 00:55:56.897274 | Pipeline: check
2026-09-09 00:55:56.897338 | Executor: 2d72f0692154
2026-09-09 00:55:56.897377 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4089
2026-09-09 00:55:56.897422 | Event ID: 9c92ba20-abe8-11f1-8ba3-8b914870f6b2
2026-09-09 00:55:56.904946 | 
2026-09-09 00:55:56.905079 | LOOP [emit-job-header : Print node information]
2026-09-09 00:55:57.016975 | localhost | ok:
2026-09-09 00:55:57.017158 | localhost | # Node Information
2026-09-09 00:55:57.017183 | localhost | Inventory Hostname: instance
2026-09-09 00:55:57.017202 | localhost | Hostname: np0000192306
2026-09-09 00:55:57.017219 | localhost | Username: zuul
2026-09-09 00:55:57.017427 | localhost | Distro: Ubuntu 22.04
2026-09-09 00:55:57.017450 | localhost | Provider: yul1
2026-09-09 00:55:57.017467 | localhost | Region: ca-ymq-1
2026-09-09 00:55:57.017483 | localhost | Label: ubuntu-jammy
2026-09-09 00:55:57.017499 | localhost | Product Name: OpenStack Nova
2026-09-09 00:55:57.017515 | localhost | Interface IP: 162.253.55.43
2026-09-09 00:55:57.033916 | 
2026-09-09 00:55:57.034131 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-09 00:55:57.476568 | localhost -> localhost | changed
2026-09-09 00:55:57.485908 | 
2026-09-09 00:55:57.486051 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-09 00:55:58.435084 | localhost -> localhost | changed
2026-09-09 00:55:58.441389 | 
2026-09-09 00:55:58.441447 | PLAY [all]
2026-09-09 00:55:58.455568 | 
2026-09-09 00:55:58.455651 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-09 00:55:58.725121 | instance -> localhost | ok
2026-09-09 00:55:58.730946 | 
2026-09-09 00:55:58.731061 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-09 00:55:58.759997 | instance | ok
2026-09-09 00:55:58.774012 | instance | included: /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-09 00:55:58.780072 | 
2026-09-09 00:55:58.780203 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-09 00:56:00.154452 | instance -> localhost | Generating public/private rsa key pair.
2026-09-09 00:56:00.154794 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/258d83e9409c45b59eb3e4acb0c3b553_id_rsa
2026-09-09 00:56:00.154863 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/258d83e9409c45b59eb3e4acb0c3b553_id_rsa.pub
2026-09-09 00:56:00.155053 | instance -> localhost | The key fingerprint is:
2026-09-09 00:56:00.155140 | instance -> localhost | SHA256:cSrQiGgokvGAoDehz4f5tyeTJE+atclOLkPQOqp668E zuul-build-sshkey
2026-09-09 00:56:00.155241 | instance -> localhost | The key's randomart image is:
2026-09-09 00:56:00.155345 | instance -> localhost | +---[RSA 3072]----+
2026-09-09 00:56:00.155407 | instance -> localhost | |* .              |
2026-09-09 00:56:00.155452 | instance -> localhost | |+B o o           |
2026-09-09 00:56:00.155492 | instance -> localhost | |O.=.o . . .      |
2026-09-09 00:56:00.155692 | instance -> localhost | |++.+..   +       |
2026-09-09 00:56:00.155856 | instance -> localhost | |  =o. . S        |
2026-09-09 00:56:00.155920 | instance -> localhost | | .ooo +.         |
2026-09-09 00:56:00.155962 | instance -> localhost | | .Eo.Xo+         |
2026-09-09 00:56:00.156001 | instance -> localhost | |. ..=+O..        |
2026-09-09 00:56:00.156047 | instance -> localhost | |=oo. +++         |
2026-09-09 00:56:00.156086 | instance -> localhost | +----[SHA256]-----+
2026-09-09 00:56:00.156179 | instance -> localhost | ok: Runtime: 0:00:00.941805
2026-09-09 00:56:00.167713 | 
2026-09-09 00:56:00.167823 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-09 00:56:00.198890 | instance | ok
2026-09-09 00:56:00.211038 | instance | included: /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-09 00:56:00.219673 | 
2026-09-09 00:56:00.219850 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-09 00:56:00.237248 | instance | skipping: Conditional result was False
2026-09-09 00:56:00.244128 | 
2026-09-09 00:56:00.244206 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-09 00:56:00.787953 | instance | changed
2026-09-09 00:56:00.801617 | 
2026-09-09 00:56:00.801753 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-09 00:56:00.999013 | instance | ok
2026-09-09 00:56:01.010660 | 
2026-09-09 00:56:01.010904 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-09 00:56:01.572486 | instance | changed
2026-09-09 00:56:01.581402 | 
2026-09-09 00:56:01.581495 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-09 00:56:02.188546 | instance | changed
2026-09-09 00:56:02.201029 | 
2026-09-09 00:56:02.201193 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-09 00:56:02.227603 | instance | skipping: Conditional result was False
2026-09-09 00:56:02.239997 | 
2026-09-09 00:56:02.240134 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-09 00:56:02.667833 | instance -> localhost | changed
2026-09-09 00:56:02.677918 | 
2026-09-09 00:56:02.677997 | TASK [add-build-sshkey : Add back temp key]
2026-09-09 00:56:02.992185 | instance -> localhost | Identity added: /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/258d83e9409c45b59eb3e4acb0c3b553_id_rsa (zuul-build-sshkey)
2026-09-09 00:56:02.992411 | instance -> localhost | ok: Runtime: 0:00:00.010013
2026-09-09 00:56:02.997564 | 
2026-09-09 00:56:02.997632 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-09 00:56:03.342872 | instance | ok
2026-09-09 00:56:03.362637 | 
2026-09-09 00:56:03.362853 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-09 00:56:03.387731 | instance | skipping: Conditional result was False
2026-09-09 00:56:03.403767 | 
2026-09-09 00:56:03.403898 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-09 00:56:03.819070 | instance | ok
2026-09-09 00:56:03.830958 | 
2026-09-09 00:56:03.831092 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-09 00:56:07.487340 | instance | Output suppressed because no_log was given
2026-09-09 00:56:07.500183 | 
2026-09-09 00:56:07.500355 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-09 00:56:07.742588 | instance | ok: "logs"
2026-09-09 00:56:07.743049 | instance | ok: All items complete
2026-09-09 00:56:07.743093 | 
2026-09-09 00:56:07.895166 | instance | ok: "artifacts"
2026-09-09 00:56:08.089514 | instance | ok: "docs"
2026-09-09 00:56:08.100702 | 
2026-09-09 00:56:08.101483 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-09 00:56:08.323799 | instance | changed: "logs"
2026-09-09 00:56:08.504655 | instance | changed: "artifacts"
2026-09-09 00:56:08.668670 | instance | changed: "docs"
2026-09-09 00:56:08.685046 | 
2026-09-09 00:56:08.685231 | PLAY RECAP
2026-09-09 00:56:08.685369 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-09 00:56:08.685439 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-09 00:56:08.685485 | 
2026-09-09 00:56:08.862944 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-09 00:56:08.867382 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-09 00:56:09.446440 | 
2026-09-09 00:56:09.446565 | PLAY [all]
2026-09-09 00:56:09.456123 | 
2026-09-09 00:56:09.456195 | TASK [setup-uv : Extract archive]
2026-09-09 00:56:11.829861 | instance | changed
2026-09-09 00:56:11.841954 | 
2026-09-09 00:56:11.842127 | TASK [setup-uv : Print version]
2026-09-09 00:56:12.211520 | instance | uv 0.8.13
2026-09-09 00:56:12.378842 | instance | ok: Runtime: 0:00:00.013312
2026-09-09 00:56:12.390937 | 
2026-09-09 00:56:12.391030 | TASK [Install Ansible collection siblings]
2026-09-09 00:56:22.315683 | instance | changed:
2026-09-09 00:56:22.316333 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-09 00:56:22.316367 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-09 00:56:22.316388 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-09 00:56:22.316407 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-09 00:56:22.316425 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-09 00:56:22.316445 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-09 00:56:22.316465 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-09 00:56:22.316484 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-09 00:56:22.317042 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-09 00:56:22.317074 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-09 00:56:22.317094 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-09 00:56:22.317112 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-09 00:56:22.317129 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0
2026-09-09 00:56:22.317147 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-09 00:56:22.317163 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0
2026-09-09 00:56:22.317181 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-09 00:56:22.317197 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-09 00:56:22.317214 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-09 00:56:22.317231 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-09 00:56:22.317246 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0
2026-09-09 00:56:22.317262 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0
2026-09-09 00:56:22.317293 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-09 00:56:22.317314 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-09 00:56:22.317343 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-09-09 00:56:22.317361 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-09 00:56:22.317378 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-09 00:56:22.317394 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-09 00:56:22.317411 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-09-09 00:56:22.317427 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-09 00:56:22.317443 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-09 00:56:22.317459 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-09 00:56:22.317476 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-09 00:56:22.317493 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-09 00:56:22.317509 | instance | Checked out ansible.netcommon to v8.6.2
2026-09-09 00:56:22.317526 | 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-09 00:56:22.317549 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.317567 | instance | Process install dependency map
2026-09-09 00:56:22.317583 | instance | Starting collection install process
2026-09-09 00:56:22.317601 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-09 00:56:22.317617 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-09 00:56:22.317633 | instance | ansible.netcommon:8.6.2 was installed successfully
2026-09-09 00:56:22.317649 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-09 00:56:22.317665 | instance | Creating virtual environment at: .venv
2026-09-09 00:56:22.317681 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-09 00:56:22.317697 | instance | Downloading openstacksdk (1.7MiB)
2026-09-09 00:56:22.317720 | instance | Downloading netaddr (2.2MiB)
2026-09-09 00:56:22.317736 | instance | Downloading ansible-core (2.1MiB)
2026-09-09 00:56:22.317752 | instance | Downloading cryptography (4.2MiB)
2026-09-09 00:56:22.317767 | instance | Downloading setuptools (1.1MiB)
2026-09-09 00:56:22.317784 | instance | Downloading pygments (1.2MiB)
2026-09-09 00:56:22.317800 | instance | Downloading kubernetes (1.9MiB)
2026-09-09 00:56:22.317816 | instance | Downloading rjsonnet (1.2MiB)
2026-09-09 00:56:22.317833 | instance |    Building pyperclip==1.9.0
2026-09-09 00:56:22.317851 | instance |  Downloading rjsonnet
2026-09-09 00:56:22.317870 | instance |  Downloading netaddr
2026-09-09 00:56:22.317895 | instance |  Downloading pygments
2026-09-09 00:56:22.317918 | instance |  Downloading cryptography
2026-09-09 00:56:22.317935 | instance |  Downloading setuptools
2026-09-09 00:56:22.317952 | instance |  Downloading kubernetes
2026-09-09 00:56:22.317969 | instance |  Downloading ansible-core
2026-09-09 00:56:22.317986 | instance |  Downloading openstacksdk
2026-09-09 00:56:22.318002 | instance |       Built pyperclip==1.9.0
2026-09-09 00:56:22.318019 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-09 00:56:22.318036 | instance | Installed 79 packages in 204ms
2026-09-09 00:56:22.318052 | instance | Checked out ansible.posix to 1.6.0
2026-09-09 00:56:22.318069 | 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-09 00:56:22.318086 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318101 | instance | Process install dependency map
2026-09-09 00:56:22.318125 | instance | Starting collection install process
2026-09-09 00:56:22.318143 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-09 00:56:22.318159 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-09 00:56:22.318174 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-09 00:56:22.318190 | instance | Checked out ansible.utils to v6.1.0
2026-09-09 00:56:22.318207 | 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-09 00:56:22.318223 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318239 | instance | Process install dependency map
2026-09-09 00:56:22.318256 | instance | Starting collection install process
2026-09-09 00:56:22.318273 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-09 00:56:22.318304 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-09 00:56:22.318320 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-09 00:56:22.318336 | instance | Checked out atmosphere.common to v0.6.0
2026-09-09 00:56:22.318352 | 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-09 00:56:22.318368 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318384 | instance | Process install dependency map
2026-09-09 00:56:22.318401 | instance | Starting collection install process
2026-09-09 00:56:22.318417 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-09 00:56:22.318434 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-09 00:56:22.318451 | instance | atmosphere.common:0.6.0 was installed successfully
2026-09-09 00:56:22.318467 | instance | Checked out community.crypto to 2.2.3
2026-09-09 00:56:22.318483 | 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-09 00:56:22.318499 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318515 | instance | Process install dependency map
2026-09-09 00:56:22.318531 | instance | Starting collection install process
2026-09-09 00:56:22.318548 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-09 00:56:22.318564 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-09 00:56:22.318582 | instance | community.crypto:2.2.3 was installed successfully
2026-09-09 00:56:22.318598 | instance | Checked out community.general to 7.3.0
2026-09-09 00:56:22.318613 | 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-09 00:56:22.318629 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318644 | instance | Process install dependency map
2026-09-09 00:56:22.318661 | instance | Starting collection install process
2026-09-09 00:56:22.318678 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-09 00:56:22.318693 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-09 00:56:22.318709 | instance | community.general:7.3.0 was installed successfully
2026-09-09 00:56:22.318734 | instance | Checked out community.mysql to 3.6.0
2026-09-09 00:56:22.318759 | 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-09 00:56:22.318786 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.318814 | instance | Process install dependency map
2026-09-09 00:56:22.318839 | instance | Starting collection install process
2026-09-09 00:56:22.318863 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-09 00:56:22.318888 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-09 00:56:22.318912 | instance | community.mysql:3.6.0 was installed successfully
2026-09-09 00:56:22.318937 | instance | Checked out kubernetes.core to 2.4.0
2026-09-09 00:56:22.318962 | 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-09 00:56:22.318987 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.319011 | instance | Process install dependency map
2026-09-09 00:56:22.319037 | instance | Starting collection install process
2026-09-09 00:56:22.319060 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-09 00:56:22.319084 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-09 00:56:22.319182 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-09 00:56:22.319210 | instance | Checked out openstack.cloud to 1.7.0
2026-09-09 00:56:22.319229 | 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-09 00:56:22.319247 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.319265 | instance | Process install dependency map
2026-09-09 00:56:22.319302 | instance | Starting collection install process
2026-09-09 00:56:22.319329 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-09 00:56:22.319358 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-09 00:56:22.319386 | instance | openstack.cloud:1.7.0 was installed successfully
2026-09-09 00:56:22.319416 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-09 00:56:22.319447 | 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-09 00:56:22.319477 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.319506 | instance | Process install dependency map
2026-09-09 00:56:22.319532 | instance | Starting collection install process
2026-09-09 00:56:22.319557 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-09 00:56:22.319578 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-09 00:56:22.319595 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-09 00:56:22.319611 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-09 00:56:22.319628 | 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-09 00:56:22.319645 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.319670 | instance | Process install dependency map
2026-09-09 00:56:22.319688 | instance | Starting collection install process
2026-09-09 00:56:22.319704 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-09 00:56:22.319720 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-09 00:56:22.319736 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-09 00:56:22.319753 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-09 00:56:22.319769 | 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-09 00:56:22.319785 | instance | Starting galaxy collection install process
2026-09-09 00:56:22.319800 | instance | Process install dependency map
2026-09-09 00:56:22.319816 | instance | Starting collection install process
2026-09-09 00:56:22.319832 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-09 00:56:22.319848 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-09 00:56:22.319865 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-09 00:56:22.327078 | 
2026-09-09 00:56:22.327142 | PLAY RECAP
2026-09-09 00:56:22.327190 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-09 00:56:22.327210 | 
2026-09-09 00:56:22.473076 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-09 00:56:22.475622 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-09 00:56:23.063657 | 
2026-09-09 00:56:23.063836 | PLAY [all]
2026-09-09 00:56:23.074880 | 
2026-09-09 00:56:23.074992 | TASK [Install "jq" for log collection]
2026-09-09 00:56:32.398814 | instance | changed
2026-09-09 00:56:32.401361 | 
2026-09-09 00:56:32.401425 | PLAY RECAP
2026-09-09 00:56:32.401488 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-09 00:56:32.401553 | 
2026-09-09 00:56:32.629827 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-09 00:56:32.637110 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-09 00:56:33.260336 | 
2026-09-09 00:56:33.260469 | PLAY [all]
2026-09-09 00:56:33.271096 | 
2026-09-09 00:56:33.271177 | LOOP [Check inventory directories]
2026-09-09 00:56:33.696370 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-09 00:56:33.860566 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-09 00:56:34.020939 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-09 00:56:34.045252 | 
2026-09-09 00:56:34.045951 | LOOP [Copy inventory file for Zuul]
2026-09-09 00:56:34.887970 | instance | changed:
2026-09-09 00:56:34.888167 | instance | {
2026-09-09 00:56:34.888195 | instance |   "ansible_loop_var": "item",
2026-09-09 00:56:34.888217 | instance |   "changed": false,
2026-09-09 00:56:34.888234 | instance |   "failed": false,
2026-09-09 00:56:34.888254 | instance |   "invocation": {
2026-09-09 00:56:34.888270 | instance |     "module_args": {
2026-09-09 00:56:34.888308 | instance |       "checksum_algorithm": "sha1",
2026-09-09 00:56:34.888326 | instance |       "follow": true,
2026-09-09 00:56:34.888342 | instance |       "get_attributes": true,
2026-09-09 00:56:34.888359 | instance |       "get_checksum": true,
2026-09-09 00:56:34.888376 | instance |       "get_mime": true,
2026-09-09 00:56:34.888393 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-09 00:56:34.888420 | instance |     }
2026-09-09 00:56:34.888437 | instance |   },
2026-09-09 00:56:34.888452 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-09 00:56:34.888467 | instance |   "stat": {
2026-09-09 00:56:34.888482 | instance |     "atime": 1788915374.732012,
2026-09-09 00:56:34.888796 | instance |     "attr_flags": "e",
2026-09-09 00:56:34.888862 | instance |     "attributes": [
2026-09-09 00:56:34.888885 | instance |       "extents"
2026-09-09 00:56:34.888902 | instance |     ],
2026-09-09 00:56:34.888918 | instance |     "block_size": 4096,
2026-09-09 00:56:34.888933 | instance |     "blocks": 8,
2026-09-09 00:56:34.888949 | instance |     "charset": "unknown",
2026-09-09 00:56:34.888965 | instance |     "ctime": 1788915373.4240108,
2026-09-09 00:56:34.888982 | instance |     "dev": 64513,
2026-09-09 00:56:34.888997 | instance |     "device_type": 0,
2026-09-09 00:56:34.889012 | instance |     "executable": true,
2026-09-09 00:56:34.889028 | instance |     "exists": true,
2026-09-09 00:56:34.889043 | instance |     "gid": 1000,
2026-09-09 00:56:34.889057 | instance |     "gr_name": "zuul",
2026-09-09 00:56:34.889073 | instance |     "inode": 1048172,
2026-09-09 00:56:34.889092 | instance |     "isblk": false,
2026-09-09 00:56:34.889117 | instance |     "ischr": false,
2026-09-09 00:56:34.889133 | instance |     "isdir": true,
2026-09-09 00:56:34.889148 | instance |     "isfifo": false,
2026-09-09 00:56:34.889163 | instance |     "isgid": false,
2026-09-09 00:56:34.889178 | instance |     "islnk": false,
2026-09-09 00:56:34.889194 | instance |     "isreg": false,
2026-09-09 00:56:34.889208 | instance |     "issock": false,
2026-09-09 00:56:34.889223 | instance |     "isuid": false,
2026-09-09 00:56:34.889237 | instance |     "mimetype": "unknown",
2026-09-09 00:56:34.889251 | instance |     "mode": "0755",
2026-09-09 00:56:34.889266 | instance |     "mtime": 1788915373.4240108,
2026-09-09 00:56:34.889300 | instance |     "nlink": 22,
2026-09-09 00:56:34.889315 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-09 00:56:34.889331 | instance |     "pw_name": "zuul",
2026-09-09 00:56:34.889351 | instance |     "readable": true,
2026-09-09 00:56:34.889367 | instance |     "rgrp": true,
2026-09-09 00:56:34.889382 | instance |     "roth": true,
2026-09-09 00:56:34.889397 | instance |     "rusr": true,
2026-09-09 00:56:34.889412 | instance |     "size": 4096,
2026-09-09 00:56:34.889427 | instance |     "uid": 1000,
2026-09-09 00:56:34.889443 | instance |     "version": "3923916678",
2026-09-09 00:56:34.889459 | instance |     "wgrp": false,
2026-09-09 00:56:34.889475 | instance |     "woth": false,
2026-09-09 00:56:34.889490 | instance |     "writeable": true,
2026-09-09 00:56:34.889506 | instance |     "wusr": true,
2026-09-09 00:56:34.889521 | instance |     "xgrp": true,
2026-09-09 00:56:34.889535 | instance |     "xoth": true,
2026-09-09 00:56:34.889550 | instance |     "xusr": true
2026-09-09 00:56:34.889565 | instance |   }
2026-09-09 00:56:34.889581 | instance | }
2026-09-09 00:56:34.889615 | instance | ok: All items complete
2026-09-09 00:56:34.889634 | 
2026-09-09 00:56:34.892346 | instance | skipping: Conditional result was False
2026-09-09 00:56:34.902246 | instance | skipping: Conditional result was False
2026-09-09 00:56:34.917852 | 
2026-09-09 00:56:34.917990 | LOOP [Switch "ansible_host" to private IP]
2026-09-09 00:56:35.310042 | instance | changed: 1 replacements made
2026-09-09 00:56:35.356520 | instance | skipping: Conditional result was False
2026-09-09 00:56:35.358374 | instance | skipping: Conditional result was False
2026-09-09 00:56:35.383771 | 
2026-09-09 00:56:35.383929 | TASK [Run Molecule scenario]
2026-09-09 00:56:36.355442 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-09 00:56:36.766006 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-09 00:56:36.766148 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-09 00:56:47.816834 | instance | INFO     [csi > dependency] Executing
2026-09-09 00:56:47.817242 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-09 00:56:47.817646 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-09 00:56:47.817867 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-09 00:56:47.834774 | instance | INFO     [csi > cleanup] Executing
2026-09-09 00:56:47.835413 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-09 00:56:47.848258 | instance | INFO     [csi > destroy] Executing
2026-09-09 00:56:47.848319 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-09 00:56:47.848459 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-09 00:56:47.857416 | instance | INFO     [csi > syntax] Executing
2026-09-09 00:56:49.471917 | instance |
2026-09-09 00:56:49.472004 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-09 00:56:49.595612 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-09 00:56:49.610755 | instance | INFO     [csi > create] Executing
2026-09-09 00:56:49.614313 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-09 00:56:49.628626 | instance | INFO     [csi > prepare] Executing
2026-09-09 00:56:50.410617 | instance |
2026-09-09 00:56:50.410978 | instance | PLAY [Prepare] *****************************************************************
2026-09-09 00:56:50.411157 | instance |
2026-09-09 00:56:50.411470 | instance | TASK [Gathering Facts] *********************************************************
2026-09-09 00:56:50.411740 | instance | Wednesday 09 September 2026  00:56:50 +0000 (0:00:00.023)       0:00:00.023 ***
2026-09-09 00:56:51.684780 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-09 00:56:51.684911 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-09 00:56:51.685060 | instance | interpreter could change the meaning of that path. See
2026-09-09 00:56:51.685297 | instance | https://docs.ansible.com/ansible-
2026-09-09 00:56:51.685623 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-09 00:56:51.696275 | instance | ok: [instance]
2026-09-09 00:56:51.696509 | instance |
2026-09-09 00:56:51.696758 | instance | TASK [Configure short hostname] ************************************************
2026-09-09 00:56:51.696988 | instance | Wednesday 09 September 2026  00:56:51 +0000 (0:00:01.285)       0:00:01.309 ***
2026-09-09 00:56:52.439645 | instance | changed: [instance]
2026-09-09 00:56:52.439874 | instance |
2026-09-09 00:56:52.440171 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-09 00:56:52.440519 | instance | Wednesday 09 September 2026  00:56:52 +0000 (0:00:00.742)       0:00:02.052 ***
2026-09-09 00:56:52.734823 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-09 00:56:52.735049 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-09 00:56:52.735312 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-09 00:56:52.744030 | instance | changed: [instance]
2026-09-09 00:56:52.744269 | instance |
2026-09-09 00:56:52.744548 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-09 00:56:52.744795 | instance | Wednesday 09 September 2026  00:56:52 +0000 (0:00:00.305)       0:00:02.357 ***
2026-09-09 00:56:53.631210 | instance | ok: [instance]
2026-09-09 00:56:53.631446 | instance |
2026-09-09 00:56:53.631696 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-09 00:56:53.631901 | instance |
2026-09-09 00:56:53.632130 | instance | TASK [Gathering Facts] *********************************************************
2026-09-09 00:56:53.632392 | instance | Wednesday 09 September 2026  00:56:53 +0000 (0:00:00.886)       0:00:03.244 ***
2026-09-09 00:56:54.394955 | instance | ok: [instance]
2026-09-09 00:56:54.395167 | instance |
2026-09-09 00:56:54.395449 | instance | TASK [Install depedencies] *****************************************************
2026-09-09 00:56:54.395743 | instance | Wednesday 09 September 2026  00:56:54 +0000 (0:00:00.763)       0:00:04.007 ***
2026-09-09 00:57:18.815329 | instance | changed: [instance]
2026-09-09 00:57:18.815490 | instance |
2026-09-09 00:57:18.815707 | instance | TASK [Start up service] ********************************************************
2026-09-09 00:57:18.815940 | instance | Wednesday 09 September 2026  00:57:18 +0000 (0:00:24.420)       0:00:28.428 ***
2026-09-09 00:57:19.352877 | instance | ok: [instance]
2026-09-09 00:57:19.353047 | instance |
2026-09-09 00:57:19.353351 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-09 00:57:19.353615 | instance | Wednesday 09 September 2026  00:57:19 +0000 (0:00:00.538)       0:00:28.966 ***
2026-09-09 00:57:19.694021 | instance | ok: [instance]
2026-09-09 00:57:19.694249 | instance |
2026-09-09 00:57:19.694525 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-09 00:57:19.694879 | instance | Wednesday 09 September 2026  00:57:19 +0000 (0:00:00.340)       0:00:29.306 ***
2026-09-09 00:57:20.453576 | instance | changed: [instance]
2026-09-09 00:57:20.453973 | instance |
2026-09-09 00:57:20.454419 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-09 00:57:20.454738 | instance | Wednesday 09 September 2026  00:57:20 +0000 (0:00:00.759)       0:00:30.066 ***
2026-09-09 00:57:20.693839 | instance | ok: [instance]
2026-09-09 00:57:20.694084 | instance |
2026-09-09 00:57:20.694470 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-09 00:57:20.694778 | instance | Wednesday 09 September 2026  00:57:20 +0000 (0:00:00.240)       0:00:30.307 ***
2026-09-09 00:57:20.726126 | instance | skipping: [instance]
2026-09-09 00:57:20.726344 | instance |
2026-09-09 00:57:20.726598 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-09 00:57:20.726847 | instance | Wednesday 09 September 2026  00:57:20 +0000 (0:00:00.029)       0:00:30.336 ***
2026-09-09 00:57:21.346004 | instance | changed: [instance] => (item=osd0)
2026-09-09 00:57:21.346311 | instance | changed: [instance] => (item=osd1)
2026-09-09 00:57:21.346569 | instance | changed: [instance] => (item=osd2)
2026-09-09 00:57:21.346806 | instance |
2026-09-09 00:57:21.347058 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-09 00:57:21.347329 | instance | Wednesday 09 September 2026  00:57:21 +0000 (0:00:00.622)       0:00:30.959 ***
2026-09-09 00:57:22.047539 | instance | changed: [instance] => (item=osd0)
2026-09-09 00:57:22.047783 | instance | changed: [instance] => (item=osd1)
2026-09-09 00:57:22.048041 | instance | changed: [instance] => (item=osd2)
2026-09-09 00:57:22.048349 | instance |
2026-09-09 00:57:22.048609 | instance | TASK [Start loop devices] ******************************************************
2026-09-09 00:57:22.048874 | instance | Wednesday 09 September 2026  00:57:22 +0000 (0:00:00.701)       0:00:31.660 ***
2026-09-09 00:57:22.845748 | instance | changed: [instance] => (item=osd0)
2026-09-09 00:57:22.845965 | instance | changed: [instance] => (item=osd1)
2026-09-09 00:57:22.846329 | instance | changed: [instance] => (item=osd2)
2026-09-09 00:57:22.846613 | instance |
2026-09-09 00:57:22.846944 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-09 00:57:22.847372 | instance | Wednesday 09 September 2026  00:57:22 +0000 (0:00:00.797)       0:00:32.458 ***
2026-09-09 00:57:26.107478 | instance | changed: [instance] => (item=osd0)
2026-09-09 00:57:26.107767 | instance | changed: [instance] => (item=osd1)
2026-09-09 00:57:26.108033 | instance | changed: [instance] => (item=osd2)
2026-09-09 00:57:26.108295 | instance |
2026-09-09 00:57:26.108552 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-09 00:57:26.108804 | instance | Wednesday 09 September 2026  00:57:26 +0000 (0:00:03.262)       0:00:35.720 ***
2026-09-09 00:57:28.113126 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-09 00:57:28.113188 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-09 00:57:28.113215 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-09 00:57:28.113232 | instance |
2026-09-09 00:57:28.113492 | instance | PLAY RECAP *********************************************************************
2026-09-09 00:57:28.113948 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-09 00:57:28.114304 | instance |
2026-09-09 00:57:28.114612 | instance | Wednesday 09 September 2026  00:57:28 +0000 (0:00:02.005)       0:00:37.726 ***
2026-09-09 00:57:28.114901 | instance | ===============================================================================
2026-09-09 00:57:28.115216 | instance | Install depedencies ---------------------------------------------------- 24.42s
2026-09-09 00:57:28.115510 | instance | Create a volume group for each loop device ------------------------------ 3.26s
2026-09-09 00:57:28.115897 | instance | Create a logical volume for each loop device ---------------------------- 2.01s
2026-09-09 00:57:28.116281 | instance | Gathering Facts --------------------------------------------------------- 1.29s
2026-09-09 00:57:28.116591 | instance | Purge "snapd" package --------------------------------------------------- 0.89s
2026-09-09 00:57:28.116893 | instance | Start loop devices ------------------------------------------------------ 0.80s
2026-09-09 00:57:28.117226 | instance | Gathering Facts --------------------------------------------------------- 0.76s
2026-09-09 00:57:28.117532 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.76s
2026-09-09 00:57:28.117834 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-09 00:57:28.118278 | instance | Set permissions on loopback devices ------------------------------------- 0.70s
2026-09-09 00:57:28.118678 | instance | Create devices for Ceph ------------------------------------------------- 0.62s
2026-09-09 00:57:28.119008 | instance | Start up service -------------------------------------------------------- 0.54s
2026-09-09 00:57:28.119347 | instance | Generate lvm.conf ------------------------------------------------------- 0.34s
2026-09-09 00:57:28.119696 | instance | Ensure hostname inside hosts file --------------------------------------- 0.31s
2026-09-09 00:57:28.120010 | instance | Get list of all loopback devices ---------------------------------------- 0.24s
2026-09-09 00:57:28.120345 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-09 00:57:28.224867 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-09 00:57:28.241777 | instance | INFO     [csi > converge] Executing
2026-09-09 00:57:29.800744 | instance |
2026-09-09 00:57:29.801136 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-09 00:57:29.801427 | instance |
2026-09-09 00:57:29.801725 | instance | TASK [Gathering Facts] *********************************************************
2026-09-09 00:57:29.802076 | instance | Wednesday 09 September 2026  00:57:29 +0000 (0:00:00.008)       0:00:00.008 ***
2026-09-09 00:57:30.895779 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-09 00:57:30.896180 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-09 00:57:30.896496 | instance | interpreter could change the meaning of that path. See
2026-09-09 00:57:30.896795 | instance | https://docs.ansible.com/ansible-
2026-09-09 00:57:30.897130 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-09 00:57:30.910540 | instance | ok: [instance]
2026-09-09 00:57:30.911009 | instance |
2026-09-09 00:57:30.911465 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-09 00:57:30.911906 | instance | Wednesday 09 September 2026  00:57:30 +0000 (0:00:01.107)       0:00:01.116 ***
2026-09-09 00:57:30.966860 | instance | ok: [instance] => {
2026-09-09 00:57:30.967268 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-09 00:57:30.967571 | instance | }
2026-09-09 00:57:30.967857 | instance |
2026-09-09 00:57:30.968178 | instance | PLAY [all] *********************************************************************
2026-09-09 00:57:30.968463 | instance |
2026-09-09 00:57:30.968760 | instance | TASK [Gathering Facts] *********************************************************
2026-09-09 00:57:30.969104 | instance | Wednesday 09 September 2026  00:57:30 +0000 (0:00:00.057)       0:00:01.173 ***
2026-09-09 00:57:31.951044 | instance | ok: [instance]
2026-09-09 00:57:31.951450 | instance |
2026-09-09 00:57:31.951814 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-09 00:57:31.952167 | instance | Wednesday 09 September 2026  00:57:31 +0000 (0:00:00.981)       0:00:02.154 ***
2026-09-09 00:57:32.167059 | instance | ok: [instance]
2026-09-09 00:57:32.167410 | instance |
2026-09-09 00:57:32.167753 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-09 00:57:32.168078 | instance |
2026-09-09 00:57:32.168371 | instance | TASK [Gathering Facts] *********************************************************
2026-09-09 00:57:32.168661 | instance | Wednesday 09 September 2026  00:57:32 +0000 (0:00:00.219)       0:00:02.374 ***
2026-09-09 00:57:33.170836 | instance | ok: [instance]
2026-09-09 00:57:33.171229 | instance |
2026-09-09 00:57:33.171541 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-09 00:57:33.171852 | instance | Wednesday 09 September 2026  00:57:33 +0000 (0:00:00.999)       0:00:03.374 ***
2026-09-09 00:57:33.486165 | instance | ok: [instance]
2026-09-09 00:57:33.486393 | instance |
2026-09-09 00:57:33.486543 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-09 00:57:33.486705 | instance | Wednesday 09 September 2026  00:57:33 +0000 (0:00:00.316)       0:00:03.691 ***
2026-09-09 00:57:33.523876 | instance | skipping: [instance]
2026-09-09 00:57:33.523932 | instance |
2026-09-09 00:57:33.523937 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-09 00:57:33.523942 | instance | Wednesday 09 September 2026  00:57:33 +0000 (0:00:00.040)       0:00:03.731 ***
2026-09-09 00:57:33.872790 | instance | changed: [instance]
2026-09-09 00:57:33.872881 | instance |
2026-09-09 00:57:33.872889 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-09 00:57:33.872895 | instance | Wednesday 09 September 2026  00:57:33 +0000 (0:00:00.348)       0:00:04.080 ***
2026-09-09 00:57:33.966166 | instance | ok: [instance] => {
2026-09-09 00:57:33.966275 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-09 00:57:33.966287 | instance | }
2026-09-09 00:57:33.966296 | instance |
2026-09-09 00:57:33.966316 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-09 00:57:33.966325 | instance | Wednesday 09 September 2026  00:57:33 +0000 (0:00:00.092)       0:00:04.172 ***
2026-09-09 00:57:34.688491 | instance | changed: [instance]
2026-09-09 00:57:34.688592 | instance |
2026-09-09 00:57:34.688754 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-09 00:57:34.688919 | instance | Wednesday 09 September 2026  00:57:34 +0000 (0:00:00.723)       0:00:04.896 ***
2026-09-09 00:57:34.762138 | instance | skipping: [instance]
2026-09-09 00:57:34.762230 | instance |
2026-09-09 00:57:34.762416 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-09 00:57:34.762563 | instance | Wednesday 09 September 2026  00:57:34 +0000 (0:00:00.073)       0:00:04.969 ***
2026-09-09 00:57:34.817493 | instance | skipping: [instance]
2026-09-09 00:57:34.817614 | instance |
2026-09-09 00:57:34.817763 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-09 00:57:34.817913 | instance | Wednesday 09 September 2026  00:57:34 +0000 (0:00:00.055)       0:00:05.025 ***
2026-09-09 00:57:35.096749 | instance | ok: [instance]
2026-09-09 00:57:35.096980 | instance |
2026-09-09 00:57:35.097231 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-09 00:57:35.097470 | instance | Wednesday 09 September 2026  00:57:35 +0000 (0:00:00.278)       0:00:05.303 ***
2026-09-09 00:57:36.573232 | instance | ok: [instance]
2026-09-09 00:57:36.573619 | instance |
2026-09-09 00:57:36.574056 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-09 00:57:36.574423 | instance | Wednesday 09 September 2026  00:57:36 +0000 (0:00:01.476)       0:00:06.780 ***
2026-09-09 00:57:36.654836 | instance | ok: [instance] => {
2026-09-09 00:57:36.654958 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-09 00:57:36.655133 | instance | }
2026-09-09 00:57:36.655409 | instance |
2026-09-09 00:57:36.655622 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-09 00:57:36.655838 | instance | Wednesday 09 September 2026  00:57:36 +0000 (0:00:00.081)       0:00:06.862 ***
2026-09-09 00:57:37.487439 | instance | changed: [instance]
2026-09-09 00:57:37.487591 | instance |
2026-09-09 00:57:37.487874 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-09 00:57:37.488417 | instance | Wednesday 09 September 2026  00:57:37 +0000 (0:00:00.832)       0:00:07.694 ***
2026-09-09 00:57:40.511245 | instance | changed: [instance]
2026-09-09 00:57:40.511315 | instance |
2026-09-09 00:57:40.511329 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-09 00:57:40.511341 | instance | Wednesday 09 September 2026  00:57:40 +0000 (0:00:03.022)       0:00:10.717 ***
2026-09-09 00:57:40.550852 | instance | skipping: [instance]
2026-09-09 00:57:40.551348 | instance |
2026-09-09 00:57:40.551399 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-09 00:57:40.551408 | instance | Wednesday 09 September 2026  00:57:40 +0000 (0:00:00.040)       0:00:10.758 ***
2026-09-09 00:57:40.596642 | instance | skipping: [instance]
2026-09-09 00:57:40.598137 | instance |
2026-09-09 00:57:40.598227 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-09 00:57:40.598238 | instance | Wednesday 09 September 2026  00:57:40 +0000 (0:00:00.045)       0:00:10.803 ***
2026-09-09 00:57:40.639615 | instance | skipping: [instance]
2026-09-09 00:57:40.639900 | instance |
2026-09-09 00:57:40.640387 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-09 00:57:40.640769 | instance | Wednesday 09 September 2026  00:57:40 +0000 (0:00:00.043)       0:00:10.846 ***
2026-09-09 00:57:46.181494 | instance | changed: [instance]
2026-09-09 00:57:46.181718 | instance |
2026-09-09 00:57:46.182161 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-09 00:57:46.182486 | instance | Wednesday 09 September 2026  00:57:46 +0000 (0:00:05.541)       0:00:16.388 ***
2026-09-09 00:57:46.855876 | instance | changed: [instance]
2026-09-09 00:57:46.856592 | instance |
2026-09-09 00:57:46.856625 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-09 00:57:46.856637 | instance | Wednesday 09 September 2026  00:57:46 +0000 (0:00:00.674)       0:00:17.063 ***
2026-09-09 00:57:47.954053 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-09 00:57:47.954255 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-09 00:57:47.955722 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-09 00:57:47.955809 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-09 00:57:47.955822 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-09 00:57:47.955832 | instance |
2026-09-09 00:57:47.955850 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-09 00:57:47.955860 | instance | Wednesday 09 September 2026  00:57:47 +0000 (0:00:01.097)       0:00:18.161 ***
2026-09-09 00:57:48.642190 | instance | changed: [instance]
2026-09-09 00:57:48.642274 | instance |
2026-09-09 00:57:48.642765 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-09 00:57:48.642784 | instance | Wednesday 09 September 2026  00:57:48 +0000 (0:00:00.665)       0:00:18.826 ***
2026-09-09 00:57:48.642789 | instance |
2026-09-09 00:57:48.642794 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-09 00:57:48.642798 | instance | Wednesday 09 September 2026  00:57:48 +0000 (0:00:00.023)       0:00:18.850 ***
2026-09-09 00:57:49.733551 | instance | ok: [instance]
2026-09-09 00:57:49.733616 | instance |
2026-09-09 00:57:49.733912 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-09 00:57:49.733970 | instance | Wednesday 09 September 2026  00:57:49 +0000 (0:00:01.091)       0:00:19.941 ***
2026-09-09 00:57:50.276076 | instance | changed: [instance]
2026-09-09 00:57:50.277036 | instance |
2026-09-09 00:57:50.277122 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-09 00:57:50.277138 | instance | Wednesday 09 September 2026  00:57:50 +0000 (0:00:00.541)       0:00:20.483 ***
2026-09-09 00:57:50.874223 | instance | changed: [instance]
2026-09-09 00:57:50.874384 | instance |
2026-09-09 00:57:50.874658 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-09 00:57:50.874895 | instance | Wednesday 09 September 2026  00:57:50 +0000 (0:00:00.597)       0:00:21.081 ***
2026-09-09 00:57:51.121011 | instance | ok: [instance]
2026-09-09 00:57:51.121198 | instance |
2026-09-09 00:57:51.121457 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-09 00:57:51.121733 | instance | Wednesday 09 September 2026  00:57:51 +0000 (0:00:00.246)       0:00:21.328 ***
2026-09-09 00:57:51.211568 | instance | ok: [instance] => {
2026-09-09 00:57:51.211919 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-09 00:57:51.212176 | instance | }
2026-09-09 00:57:51.212411 | instance |
2026-09-09 00:57:51.212734 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-09 00:57:51.213001 | instance | Wednesday 09 September 2026  00:57:51 +0000 (0:00:00.090)       0:00:21.418 ***
2026-09-09 00:57:52.114590 | instance | changed: [instance]
2026-09-09 00:57:52.114828 | instance |
2026-09-09 00:57:52.115050 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-09 00:57:52.115281 | instance | Wednesday 09 September 2026  00:57:52 +0000 (0:00:00.903)       0:00:22.322 ***
2026-09-09 00:57:56.647844 | instance | changed: [instance]
2026-09-09 00:57:56.647923 | instance |
2026-09-09 00:57:56.647936 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-09 00:57:56.647946 | instance | Wednesday 09 September 2026  00:57:56 +0000 (0:00:04.532)       0:00:26.854 ***
2026-09-09 00:57:58.002745 | instance | ok: [instance]
2026-09-09 00:57:58.002891 | instance |
2026-09-09 00:57:58.003394 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-09 00:57:58.003459 | instance | Wednesday 09 September 2026  00:57:57 +0000 (0:00:01.355)       0:00:28.210 ***
2026-09-09 00:57:58.394967 | instance | changed: [instance]
2026-09-09 00:57:58.395057 | instance |
2026-09-09 00:57:58.395124 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-09 00:57:58.395259 | instance | Wednesday 09 September 2026  00:57:58 +0000 (0:00:00.392)       0:00:28.602 ***
2026-09-09 00:57:58.967411 | instance | changed: [instance]
2026-09-09 00:57:58.967470 | instance |
2026-09-09 00:57:58.967482 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-09 00:57:58.967492 | instance | Wednesday 09 September 2026  00:57:58 +0000 (0:00:00.570)       0:00:29.173 ***
2026-09-09 00:57:59.604663 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-09 00:57:59.605320 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-09 00:57:59.605339 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-09 00:57:59.605346 | instance |
2026-09-09 00:57:59.605352 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-09 00:57:59.605358 | instance | Wednesday 09 September 2026  00:57:59 +0000 (0:00:00.638)       0:00:29.812 ***
2026-09-09 00:58:00.152686 | instance | changed: [instance]
2026-09-09 00:58:00.153513 | instance |
2026-09-09 00:58:00.153592 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-09 00:58:00.153605 | instance | Wednesday 09 September 2026  00:58:00 +0000 (0:00:00.547)       0:00:30.360 ***
2026-09-09 00:58:00.706114 | instance | changed: [instance]
2026-09-09 00:58:00.706221 | instance |
2026-09-09 00:58:00.707016 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-09 00:58:00.707213 | instance | Wednesday 09 September 2026  00:58:00 +0000 (0:00:00.524)       0:00:30.884 ***
2026-09-09 00:58:00.707222 | instance |
2026-09-09 00:58:00.707229 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-09 00:58:00.707235 | instance | Wednesday 09 September 2026  00:58:00 +0000 (0:00:00.029)       0:00:30.913 ***
2026-09-09 00:58:01.503512 | instance | ok: [instance]
2026-09-09 00:58:01.503618 | instance |
2026-09-09 00:58:01.503974 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-09 00:58:01.504033 | instance | Wednesday 09 September 2026  00:58:01 +0000 (0:00:00.797)       0:00:31.711 ***
2026-09-09 00:58:02.533699 | instance | changed: [instance]
2026-09-09 00:58:02.534073 | instance |
2026-09-09 00:58:02.534198 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-09 00:58:02.534582 | instance | Wednesday 09 September 2026  00:58:02 +0000 (0:00:01.029)       0:00:32.740 ***
2026-09-09 00:58:03.173835 | instance | changed: [instance]
2026-09-09 00:58:03.173900 | instance |
2026-09-09 00:58:03.173908 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-09 00:58:03.173915 | instance | Wednesday 09 September 2026  00:58:03 +0000 (0:00:00.637)       0:00:33.378 ***
2026-09-09 00:58:03.238561 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-09 00:58:03.238656 | instance |
2026-09-09 00:58:03.238858 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-09 00:58:03.239111 | instance | Wednesday 09 September 2026  00:58:03 +0000 (0:00:00.067)       0:00:33.446 ***
2026-09-09 00:58:09.841165 | instance | changed: [instance]
2026-09-09 00:58:09.842013 | instance |
2026-09-09 00:58:09.842088 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-09 00:58:09.842101 | instance | Wednesday 09 September 2026  00:58:09 +0000 (0:00:06.602)       0:00:40.048 ***
2026-09-09 00:58:10.565023 | instance | ok: [instance] => (item=chronyd)
2026-09-09 00:58:10.566086 | instance | ok: [instance] => (item=sshd)
2026-09-09 00:58:10.566371 | instance |
2026-09-09 00:58:10.566383 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-09 00:58:10.566416 | instance | Wednesday 09 September 2026  00:58:10 +0000 (0:00:00.724)       0:00:40.772 ***
2026-09-09 00:58:17.446085 | instance | changed: [instance]
2026-09-09 00:58:17.446340 | instance |
2026-09-09 00:58:17.446640 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-09 00:58:17.446892 | instance | Wednesday 09 September 2026  00:58:17 +0000 (0:00:06.880)       0:00:47.653 ***
2026-09-09 00:58:17.669578 | instance | ok: [instance]
2026-09-09 00:58:17.669830 | instance |
2026-09-09 00:58:17.670191 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-09 00:58:17.670488 | instance | Wednesday 09 September 2026  00:58:17 +0000 (0:00:00.223)       0:00:47.877 ***
2026-09-09 00:58:18.182635 | instance | changed: [instance]
2026-09-09 00:58:18.182859 | instance |
2026-09-09 00:58:18.183122 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-09 00:58:18.183361 | instance | Wednesday 09 September 2026  00:58:18 +0000 (0:00:00.512)       0:00:48.390 ***
2026-09-09 00:58:18.560392 | instance | changed: [instance]
2026-09-09 00:58:18.560584 | instance |
2026-09-09 00:58:18.560826 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-09 00:58:18.561060 | instance | Wednesday 09 September 2026  00:58:18 +0000 (0:00:00.377)       0:00:48.768 ***
2026-09-09 00:58:18.699097 | instance | ok: [instance]
2026-09-09 00:58:18.699458 | instance |
2026-09-09 00:58:18.699831 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-09 00:58:18.700091 | instance | Wednesday 09 September 2026  00:58:18 +0000 (0:00:00.137)       0:00:48.905 ***
2026-09-09 00:58:18.961189 | instance | ok: [instance] => (item=instance)
2026-09-09 00:58:18.961337 | instance |
2026-09-09 00:58:18.961643 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-09 00:58:18.961935 | instance | Wednesday 09 September 2026  00:58:18 +0000 (0:00:00.262)       0:00:49.168 ***
2026-09-09 00:58:19.033768 | instance | ok: [instance]
2026-09-09 00:58:19.033988 | instance |
2026-09-09 00:58:19.034252 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-09 00:58:19.034532 | instance | Wednesday 09 September 2026  00:58:19 +0000 (0:00:00.072)       0:00:49.241 ***
2026-09-09 00:58:19.121727 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-09 00:58:19.122014 | instance |
2026-09-09 00:58:19.122343 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-09 00:58:19.122652 | instance | Wednesday 09 September 2026  00:58:19 +0000 (0:00:00.088)       0:00:49.329 ***
2026-09-09 00:58:19.482080 | instance | changed: [instance]
2026-09-09 00:58:19.482334 | instance |
2026-09-09 00:58:19.482634 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-09 00:58:19.482878 | instance | Wednesday 09 September 2026  00:58:19 +0000 (0:00:00.359)       0:00:49.689 ***
2026-09-09 00:58:20.231964 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-09 00:58:20.232151 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-09 00:58:20.232422 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-09 00:58:20.232642 | instance |
2026-09-09 00:58:20.232876 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-09 00:58:20.233151 | instance | Wednesday 09 September 2026  00:58:20 +0000 (0:00:00.749)       0:00:50.439 ***
2026-09-09 01:00:00.206360 | instance | ok: [instance]
2026-09-09 01:00:00.206963 | instance |
2026-09-09 01:00:00.206994 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-09 01:00:00.207099 | instance | Wednesday 09 September 2026  01:00:00 +0000 (0:01:39.974)       0:02:30.413 ***
2026-09-09 01:00:00.468477 | instance | changed: [instance]
2026-09-09 01:00:00.468673 | instance |
2026-09-09 01:00:00.468914 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-09 01:00:00.469151 | instance | Wednesday 09 September 2026  01:00:00 +0000 (0:00:00.262)       0:02:30.676 ***
2026-09-09 01:00:00.560641 | instance | ok: [instance]
2026-09-09 01:00:00.560821 | instance |
2026-09-09 01:00:00.561041 | instance | TASK [Install Ceph host] *******************************************************
2026-09-09 01:00:00.561268 | instance | Wednesday 09 September 2026  01:00:00 +0000 (0:00:00.092)       0:02:30.768 ***
2026-09-09 01:00:00.654878 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-09 01:00:00.655018 | instance |
2026-09-09 01:00:00.655193 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-09 01:00:00.655489 | instance | Wednesday 09 September 2026  01:00:00 +0000 (0:00:00.094)       0:02:30.863 ***
2026-09-09 01:00:02.528992 | instance | ok: [instance]
2026-09-09 01:00:02.529183 | instance |
2026-09-09 01:00:02.529576 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-09 01:00:02.529913 | instance | Wednesday 09 September 2026  01:00:02 +0000 (0:00:01.873)       0:02:32.736 ***
2026-09-09 01:00:02.592170 | instance | ok: [instance] => (item=instance)
2026-09-09 01:00:02.592411 | instance |
2026-09-09 01:00:02.592829 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-09 01:00:02.593084 | instance | Wednesday 09 September 2026  01:00:02 +0000 (0:00:00.062)       0:02:32.799 ***
2026-09-09 01:00:03.000156 | instance | ok: [instance]
2026-09-09 01:00:03.000628 | instance |
2026-09-09 01:00:03.001369 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-09 01:00:03.001492 | instance | Wednesday 09 September 2026  01:00:02 +0000 (0:00:00.407)       0:02:33.207 ***
2026-09-09 01:00:05.505737 | instance | ok: [instance]
2026-09-09 01:00:05.505907 | instance |
2026-09-09 01:00:05.506135 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-09 01:00:05.506321 | instance | Wednesday 09 September 2026  01:00:05 +0000 (0:00:02.505)       0:02:35.713 ***
2026-09-09 01:01:02.252324 | 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-09 01:01:02.252436 | 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_s91qrm2h/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_s91qrm2h/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_s91qrm2h/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_s91qrm2h/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-09T01:01:02.053+0000 7fa534124640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBir6Bq2DkeOCAA49gfJNeHJynrPQvwcdXVqo2s2lHC451RIKCBjPanevM=: Malformed input [buffer:3]\n2026-09-09T01:01:02.053+0000 7fa534124640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-09T01:01:02.053+0000 7fa534124640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBir6Bq2DkeOCAA49gfJNeHJynrPQvwcdXVqo2s2lHC451RIKCBjPanevM=: Malformed input [buffer:3]\n2026-09-09T01:01:02.053+0000 7fa534124640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-09T01:01:02.057+0000 7fa534124640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBir6Bq2DkeOCAA49gfJNeHJynrPQvwcdXVqo2s2lHC451RIKCBjPanevM=: Malformed input [buffer:3]\n2026-09-09T01:01:02.057+0000 7fa534124640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-09T01:01:02.057+0000 7fa534124640 -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-09 01:01:02.254418 | instance |
2026-09-09 01:01:02.254690 | instance | PLAY RECAP *********************************************************************
2026-09-09 01:01:02.258091 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-09 01:01:02.258158 | instance |
2026-09-09 01:01:02.258170 | instance | Wednesday 09 September 2026  01:01:02 +0000 (0:00:56.749)       0:03:32.462 ***
2026-09-09 01:01:02.258181 | instance | ===============================================================================
2026-09-09 01:01:02.258190 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 99.97s
2026-09-09 01:01:02.258199 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 56.75s
2026-09-09 01:01:02.258207 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 6.88s
2026-09-09 01:01:02.258216 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 6.60s
2026-09-09 01:01:02.258225 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.54s
2026-09-09 01:01:02.258233 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.53s
2026-09-09 01:01:02.258242 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.02s
2026-09-09 01:01:02.258251 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.51s
2026-09-09 01:01:02.258280 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.89s
2026-09-09 01:01:02.258296 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.87s
2026-09-09 01:01:02.258539 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.48s
2026-09-09 01:01:02.258943 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.36s
2026-09-09 01:01:02.259245 | instance | Gathering Facts --------------------------------------------------------- 1.11s
2026-09-09 01:01:02.259536 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.10s
2026-09-09 01:01:02.259869 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.03s
2026-09-09 01:01:02.260159 | instance | Gathering Facts --------------------------------------------------------- 1.00s
2026-09-09 01:01:02.260448 | instance | Gathering Facts --------------------------------------------------------- 0.98s
2026-09-09 01:01:02.260773 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.90s
2026-09-09 01:01:02.261080 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-09-09 01:01:02.261398 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.75s
2026-09-09 01:01:02.394985 | 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-09 01:01:02.395301 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-09 01:01:02.395495 | 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-09 01:01:02.788683 | instance | ERROR
2026-09-09 01:01:02.789005 | instance | {
2026-09-09 01:01:02.789062 | instance |   "delta": "0:04:26.735791",
2026-09-09 01:01:02.789102 | instance |   "end": "2026-09-09 01:01:02.488961",
2026-09-09 01:01:02.789136 | instance |   "msg": "non-zero return code",
2026-09-09 01:01:02.789170 | instance |   "rc": 2,
2026-09-09 01:01:02.789203 | instance |   "start": "2026-09-09 00:56:35.753170"
2026-09-09 01:01:02.789237 | instance | }
failure
2026-09-09 01:01:02.798749 | 
2026-09-09 01:01:02.798850 | PLAY RECAP
2026-09-09 01:01:02.798959 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-09 01:01:02.799004 | 
2026-09-09 01:01:03.008760 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-09 01:01:03.015300 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-09 01:01:03.598056 | 
2026-09-09 01:01:03.598169 | PLAY [all]
2026-09-09 01:01:03.611099 | 
2026-09-09 01:01:03.611182 | TASK [gather-host-logs : creating directory for system status]
2026-09-09 01:01:04.054118 | instance | changed
2026-09-09 01:01:04.058777 | 
2026-09-09 01:01:04.058857 | TASK [gather-host-logs : Get logs for each host]
2026-09-09 01:01:04.409243 | instance | + systemd-cgls --full --all --no-pager
2026-09-09 01:01:04.426047 | instance | + ip addr
2026-09-09 01:01:04.428860 | instance | + ip route
2026-09-09 01:01:04.431857 | instance | + lsblk
2026-09-09 01:01:04.437470 | instance | + mount
2026-09-09 01:01:04.440608 | instance | + docker images
2026-09-09 01:01:04.463770 | instance | + brctl show
2026-09-09 01:01:04.464401 | instance | /bin/bash: line 8: brctl: command not found
2026-09-09 01:01:04.464844 | instance | + ps aux --sort=-%mem
2026-09-09 01:01:04.485821 | instance | + dpkg -l
2026-09-09 01:01:04.497326 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-09 01:01:04.498191 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-09 01:01:04.518587 | instance | + '[' '!' -z '' ']'
2026-09-09 01:01:04.592257 | instance | ok: Runtime: 0:00:00.115032
2026-09-09 01:01:04.605718 | 
2026-09-09 01:01:04.605957 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-09 01:01:05.369908 | instance | changed:
2026-09-09 01:01:05.370186 | instance | created directory /var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/logs/instance
2026-09-09 01:01:05.370244 | instance | cd+++++++++ system/
2026-09-09 01:01:05.370288 | instance | >f+++++++++ system/brctl-show.txt
2026-09-09 01:01:05.370329 | instance | >f+++++++++ system/docker-images.txt
2026-09-09 01:01:05.370368 | instance | >f+++++++++ system/ip-addr.txt
2026-09-09 01:01:05.370412 | instance | >f+++++++++ system/ip-route.txt
2026-09-09 01:01:05.370452 | instance | >f+++++++++ system/lsblk.txt
2026-09-09 01:01:05.370492 | instance | >f+++++++++ system/mount.txt
2026-09-09 01:01:05.370529 | instance | >f+++++++++ system/packages.txt
2026-09-09 01:01:05.370589 | instance | >f+++++++++ system/ps.txt
2026-09-09 01:01:05.370635 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-09 01:01:05.388879 | 
2026-09-09 01:01:05.389012 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-09 01:01:05.603354 | instance | changed: "values"
2026-09-09 01:01:05.794428 | instance | changed: "releases"
2026-09-09 01:01:05.814403 | 
2026-09-09 01:01:05.814745 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-09 01:01:06.090682 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-09 01:01:06.364340 | instance | ok: Runtime: 0:00:00.006376
2026-09-09 01:01:06.374852 | 
2026-09-09 01:01:06.375058 | TASK [helm-release-status : Downloads logs to executor]
2026-09-09 01:01:06.900468 | instance | changed:
2026-09-09 01:01:06.900659 | instance | cd+++++++++ helm/
2026-09-09 01:01:06.900686 | instance | cd+++++++++ helm/releases/
2026-09-09 01:01:06.900706 | instance | cd+++++++++ helm/values/
2026-09-09 01:01:06.908467 | 
2026-09-09 01:01:06.908545 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-09 01:01:07.143055 | instance | changed
2026-09-09 01:01:07.157458 | 
2026-09-09 01:01:07.157622 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-09 01:01:07.473971 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-09 01:01:07.474382 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-09 01:01:07.480668 | instance | environment: line 1: kubectl: command not found
2026-09-09 01:01:07.482420 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-09 01:01:07.484405 | instance | environment: line 1: kubectl: command not found
2026-09-09 01:01:07.485945 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-09 01:01:07.486265 | instance | environment: line 1: kubectl: command not found
2026-09-09 01:01:07.487662 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-09 01:01:07.490250 | instance | environment: line 1: kubectl: command not found
2026-09-09 01:01:07.491232 | instance | environment: line 1: kubectl: command not found
2026-09-09 01:01:07.491337 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-09 01:01:07.492680 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-09 01:01:07.696113 | instance | ok: Runtime: 0:00:00.028347
2026-09-09 01:01:07.703506 | 
2026-09-09 01:01:07.703632 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-09 01:01:07.934188 | instance | changed
2026-09-09 01:01:07.945859 | 
2026-09-09 01:01:07.946001 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-09 01:01:08.171055 | instance | environment: line 5: kubectl: command not found
2026-09-09 01:01:08.171884 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-09 01:01:08.171929 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-09 01:01:08.172684 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-09 01:01:08.488895 | instance | ok: Runtime: 0:00:00.010297
2026-09-09 01:01:08.500176 | 
2026-09-09 01:01:08.500435 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-09 01:01:09.040004 | instance | changed:
2026-09-09 01:01:09.040238 | instance | cd+++++++++ objects/
2026-09-09 01:01:09.040279 | instance | cd+++++++++ objects/cluster/
2026-09-09 01:01:09.040311 | instance | cd+++++++++ objects/namespaced/
2026-09-09 01:01:09.051931 | 
2026-09-09 01:01:09.052037 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-09 01:01:09.277267 | instance | changed
2026-09-09 01:01:09.284028 | 
2026-09-09 01:01:09.284112 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-09 01:01:09.518370 | instance | changed
2026-09-09 01:01:09.529728 | 
2026-09-09 01:01:09.529999 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-09 01:01:09.800860 | instance | environment: line 3: kubectl: command not found
2026-09-09 01:01:10.075111 | instance | ok: Runtime: 0:00:00.008788
2026-09-09 01:01:10.079704 | 
2026-09-09 01:01:10.079771 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-09 01:01:10.620846 | instance | changed:
2026-09-09 01:01:10.621101 | instance | cd+++++++++ pod-logs/
2026-09-09 01:01:10.621159 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-09 01:01:10.641810 | 
2026-09-09 01:01:10.641982 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-09 01:01:10.890296 | instance | changed
2026-09-09 01:01:10.897543 | 
2026-09-09 01:01:10.897669 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-09 01:01:11.141607 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-09 01:01:11.448268 | instance | ok: Runtime: 0:00:00.057087
2026-09-09 01:01:11.459850 | 
2026-09-09 01:01:11.460089 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-09 01:01:11.677391 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-09 01:01:11.724533 | instance | ceph-mgr endpoints:
2026-09-09 01:01:12.003660 | instance | ok: Runtime: 0:00:00.054094
2026-09-09 01:01:12.010933 | 
2026-09-09 01:01:12.011058 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-09 01:01:12.284982 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-09 01:01:12.564389 | instance | ok: Runtime: 0:00:00.056932
2026-09-09 01:01:12.583052 | 
2026-09-09 01:01:12.583322 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-09 01:01:13.126634 | instance | changed: cd+++++++++ prometheus/
2026-09-09 01:01:13.145751 | 
2026-09-09 01:01:13.145885 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-09 01:01:13.369444 | instance | changed
2026-09-09 01:01:13.379378 | 
2026-09-09 01:01:13.379656 | TASK [gather-selenium-data : Get selenium data]
2026-09-09 01:01:13.669767 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-09 01:01:13.671292 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-09 01:01:13.923323 | instance | ERROR
2026-09-09 01:01:13.923795 | instance | {
2026-09-09 01:01:13.923875 | instance |   "delta": "0:00:00.006843",
2026-09-09 01:01:13.923971 | instance |   "end": "2026-09-09 01:01:13.671699",
2026-09-09 01:01:13.924027 | instance |   "msg": "non-zero return code",
2026-09-09 01:01:13.924069 | instance |   "rc": 1,
2026-09-09 01:01:13.924108 | instance |   "start": "2026-09-09 01:01:13.664856"
2026-09-09 01:01:13.924199 | instance | }
2026-09-09 01:01:13.924269 | instance | ERROR: Ignoring Errors
2026-09-09 01:01:13.938633 | 
2026-09-09 01:01:13.938949 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-09 01:01:14.611093 | instance | changed: cd+++++++++ selenium/
2026-09-09 01:01:14.619200 | 
2026-09-09 01:01:14.619313 | PLAY RECAP
2026-09-09 01:01:14.619376 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-09 01:01:14.619406 | 
2026-09-09 01:01:14.773710 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-09 01:01:14.776049 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-09 01:01:15.543393 | 
2026-09-09 01:01:15.543719 | PLAY [all]
2026-09-09 01:01:15.567527 | 
2026-09-09 01:01:15.567754 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-09 01:01:15.612933 | instance | skipping: Conditional result was False
2026-09-09 01:01:15.624373 | 
2026-09-09 01:01:15.624590 | TASK [fetch-output : Set log path for single node]
2026-09-09 01:01:15.668810 | instance | ok
2026-09-09 01:01:15.677665 | 
2026-09-09 01:01:15.691304 | LOOP [fetch-output : Ensure local output dirs]
2026-09-09 01:01:16.486454 | instance -> localhost | ok: "/var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/logs"
2026-09-09 01:01:17.394284 | instance -> localhost | changed: "/var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/artifacts"
2026-09-09 01:01:17.862369 | instance -> localhost | changed: "/var/lib/zuul/builds/258d83e9409c45b59eb3e4acb0c3b553/work/docs"
2026-09-09 01:01:17.894197 | 
2026-09-09 01:01:17.894352 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-09 01:01:21.049187 | instance | changed: .d..t...... ./
2026-09-09 01:01:21.049443 | instance | changed: All items complete
2026-09-09 01:01:21.049488 | 
2026-09-09 01:01:21.586723 | instance | changed: .d..t...... ./
2026-09-09 01:01:22.173544 | instance | changed: .d..t...... ./
2026-09-09 01:01:22.191814 | 
2026-09-09 01:01:22.191944 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-09 01:01:22.716318 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007855
2026-09-09 01:01:23.191119 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008654
2026-09-09 01:01:23.218855 | 
2026-09-09 01:01:23.219058 | PLAY [all]
2026-09-09 01:01:23.232167 | 
2026-09-09 01:01:23.232294 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-09 01:01:23.732435 | instance | changed
2026-09-09 01:01:23.743009 | 
2026-09-09 01:01:23.743107 | PLAY RECAP
2026-09-09 01:01:23.743351 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-09 01:01:23.743418 | 
2026-09-09 01:01:23.903509 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-09 01:01:23.909791 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-09 01:01:25.827831 | 
2026-09-09 01:01:25.828102 | PLAY [localhost]
2026-09-09 01:01:25.851793 | 
2026-09-09 01:01:26.025044 | TASK [Generate Zuul manifest]
2026-09-09 01:01:26.059037 | localhost | ok
2026-09-09 01:01:26.295792 | 
2026-09-09 01:01:26.296024 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-09 01:01:26.838029 | localhost | changed
2026-09-09 01:01:26.853288 | 
2026-09-09 01:01:26.853389 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-09 01:01:26.945191 | localhost | ok
2026-09-09 01:01:26.954922 | 
2026-09-09 01:01:26.955015 | TASK [Upload logs]
2026-09-09 01:01:26.979138 | localhost | ok
2026-09-09 01:01:27.058592 | 
2026-09-09 01:01:27.059182 | TASK [Set zuul-log-path fact]
2026-09-09 01:01:27.087193 | localhost | ok
2026-09-09 01:01:27.245956 | 
2026-09-09 01:01:27.351854 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-09 01:01:27.385444 | localhost | ok
2026-09-09 01:01:27.399767 | 
2026-09-09 01:01:27.399906 | TASK [upload-logs : Create log directories]
2026-09-09 01:01:27.863682 | localhost | changed
2026-09-09 01:01:28.100780 | 
2026-09-09 01:01:28.101059 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-09 01:01:28.776061 | localhost -> localhost | ok: Runtime: 0:00:00.010217
2026-09-09 01:01:28.786116 | 
2026-09-09 01:01:28.786250 | TASK [upload-logs : Upload logs to log server]
2026-09-09 01:01:29.561013 | localhost | Output suppressed because no_log was given
2026-09-09 01:01:29.613889 | 
2026-09-09 01:01:29.614049 | LOOP [upload-logs : Compress console log and json output]
2026-09-09 01:01:29.662909 | localhost | skipping: Conditional result was False
2026-09-09 01:01:29.674301 | localhost | skipping: Conditional result was False
2026-09-09 01:01:29.687475 | 
2026-09-09 01:01:29.687678 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-09 01:01:29.728727 | localhost | skipping: Conditional result was False
2026-09-09 01:01:29.729090 | 
2026-09-09 01:01:29.741734 | localhost | skipping: Conditional result was False
2026-09-09 01:01:29.758266 | 
2026-09-09 01:01:29.758773 | LOOP [upload-logs : Upload console log and json output]