2026-08-20 01:05:56.016402 | Job console starting
2026-08-20 01:05:56.030310 | Updating git repos
2026-08-20 01:06:03.986014 | Cloning repos into workspace
2026-08-20 01:06:20.091433 | Restoring repo states
2026-08-20 01:06:29.857171 | Merging changes
2026-08-20 01:06:30.878121 | Checking out repos
2026-08-20 01:06:32.670773 | Preparing playbooks
2026-08-20 01:06:38.421487 | Running Ansible setup
2026-08-20 01:06:42.351411 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 01:06:43.000135 | 
2026-08-20 01:06:43.000259 | PLAY [localhost]
2026-08-20 01:06:43.007507 | 
2026-08-20 01:06:43.007574 | TASK [Gathering Facts]
2026-08-20 01:06:44.130398 | localhost | ok
2026-08-20 01:06:44.140424 | 
2026-08-20 01:06:44.140569 | TASK [Setup log path fact]
2026-08-20 01:06:44.163539 | localhost | ok
2026-08-20 01:06:44.176560 | 
2026-08-20 01:06:44.176641 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 01:06:44.207689 | localhost | ok
2026-08-20 01:06:44.216639 | 
2026-08-20 01:06:44.216739 | TASK [emit-job-header : Print job information]
2026-08-20 01:06:44.265068 | # Job Information
2026-08-20 01:06:44.265261 | Ansible Version: 2.16.18
2026-08-20 01:06:44.265306 | Job: atmosphere-molecule-csi-rbd
2026-08-20 01:06:44.265337 | Pipeline: check
2026-08-20 01:06:44.265364 | Executor: 2d72f0692154
2026-08-20 01:06:44.265392 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090
2026-08-20 01:06:44.265424 | Event ID: d62eb880-9c32-11f1-9ee6-3fb0947c1a37
2026-08-20 01:06:44.270541 | 
2026-08-20 01:06:44.270632 | LOOP [emit-job-header : Print node information]
2026-08-20 01:06:44.373567 | localhost | ok:
2026-08-20 01:06:44.374286 | localhost | # Node Information
2026-08-20 01:06:44.374331 | localhost | Inventory Hostname: instance
2026-08-20 01:06:44.374363 | localhost | Hostname: np0000190154
2026-08-20 01:06:44.374392 | localhost | Username: zuul
2026-08-20 01:06:44.374424 | localhost | Distro: Ubuntu 22.04
2026-08-20 01:06:44.374453 | localhost | Provider: yul1
2026-08-20 01:06:44.374480 | localhost | Region: ca-ymq-1
2026-08-20 01:06:44.374507 | localhost | Label: ubuntu-jammy
2026-08-20 01:06:44.374534 | localhost | Product Name: OpenStack Nova
2026-08-20 01:06:44.374561 | localhost | Interface IP: 199.204.45.129
2026-08-20 01:06:44.387407 | 
2026-08-20 01:06:44.387533 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-20 01:06:44.808276 | localhost -> localhost | changed
2026-08-20 01:06:44.817312 | 
2026-08-20 01:06:44.817410 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-20 01:06:46.647194 | localhost -> localhost | changed
2026-08-20 01:06:46.657797 | 
2026-08-20 01:06:46.657866 | PLAY [all]
2026-08-20 01:06:46.666675 | 
2026-08-20 01:06:46.666741 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-20 01:06:46.944072 | instance -> localhost | ok
2026-08-20 01:06:46.950039 | 
2026-08-20 01:06:46.950105 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-20 01:06:46.984208 | instance | ok
2026-08-20 01:06:47.000882 | instance | included: /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-20 01:06:47.006508 | 
2026-08-20 01:06:47.006570 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-20 01:06:47.992648 | instance -> localhost | Generating public/private rsa key pair.
2026-08-20 01:06:47.992851 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/fea730c2c333442c98d673fd12cbf1a9_id_rsa
2026-08-20 01:06:47.992910 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/fea730c2c333442c98d673fd12cbf1a9_id_rsa.pub
2026-08-20 01:06:47.992944 | instance -> localhost | The key fingerprint is:
2026-08-20 01:06:47.993026 | instance -> localhost | SHA256:J5GTdEpzvADPOEqi7UT81vkzZmF4XyEJFv+ClrRNytI zuul-build-sshkey
2026-08-20 01:06:47.993103 | instance -> localhost | The key's randomart image is:
2026-08-20 01:06:47.993140 | instance -> localhost | +---[RSA 3072]----+
2026-08-20 01:06:47.993179 | instance -> localhost | |      ..Boo      |
2026-08-20 01:06:47.993211 | instance -> localhost | | .     B.X..     |
2026-08-20 01:06:47.993257 | instance -> localhost | |  + . o X.=..    |
2026-08-20 01:06:47.993288 | instance -> localhost | | + + o B X.o .   |
2026-08-20 01:06:47.993318 | instance -> localhost | |. o + = E + o    |
2026-08-20 01:06:47.993357 | instance -> localhost | | o .   * = o     |
2026-08-20 01:06:47.993388 | instance -> localhost | |  .     * .      |
2026-08-20 01:06:47.993420 | instance -> localhost | |       o o       |
2026-08-20 01:06:47.993454 | instance -> localhost | |                 |
2026-08-20 01:06:47.993484 | instance -> localhost | +----[SHA256]-----+
2026-08-20 01:06:47.993555 | instance -> localhost | ok: Runtime: 0:00:00.527943
2026-08-20 01:06:48.000706 | 
2026-08-20 01:06:48.000773 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-20 01:06:48.032901 | instance | ok
2026-08-20 01:06:48.044483 | instance | included: /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-20 01:06:48.055130 | 
2026-08-20 01:06:48.055231 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-20 01:06:48.071281 | instance | skipping: Conditional result was False
2026-08-20 01:06:48.081365 | 
2026-08-20 01:06:48.081449 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-20 01:06:48.500027 | instance | changed
2026-08-20 01:06:48.509357 | 
2026-08-20 01:06:48.509431 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-20 01:06:48.698085 | instance | ok
2026-08-20 01:06:48.729762 | 
2026-08-20 01:06:48.729869 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-20 01:06:49.206725 | instance | changed
2026-08-20 01:06:49.213192 | 
2026-08-20 01:06:49.213396 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-20 01:06:49.665854 | instance | changed
2026-08-20 01:06:49.674333 | 
2026-08-20 01:06:49.674434 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-20 01:06:49.700661 | instance | skipping: Conditional result was False
2026-08-20 01:06:49.709307 | 
2026-08-20 01:06:49.709393 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-20 01:06:50.088675 | instance -> localhost | changed
2026-08-20 01:06:50.100931 | 
2026-08-20 01:06:50.101015 | TASK [add-build-sshkey : Add back temp key]
2026-08-20 01:06:50.376704 | instance -> localhost | Identity added: /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/fea730c2c333442c98d673fd12cbf1a9_id_rsa (zuul-build-sshkey)
2026-08-20 01:06:50.376970 | instance -> localhost | ok: Runtime: 0:00:00.010541
2026-08-20 01:06:50.384092 | 
2026-08-20 01:06:50.384192 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-20 01:06:50.705880 | instance | ok
2026-08-20 01:06:50.710636 | 
2026-08-20 01:06:50.710700 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-20 01:06:50.736452 | instance | skipping: Conditional result was False
2026-08-20 01:06:50.751946 | 
2026-08-20 01:06:50.752035 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-20 01:06:51.131133 | instance | ok
2026-08-20 01:06:51.139118 | 
2026-08-20 01:06:51.139230 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-20 01:06:54.245683 | instance | Output suppressed because no_log was given
2026-08-20 01:06:54.257771 | 
2026-08-20 01:06:54.316934 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-20 01:06:54.506145 | instance | ok: "logs"
2026-08-20 01:06:54.506396 | instance | ok: All items complete
2026-08-20 01:06:54.506425 | 
2026-08-20 01:06:54.654227 | instance | ok: "artifacts"
2026-08-20 01:06:54.829296 | instance | ok: "docs"
2026-08-20 01:06:54.845860 | 
2026-08-20 01:06:54.845994 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-20 01:06:55.027043 | instance | changed: "logs"
2026-08-20 01:06:55.183668 | instance | changed: "artifacts"
2026-08-20 01:06:55.334848 | instance | changed: "docs"
2026-08-20 01:06:55.349982 | 
2026-08-20 01:06:55.350101 | PLAY RECAP
2026-08-20 01:06:55.350168 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-20 01:06:55.350208 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 01:06:55.350240 | 
2026-08-20 01:06:55.490819 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 01:06:55.494920 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 01:06:56.098536 | 
2026-08-20 01:06:56.098654 | PLAY [all]
2026-08-20 01:06:56.113073 | 
2026-08-20 01:06:56.113341 | TASK [setup-uv : Extract archive]
2026-08-20 01:06:58.185525 | instance | changed
2026-08-20 01:06:58.197738 | 
2026-08-20 01:06:58.198026 | TASK [setup-uv : Print version]
2026-08-20 01:06:58.592827 | instance | uv 0.8.13
2026-08-20 01:06:58.733743 | instance | ok: Runtime: 0:00:00.012740
2026-08-20 01:06:58.746340 | 
2026-08-20 01:06:58.746483 | TASK [Install Ansible collection siblings]
2026-08-20 01:07:07.205460 | instance | changed:
2026-08-20 01:07:07.205687 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 01:07:07.205723 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 01:07:07.205753 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 01:07:07.205780 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 01:07:07.205801 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 01:07:07.205834 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 01:07:07.205862 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 01:07:07.205886 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 01:07:07.205912 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 01:07:07.205939 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 01:07:07.205966 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 01:07:07.205992 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 01:07:07.206017 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-20 01:07:07.206045 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-20 01:07:07.206069 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-20 01:07:07.206094 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-20 01:07:07.206113 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-20 01:07:07.206138 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-20 01:07:07.206161 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-20 01:07:07.206188 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-20 01:07:07.206210 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-20 01:07:07.206235 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-20 01:07:07.206260 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 01:07:07.206313 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-20 01:07:07.206335 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-20 01:07:07.206360 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 01:07:07.206387 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 01:07:07.206412 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 01:07:07.206433 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-20 01:07:07.206457 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-20 01:07:07.206480 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 01:07:07.206508 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 01:07:07.206534 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-20 01:07:07.206555 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 01:07:07.206587 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.206613 | instance | Process install dependency map
2026-08-20 01:07:07.206636 | instance | Starting collection install process
2026-08-20 01:07:07.206660 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-20 01:07:07.206684 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-20 01:07:07.206711 | instance | ansible.netcommon:* was installed successfully
2026-08-20 01:07:07.206732 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-20 01:07:07.206756 | instance | Creating virtual environment at: .venv
2026-08-20 01:07:07.206779 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 01:07:07.206808 | instance | Downloading kubernetes (1.9MiB)
2026-08-20 01:07:07.206831 | instance | Downloading openstacksdk (1.7MiB)
2026-08-20 01:07:07.206875 | instance | Downloading rjsonnet (1.2MiB)
2026-08-20 01:07:07.206898 | instance | Downloading pygments (1.2MiB)
2026-08-20 01:07:07.206924 | instance | Downloading ansible-core (2.1MiB)
2026-08-20 01:07:07.206944 | instance | Downloading setuptools (1.1MiB)
2026-08-20 01:07:07.206974 | instance | Downloading cryptography (4.2MiB)
2026-08-20 01:07:07.207001 | instance | Downloading netaddr (2.2MiB)
2026-08-20 01:07:07.207027 | instance |    Building pyperclip==1.9.0
2026-08-20 01:07:07.207048 | instance |  Downloading rjsonnet
2026-08-20 01:07:07.207077 | instance |  Downloading netaddr
2026-08-20 01:07:07.207098 | instance |  Downloading pygments
2026-08-20 01:07:07.207122 | instance |  Downloading cryptography
2026-08-20 01:07:07.207154 | instance |  Downloading setuptools
2026-08-20 01:07:07.207175 | instance |  Downloading kubernetes
2026-08-20 01:07:07.207195 | instance |  Downloading ansible-core
2026-08-20 01:07:07.207215 | instance |  Downloading openstacksdk
2026-08-20 01:07:07.207234 | instance |       Built pyperclip==1.9.0
2026-08-20 01:07:07.207254 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 01:07:07.207273 | instance | Installed 79 packages in 36ms
2026-08-20 01:07:07.207293 | instance | Checked out ansible.posix to 1.6.0
2026-08-20 01:07:07.207312 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 01:07:07.207331 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.207350 | instance | Process install dependency map
2026-08-20 01:07:07.207369 | instance | Starting collection install process
2026-08-20 01:07:07.207388 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-20 01:07:07.207413 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-20 01:07:07.207433 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-20 01:07:07.207452 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.207470 | instance | 2.17.12
2026-08-20 01:07:07.207489 | instance | Checked out ansible.utils to v6.1.0
2026-08-20 01:07:07.207508 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 01:07:07.207527 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.207546 | instance | Process install dependency map
2026-08-20 01:07:07.207565 | instance | Starting collection install process
2026-08-20 01:07:07.207583 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-20 01:07:07.207602 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-20 01:07:07.207621 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-20 01:07:07.207640 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.207659 | instance | 2.17.12
2026-08-20 01:07:07.207678 | instance | Checked out atmosphere.common to v0.7.0
2026-08-20 01:07:07.207697 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 01:07:07.207716 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.207735 | instance | Process install dependency map
2026-08-20 01:07:07.207753 | instance | Starting collection install process
2026-08-20 01:07:07.207772 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-20 01:07:07.207791 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-20 01:07:07.207810 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-20 01:07:07.207829 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.207847 | instance | 2.17.12
2026-08-20 01:07:07.207866 | instance | Checked out community.crypto to 2.2.3
2026-08-20 01:07:07.207891 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 01:07:07.207912 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.207931 | instance | Process install dependency map
2026-08-20 01:07:07.207953 | instance | Starting collection install process
2026-08-20 01:07:07.207974 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-20 01:07:07.207997 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-20 01:07:07.208017 | instance | community.crypto:2.2.3 was installed successfully
2026-08-20 01:07:07.208041 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.208064 | instance | 2.17.12
2026-08-20 01:07:07.208083 | instance | Checked out community.general to 7.3.0
2026-08-20 01:07:07.208106 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 01:07:07.208125 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.208154 | instance | Process install dependency map
2026-08-20 01:07:07.208174 | instance | Starting collection install process
2026-08-20 01:07:07.208197 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-20 01:07:07.208218 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-20 01:07:07.208242 | instance | community.general:7.3.0 was installed successfully
2026-08-20 01:07:07.208266 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.208288 | instance | 2.17.12
2026-08-20 01:07:07.208312 | instance | Checked out community.mysql to 3.6.0
2026-08-20 01:07:07.208337 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 01:07:07.208357 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.208383 | instance | Process install dependency map
2026-08-20 01:07:07.208404 | instance | Starting collection install process
2026-08-20 01:07:07.208428 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-20 01:07:07.208448 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-20 01:07:07.208472 | instance | community.mysql:3.6.0 was installed successfully
2026-08-20 01:07:07.208496 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.208520 | instance | 2.17.12
2026-08-20 01:07:07.208540 | instance | Checked out kubernetes.core to 2.4.0
2026-08-20 01:07:07.208567 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 01:07:07.208588 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.208612 | instance | Process install dependency map
2026-08-20 01:07:07.208636 | instance | Starting collection install process
2026-08-20 01:07:07.208663 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-20 01:07:07.208686 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-20 01:07:07.208710 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-20 01:07:07.208731 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.208754 | instance | 2.17.12
2026-08-20 01:07:07.208778 | instance | Checked out openstack.cloud to 2.6.0
2026-08-20 01:07:07.208802 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 01:07:07.208826 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.208853 | instance | Process install dependency map
2026-08-20 01:07:07.208873 | instance | Starting collection install process
2026-08-20 01:07:07.208900 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-20 01:07:07.208920 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-20 01:07:07.208939 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-20 01:07:07.208967 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.208993 | instance | 2.17.12
2026-08-20 01:07:07.209119 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-20 01:07:07.209165 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 01:07:07.209214 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.209238 | instance | Process install dependency map
2026-08-20 01:07:07.209266 | instance | Starting collection install process
2026-08-20 01:07:07.209286 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-20 01:07:07.209314 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-20 01:07:07.209371 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-20 01:07:07.209396 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.209423 | instance | 2.17.12
2026-08-20 01:07:07.209453 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-20 01:07:07.209475 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 01:07:07.209505 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.209530 | instance | Process install dependency map
2026-08-20 01:07:07.209556 | instance | Starting collection install process
2026-08-20 01:07:07.209584 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-20 01:07:07.209608 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-20 01:07:07.209628 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-20 01:07:07.209656 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.209677 | instance | 2.17.12
2026-08-20 01:07:07.209696 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-20 01:07:07.209715 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 01:07:07.209735 | instance | Starting galaxy collection install process
2026-08-20 01:07:07.209753 | instance | Process install dependency map
2026-08-20 01:07:07.209773 | instance | Starting collection install process
2026-08-20 01:07:07.209792 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-20 01:07:07.209812 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-20 01:07:07.209841 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-20 01:07:07.209861 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 01:07:07.209884 | instance | 2.17.12
2026-08-20 01:07:07.215998 | 
2026-08-20 01:07:07.216076 | PLAY RECAP
2026-08-20 01:07:07.216150 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 01:07:07.216175 | 
2026-08-20 01:07:07.414171 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 01:07:07.416351 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 01:07:08.015418 | 
2026-08-20 01:07:08.015577 | PLAY [all]
2026-08-20 01:07:08.027200 | 
2026-08-20 01:07:08.027270 | TASK [Install "jq" for log collection]
2026-08-20 01:07:17.672735 | instance | changed
2026-08-20 01:07:17.675073 | 
2026-08-20 01:07:17.675134 | PLAY RECAP
2026-08-20 01:07:17.675186 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 01:07:17.675235 | 
2026-08-20 01:07:17.822308 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 01:07:17.827090 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 01:07:18.391808 | 
2026-08-20 01:07:18.391936 | PLAY [all]
2026-08-20 01:07:18.402528 | 
2026-08-20 01:07:18.402603 | LOOP [Check inventory directories]
2026-08-20 01:07:18.713221 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-20 01:07:18.854457 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-20 01:07:18.994780 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-20 01:07:19.016168 | 
2026-08-20 01:07:19.016258 | LOOP [Copy inventory file for Zuul]
2026-08-20 01:07:19.736049 | instance | changed:
2026-08-20 01:07:19.736271 | instance | {
2026-08-20 01:07:19.736314 | instance |   "ansible_loop_var": "item",
2026-08-20 01:07:19.736351 | instance |   "changed": false,
2026-08-20 01:07:19.736382 | instance |   "failed": false,
2026-08-20 01:07:19.736414 | instance |   "invocation": {
2026-08-20 01:07:19.736443 | instance |     "module_args": {
2026-08-20 01:07:19.736470 | instance |       "checksum_algorithm": "sha1",
2026-08-20 01:07:19.736497 | instance |       "follow": true,
2026-08-20 01:07:19.736526 | instance |       "get_attributes": true,
2026-08-20 01:07:19.736555 | instance |       "get_checksum": true,
2026-08-20 01:07:19.736582 | instance |       "get_mime": true,
2026-08-20 01:07:19.736608 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-20 01:07:19.736634 | instance |     }
2026-08-20 01:07:19.736660 | instance |   },
2026-08-20 01:07:19.736686 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-20 01:07:19.736712 | instance |   "stat": {
2026-08-20 01:07:19.736740 | instance |     "atime": 1787188020.6238306,
2026-08-20 01:07:19.736768 | instance |     "attr_flags": "e",
2026-08-20 01:07:19.736795 | instance |     "attributes": [
2026-08-20 01:07:19.736821 | instance |       "extents"
2026-08-20 01:07:19.736847 | instance |     ],
2026-08-20 01:07:19.736872 | instance |     "block_size": 4096,
2026-08-20 01:07:19.736899 | instance |     "blocks": 8,
2026-08-20 01:07:19.736925 | instance |     "charset": "unknown",
2026-08-20 01:07:19.736953 | instance |     "ctime": 1787188019.459829,
2026-08-20 01:07:19.737024 | instance |     "dev": 64513,
2026-08-20 01:07:19.737056 | instance |     "device_type": 0,
2026-08-20 01:07:19.737082 | instance |     "executable": true,
2026-08-20 01:07:19.737110 | instance |     "exists": true,
2026-08-20 01:07:19.737138 | instance |     "gid": 1000,
2026-08-20 01:07:19.737165 | instance |     "gr_name": "zuul",
2026-08-20 01:07:19.737192 | instance |     "inode": 1048897,
2026-08-20 01:07:19.737220 | instance |     "isblk": false,
2026-08-20 01:07:19.737247 | instance |     "ischr": false,
2026-08-20 01:07:19.737272 | instance |     "isdir": true,
2026-08-20 01:07:19.737298 | instance |     "isfifo": false,
2026-08-20 01:07:19.737323 | instance |     "isgid": false,
2026-08-20 01:07:19.737348 | instance |     "islnk": false,
2026-08-20 01:07:19.737374 | instance |     "isreg": false,
2026-08-20 01:07:19.737398 | instance |     "issock": false,
2026-08-20 01:07:19.737423 | instance |     "isuid": false,
2026-08-20 01:07:19.737448 | instance |     "mimetype": "unknown",
2026-08-20 01:07:19.737473 | instance |     "mode": "0755",
2026-08-20 01:07:19.737498 | instance |     "mtime": 1787188019.459829,
2026-08-20 01:07:19.737524 | instance |     "nlink": 21,
2026-08-20 01:07:19.737551 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-20 01:07:19.737577 | instance |     "pw_name": "zuul",
2026-08-20 01:07:19.737603 | instance |     "readable": true,
2026-08-20 01:07:19.737631 | instance |     "rgrp": true,
2026-08-20 01:07:19.737657 | instance |     "roth": true,
2026-08-20 01:07:19.737686 | instance |     "rusr": true,
2026-08-20 01:07:19.737712 | instance |     "size": 4096,
2026-08-20 01:07:19.737738 | instance |     "uid": 1000,
2026-08-20 01:07:19.737824 | instance |     "version": "2139536749",
2026-08-20 01:07:19.737853 | instance |     "wgrp": false,
2026-08-20 01:07:19.737883 | instance |     "woth": false,
2026-08-20 01:07:19.737910 | instance |     "writeable": true,
2026-08-20 01:07:19.737938 | instance |     "wusr": true,
2026-08-20 01:07:19.737964 | instance |     "xgrp": true,
2026-08-20 01:07:19.737989 | instance |     "xoth": true,
2026-08-20 01:07:19.738014 | instance |     "xusr": true
2026-08-20 01:07:19.738040 | instance |   }
2026-08-20 01:07:19.738068 | instance | }
2026-08-20 01:07:19.738115 | instance | ok: All items complete
2026-08-20 01:07:19.738146 | 
2026-08-20 01:07:19.739984 | instance | skipping: Conditional result was False
2026-08-20 01:07:19.740731 | instance | skipping: Conditional result was False
2026-08-20 01:07:19.754576 | 
2026-08-20 01:07:19.754665 | LOOP [Switch "ansible_host" to private IP]
2026-08-20 01:07:20.094994 | instance | changed: 1 replacements made
2026-08-20 01:07:20.096192 | instance | skipping: Conditional result was False
2026-08-20 01:07:20.096979 | instance | skipping: Conditional result was False
2026-08-20 01:07:20.115759 | 
2026-08-20 01:07:20.115823 | TASK [Run Molecule scenario]
2026-08-20 01:07:20.990340 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-20 01:07:21.352538 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-20 01:07:21.352620 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-20 01:07:31.762341 | instance | INFO     [csi > dependency] Executing
2026-08-20 01:07:31.762542 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-20 01:07:31.762729 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-20 01:07:31.762850 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-20 01:07:31.777346 | instance | INFO     [csi > cleanup] Executing
2026-08-20 01:07:31.778121 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 01:07:31.799492 | instance | INFO     [csi > destroy] Executing
2026-08-20 01:07:31.799587 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-20 01:07:31.799706 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-20 01:07:31.814711 | instance | INFO     [csi > syntax] Executing
2026-08-20 01:07:33.370829 | instance |
2026-08-20 01:07:33.371133 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 01:07:33.427458 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-20 01:07:33.440549 | instance | INFO     [csi > create] Executing
2026-08-20 01:07:33.443155 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 01:07:33.450679 | instance | INFO     [csi > prepare] Executing
2026-08-20 01:07:34.222511 | instance |
2026-08-20 01:07:34.222789 | instance | PLAY [Prepare] *****************************************************************
2026-08-20 01:07:34.223044 | instance |
2026-08-20 01:07:34.223325 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 01:07:34.223604 | instance | Thursday 20 August 2026  01:07:34 +0000 (0:00:00.027)       0:00:00.027 *******
2026-08-20 01:07:35.395729 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 01:07:35.395993 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 01:07:35.396344 | instance | interpreter could change the meaning of that path. See
2026-08-20 01:07:35.396528 | instance | https://docs.ansible.com/ansible-
2026-08-20 01:07:35.396789 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 01:07:35.407645 | instance | ok: [instance]
2026-08-20 01:07:35.407918 | instance |
2026-08-20 01:07:35.408262 | instance | TASK [Configure short hostname] ************************************************
2026-08-20 01:07:35.408526 | instance | Thursday 20 August 2026  01:07:35 +0000 (0:00:01.185)       0:00:01.212 *******
2026-08-20 01:07:36.055571 | instance | changed: [instance]
2026-08-20 01:07:36.055930 | instance |
2026-08-20 01:07:36.056248 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-20 01:07:36.056582 | instance | Thursday 20 August 2026  01:07:36 +0000 (0:00:00.647)       0:00:01.860 *******
2026-08-20 01:07:36.302118 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-20 01:07:36.302187 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-20 01:07:36.302206 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-20 01:07:36.309748 | instance | changed: [instance]
2026-08-20 01:07:36.309927 | instance |
2026-08-20 01:07:36.310138 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-20 01:07:36.310345 | instance | Thursday 20 August 2026  01:07:36 +0000 (0:00:00.254)       0:00:02.115 *******
2026-08-20 01:07:37.069615 | instance | ok: [instance]
2026-08-20 01:07:37.069886 | instance |
2026-08-20 01:07:37.070167 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-20 01:07:37.070407 | instance |
2026-08-20 01:07:37.070669 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 01:07:37.070934 | instance | Thursday 20 August 2026  01:07:37 +0000 (0:00:00.759)       0:00:02.875 *******
2026-08-20 01:07:37.760723 | instance | ok: [instance]
2026-08-20 01:07:37.760976 | instance |
2026-08-20 01:07:37.761275 | instance | TASK [Install depedencies] *****************************************************
2026-08-20 01:07:37.761563 | instance | Thursday 20 August 2026  01:07:37 +0000 (0:00:00.690)       0:00:03.565 *******
2026-08-20 01:07:57.255055 | instance | changed: [instance]
2026-08-20 01:07:57.255243 | instance |
2026-08-20 01:07:57.255339 | instance | TASK [Start up service] ********************************************************
2026-08-20 01:07:57.255511 | instance | Thursday 20 August 2026  01:07:57 +0000 (0:00:19.494)       0:00:23.060 *******
2026-08-20 01:07:57.832355 | instance | ok: [instance]
2026-08-20 01:07:57.832424 | instance |
2026-08-20 01:07:57.832649 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-20 01:07:57.832761 | instance | Thursday 20 August 2026  01:07:57 +0000 (0:00:00.577)       0:00:23.637 *******
2026-08-20 01:07:58.110919 | instance | ok: [instance]
2026-08-20 01:07:58.110998 | instance |
2026-08-20 01:07:58.111113 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-20 01:07:58.111239 | instance | Thursday 20 August 2026  01:07:58 +0000 (0:00:00.278)       0:00:23.916 *******
2026-08-20 01:07:58.799951 | instance | changed: [instance]
2026-08-20 01:07:58.800023 | instance |
2026-08-20 01:07:58.800036 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-20 01:07:58.800054 | instance | Thursday 20 August 2026  01:07:58 +0000 (0:00:00.687)       0:00:24.604 *******
2026-08-20 01:07:58.989224 | instance | ok: [instance]
2026-08-20 01:07:58.989520 | instance |
2026-08-20 01:07:58.989751 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-20 01:07:58.990004 | instance | Thursday 20 August 2026  01:07:58 +0000 (0:00:00.189)       0:00:24.794 *******
2026-08-20 01:07:59.017327 | instance | skipping: [instance]
2026-08-20 01:07:59.017351 | instance |
2026-08-20 01:07:59.017358 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-20 01:07:59.017364 | instance | Thursday 20 August 2026  01:07:59 +0000 (0:00:00.028)       0:00:24.822 *******
2026-08-20 01:07:59.597899 | instance | changed: [instance] => (item=osd0)
2026-08-20 01:07:59.598857 | instance | changed: [instance] => (item=osd1)
2026-08-20 01:07:59.598905 | instance | changed: [instance] => (item=osd2)
2026-08-20 01:07:59.598913 | instance |
2026-08-20 01:07:59.598920 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-20 01:07:59.598927 | instance | Thursday 20 August 2026  01:07:59 +0000 (0:00:00.580)       0:00:25.403 *******
2026-08-20 01:08:00.181972 | instance | changed: [instance] => (item=osd0)
2026-08-20 01:08:00.182913 | instance | changed: [instance] => (item=osd1)
2026-08-20 01:08:00.182966 | instance | changed: [instance] => (item=osd2)
2026-08-20 01:08:00.182975 | instance |
2026-08-20 01:08:00.182995 | instance | TASK [Start loop devices] ******************************************************
2026-08-20 01:08:00.183003 | instance | Thursday 20 August 2026  01:08:00 +0000 (0:00:00.583)       0:00:25.987 *******
2026-08-20 01:08:00.896164 | instance | changed: [instance] => (item=osd0)
2026-08-20 01:08:00.896261 | instance | changed: [instance] => (item=osd1)
2026-08-20 01:08:00.896753 | instance | changed: [instance] => (item=osd2)
2026-08-20 01:08:00.896810 | instance |
2026-08-20 01:08:00.896816 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-20 01:08:00.896822 | instance | Thursday 20 August 2026  01:08:00 +0000 (0:00:00.714)       0:00:26.701 *******
2026-08-20 01:08:04.051162 | instance | changed: [instance] => (item=osd0)
2026-08-20 01:08:04.051917 | instance | changed: [instance] => (item=osd1)
2026-08-20 01:08:04.051976 | instance | changed: [instance] => (item=osd2)
2026-08-20 01:08:04.051983 | instance |
2026-08-20 01:08:04.051989 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-20 01:08:04.052025 | instance | Thursday 20 August 2026  01:08:04 +0000 (0:00:03.154)       0:00:29.856 *******
2026-08-20 01:08:05.999994 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-20 01:08:06.000064 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-20 01:08:06.000405 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-20 01:08:06.000464 | instance |
2026-08-20 01:08:06.002177 | instance | PLAY RECAP *********************************************************************
2026-08-20 01:08:06.002234 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-20 01:08:06.002242 | instance |
2026-08-20 01:08:06.002249 | instance | Thursday 20 August 2026  01:08:05 +0000 (0:00:01.949)       0:00:31.805 *******
2026-08-20 01:08:06.002256 | instance | ===============================================================================
2026-08-20 01:08:06.002261 | instance | Install depedencies ---------------------------------------------------- 19.49s
2026-08-20 01:08:06.002267 | instance | Create a volume group for each loop device ------------------------------ 3.15s
2026-08-20 01:08:06.002273 | instance | Create a logical volume for each loop device ---------------------------- 1.95s
2026-08-20 01:08:06.002280 | instance | Gathering Facts --------------------------------------------------------- 1.19s
2026-08-20 01:08:06.002291 | instance | Purge "snapd" package --------------------------------------------------- 0.76s
2026-08-20 01:08:06.004399 | instance | Start loop devices ------------------------------------------------------ 0.71s
2026-08-20 01:08:06.004456 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-20 01:08:06.004464 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.69s
2026-08-20 01:08:06.004470 | instance | Configure short hostname ------------------------------------------------ 0.65s
2026-08-20 01:08:06.004477 | instance | Set permissions on loopback devices ------------------------------------- 0.58s
2026-08-20 01:08:06.004483 | instance | Create devices for Ceph ------------------------------------------------- 0.58s
2026-08-20 01:08:06.004489 | instance | Start up service -------------------------------------------------------- 0.58s
2026-08-20 01:08:06.004495 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s
2026-08-20 01:08:06.004502 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s
2026-08-20 01:08:06.004508 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-20 01:08:06.004514 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-20 01:08:06.144309 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-20 01:08:06.157334 | instance | INFO     [csi > converge] Executing
2026-08-20 01:08:07.594610 | instance |
2026-08-20 01:08:07.595004 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-20 01:08:07.595324 | instance |
2026-08-20 01:08:07.595648 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 01:08:07.596031 | instance | Thursday 20 August 2026  01:08:07 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-20 01:08:08.610372 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 01:08:08.610818 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 01:08:08.611280 | instance | interpreter could change the meaning of that path. See
2026-08-20 01:08:08.611727 | instance | https://docs.ansible.com/ansible-
2026-08-20 01:08:08.612176 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 01:08:08.620844 | instance | ok: [instance]
2026-08-20 01:08:08.621167 | instance |
2026-08-20 01:08:08.621503 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-20 01:08:08.621865 | instance | Thursday 20 August 2026  01:08:08 +0000 (0:00:01.026)       0:00:01.034 *******
2026-08-20 01:08:08.669821 | instance | ok: [instance] => {
2026-08-20 01:08:08.670245 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-20 01:08:08.670590 | instance | }
2026-08-20 01:08:08.670918 | instance |
2026-08-20 01:08:08.671259 | instance | PLAY [all] *********************************************************************
2026-08-20 01:08:08.671586 | instance |
2026-08-20 01:08:08.671970 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 01:08:08.672352 | instance | Thursday 20 August 2026  01:08:08 +0000 (0:00:00.049)       0:00:01.083 *******
2026-08-20 01:08:09.566968 | instance | ok: [instance]
2026-08-20 01:08:09.567467 | instance |
2026-08-20 01:08:09.567979 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-20 01:08:09.568410 | instance | Thursday 20 August 2026  01:08:09 +0000 (0:00:00.896)       0:00:01.979 *******
2026-08-20 01:08:09.742082 | instance | ok: [instance]
2026-08-20 01:08:09.742490 | instance |
2026-08-20 01:08:09.742859 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-20 01:08:09.743196 | instance |
2026-08-20 01:08:09.743651 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 01:08:09.744061 | instance | Thursday 20 August 2026  01:08:09 +0000 (0:00:00.175)       0:00:02.155 *******
2026-08-20 01:08:10.624736 | instance | ok: [instance]
2026-08-20 01:08:10.625187 | instance |
2026-08-20 01:08:10.625552 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 01:08:10.625920 | instance | Thursday 20 August 2026  01:08:10 +0000 (0:00:00.882)       0:00:03.037 *******
2026-08-20 01:08:10.918606 | instance | ok: [instance]
2026-08-20 01:08:10.918900 | instance |
2026-08-20 01:08:10.919134 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 01:08:10.919349 | instance | Thursday 20 August 2026  01:08:10 +0000 (0:00:00.294)       0:00:03.331 *******
2026-08-20 01:08:10.969068 | instance | skipping: [instance]
2026-08-20 01:08:10.969472 | instance |
2026-08-20 01:08:10.969863 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-20 01:08:10.970218 | instance | Thursday 20 August 2026  01:08:10 +0000 (0:00:00.049)       0:00:03.381 *******
2026-08-20 01:08:11.304743 | instance | changed: [instance]
2026-08-20 01:08:11.305143 | instance |
2026-08-20 01:08:11.305491 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 01:08:11.305832 | instance | Thursday 20 August 2026  01:08:11 +0000 (0:00:00.332)       0:00:03.714 *******
2026-08-20 01:08:11.376737 | instance | ok: [instance] => {
2026-08-20 01:08:11.376949 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-20 01:08:11.377229 | instance | }
2026-08-20 01:08:11.377467 | instance |
2026-08-20 01:08:11.377680 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 01:08:11.377839 | instance | Thursday 20 August 2026  01:08:11 +0000 (0:00:00.073)       0:00:03.787 *******
2026-08-20 01:08:11.992912 | instance | changed: [instance]
2026-08-20 01:08:11.993440 | instance |
2026-08-20 01:08:11.994005 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 01:08:11.994480 | instance | Thursday 20 August 2026  01:08:11 +0000 (0:00:00.614)       0:00:04.402 *******
2026-08-20 01:08:12.045097 | instance | skipping: [instance]
2026-08-20 01:08:12.045681 | instance |
2026-08-20 01:08:12.046057 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 01:08:12.046416 | instance | Thursday 20 August 2026  01:08:12 +0000 (0:00:00.054)       0:00:04.456 *******
2026-08-20 01:08:12.096587 | instance | skipping: [instance]
2026-08-20 01:08:12.096711 | instance |
2026-08-20 01:08:12.096924 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 01:08:12.097081 | instance | Thursday 20 August 2026  01:08:12 +0000 (0:00:00.050)       0:00:04.507 *******
2026-08-20 01:08:12.308608 | instance | ok: [instance]
2026-08-20 01:08:12.308685 | instance |
2026-08-20 01:08:12.308833 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 01:08:12.309042 | instance | Thursday 20 August 2026  01:08:12 +0000 (0:00:00.214)       0:00:04.721 *******
2026-08-20 01:08:13.901095 | instance | ok: [instance]
2026-08-20 01:08:13.901169 | instance |
2026-08-20 01:08:13.901296 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 01:08:13.901500 | instance | Thursday 20 August 2026  01:08:13 +0000 (0:00:01.591)       0:00:06.313 *******
2026-08-20 01:08:13.972991 | instance | ok: [instance] => {
2026-08-20 01:08:13.973541 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-20 01:08:13.973829 | instance | }
2026-08-20 01:08:13.974039 | instance |
2026-08-20 01:08:13.974305 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 01:08:13.974534 | instance | Thursday 20 August 2026  01:08:13 +0000 (0:00:00.071)       0:00:06.384 *******
2026-08-20 01:08:14.623462 | instance | changed: [instance]
2026-08-20 01:08:14.623516 | instance |
2026-08-20 01:08:14.623522 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 01:08:14.623527 | instance | Thursday 20 August 2026  01:08:14 +0000 (0:00:00.651)       0:00:07.036 *******
2026-08-20 01:08:18.437846 | instance | changed: [instance]
2026-08-20 01:08:18.437992 | instance |
2026-08-20 01:08:18.438267 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-20 01:08:18.438324 | instance | Thursday 20 August 2026  01:08:18 +0000 (0:00:03.814)       0:00:10.851 *******
2026-08-20 01:08:18.477715 | instance | skipping: [instance]
2026-08-20 01:08:18.478125 | instance |
2026-08-20 01:08:18.478173 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-20 01:08:18.478180 | instance | Thursday 20 August 2026  01:08:18 +0000 (0:00:00.039)       0:00:10.890 *******
2026-08-20 01:08:18.511867 | instance | skipping: [instance]
2026-08-20 01:08:18.513788 | instance |
2026-08-20 01:08:18.513871 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-20 01:08:18.513884 | instance | Thursday 20 August 2026  01:08:18 +0000 (0:00:00.033)       0:00:10.924 *******
2026-08-20 01:08:18.549631 | instance | skipping: [instance]
2026-08-20 01:08:18.549832 | instance |
2026-08-20 01:08:18.550478 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-20 01:08:18.550495 | instance | Thursday 20 August 2026  01:08:18 +0000 (0:00:00.037)       0:00:10.962 *******
2026-08-20 01:08:23.768914 | instance | changed: [instance]
2026-08-20 01:08:23.769031 | instance |
2026-08-20 01:08:23.769090 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-20 01:08:23.769234 | instance | Thursday 20 August 2026  01:08:23 +0000 (0:00:05.219)       0:00:16.182 *******
2026-08-20 01:08:24.345767 | instance | changed: [instance]
2026-08-20 01:08:24.345853 | instance |
2026-08-20 01:08:24.346134 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-20 01:08:24.346174 | instance | Thursday 20 August 2026  01:08:24 +0000 (0:00:00.576)       0:00:16.759 *******
2026-08-20 01:08:25.237644 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-20 01:08:25.237716 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-20 01:08:25.238479 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-20 01:08:25.238520 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-20 01:08:25.238526 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-20 01:08:25.238531 | instance |
2026-08-20 01:08:25.238539 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-20 01:08:25.238544 | instance | Thursday 20 August 2026  01:08:25 +0000 (0:00:00.891)       0:00:17.651 *******
2026-08-20 01:08:25.827657 | instance | changed: [instance]
2026-08-20 01:08:25.827717 | instance |
2026-08-20 01:08:25.827907 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-20 01:08:25.828368 | instance | Thursday 20 August 2026  01:08:25 +0000 (0:00:00.572)       0:00:18.223 *******
2026-08-20 01:08:25.828408 | instance |
2026-08-20 01:08:25.828414 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 01:08:25.828419 | instance | Thursday 20 August 2026  01:08:25 +0000 (0:00:00.017)       0:00:18.241 *******
2026-08-20 01:08:26.702127 | instance | ok: [instance]
2026-08-20 01:08:26.702250 | instance |
2026-08-20 01:08:26.702628 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-20 01:08:26.702670 | instance | Thursday 20 August 2026  01:08:26 +0000 (0:00:00.874)       0:00:19.115 *******
2026-08-20 01:08:27.100107 | instance | changed: [instance]
2026-08-20 01:08:27.100219 | instance |
2026-08-20 01:08:27.100449 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-20 01:08:27.100482 | instance | Thursday 20 August 2026  01:08:27 +0000 (0:00:00.398)       0:00:19.513 *******
2026-08-20 01:08:27.629456 | instance | changed: [instance]
2026-08-20 01:08:27.629516 | instance |
2026-08-20 01:08:27.629800 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 01:08:27.629840 | instance | Thursday 20 August 2026  01:08:27 +0000 (0:00:00.529)       0:00:20.043 *******
2026-08-20 01:08:27.832799 | instance | ok: [instance]
2026-08-20 01:08:27.832864 | instance |
2026-08-20 01:08:27.833157 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 01:08:27.833200 | instance | Thursday 20 August 2026  01:08:27 +0000 (0:00:00.203)       0:00:20.246 *******
2026-08-20 01:08:27.894182 | instance | ok: [instance] => {
2026-08-20 01:08:27.894797 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-20 01:08:27.894841 | instance | }
2026-08-20 01:08:27.894847 | instance |
2026-08-20 01:08:27.894851 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 01:08:27.894856 | instance | Thursday 20 August 2026  01:08:27 +0000 (0:00:00.061)       0:00:20.307 *******
2026-08-20 01:08:28.655595 | instance | changed: [instance]
2026-08-20 01:08:28.655652 | instance |
2026-08-20 01:08:28.655917 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 01:08:28.655933 | instance | Thursday 20 August 2026  01:08:28 +0000 (0:00:00.761)       0:00:21.069 *******
2026-08-20 01:08:32.971131 | instance | changed: [instance]
2026-08-20 01:08:32.971210 | instance |
2026-08-20 01:08:32.971455 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-20 01:08:32.971602 | instance | Thursday 20 August 2026  01:08:32 +0000 (0:00:04.315)       0:00:25.384 *******
2026-08-20 01:08:33.960215 | instance | ok: [instance]
2026-08-20 01:08:33.960293 | instance |
2026-08-20 01:08:33.960533 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-20 01:08:33.960578 | instance | Thursday 20 August 2026  01:08:33 +0000 (0:00:00.989)       0:00:26.373 *******
2026-08-20 01:08:34.291371 | instance | changed: [instance]
2026-08-20 01:08:34.291443 | instance |
2026-08-20 01:08:34.291780 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-20 01:08:34.291878 | instance | Thursday 20 August 2026  01:08:34 +0000 (0:00:00.330)       0:00:26.704 *******
2026-08-20 01:08:34.741522 | instance | changed: [instance]
2026-08-20 01:08:34.741593 | instance |
2026-08-20 01:08:34.741865 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-20 01:08:34.741895 | instance | Thursday 20 August 2026  01:08:34 +0000 (0:00:00.450)       0:00:27.155 *******
2026-08-20 01:08:35.287078 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-20 01:08:35.287896 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-20 01:08:35.287945 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-20 01:08:35.287952 | instance |
2026-08-20 01:08:35.287958 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-20 01:08:35.287968 | instance | Thursday 20 August 2026  01:08:35 +0000 (0:00:00.545)       0:00:27.700 *******
2026-08-20 01:08:35.719090 | instance | changed: [instance]
2026-08-20 01:08:35.719133 | instance |
2026-08-20 01:08:35.719141 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-20 01:08:35.719147 | instance | Thursday 20 August 2026  01:08:35 +0000 (0:00:00.431)       0:00:28.131 *******
2026-08-20 01:08:36.156151 | instance | changed: [instance]
2026-08-20 01:08:36.156217 | instance |
2026-08-20 01:08:36.156228 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-20 01:08:36.156238 | instance | Thursday 20 August 2026  01:08:36 +0000 (0:00:00.420)       0:00:28.552 *******
2026-08-20 01:08:36.156247 | instance |
2026-08-20 01:08:36.156256 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 01:08:36.156265 | instance | Thursday 20 August 2026  01:08:36 +0000 (0:00:00.016)       0:00:28.569 *******
2026-08-20 01:08:36.813344 | instance | ok: [instance]
2026-08-20 01:08:36.813863 | instance |
2026-08-20 01:08:36.814058 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-20 01:08:36.814076 | instance | Thursday 20 August 2026  01:08:36 +0000 (0:00:00.657)       0:00:29.226 *******
2026-08-20 01:08:37.952480 | instance | changed: [instance]
2026-08-20 01:08:37.952583 | instance |
2026-08-20 01:08:37.952828 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-20 01:08:37.952843 | instance | Thursday 20 August 2026  01:08:37 +0000 (0:00:01.139)       0:00:30.365 *******
2026-08-20 01:08:38.501683 | instance | changed: [instance]
2026-08-20 01:08:38.501757 | instance |
2026-08-20 01:08:38.502032 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-20 01:08:38.502066 | instance | Thursday 20 August 2026  01:08:38 +0000 (0:00:00.549)       0:00:30.915 *******
2026-08-20 01:08:38.550590 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-20 01:08:38.550666 | instance |
2026-08-20 01:08:38.550943 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-20 01:08:38.550981 | instance | Thursday 20 August 2026  01:08:38 +0000 (0:00:00.048)       0:00:30.964 *******
2026-08-20 01:08:43.520429 | instance | changed: [instance]
2026-08-20 01:08:43.520472 | instance |
2026-08-20 01:08:43.520477 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-20 01:08:43.520482 | instance | Thursday 20 August 2026  01:08:43 +0000 (0:00:04.969)       0:00:35.933 *******
2026-08-20 01:08:44.157900 | instance | ok: [instance] => (item=chronyd)
2026-08-20 01:08:44.158386 | instance | ok: [instance] => (item=sshd)
2026-08-20 01:08:44.158424 | instance |
2026-08-20 01:08:44.158429 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-20 01:08:44.158434 | instance | Thursday 20 August 2026  01:08:44 +0000 (0:00:00.637)       0:00:36.571 *******
2026-08-20 01:08:45.804798 | instance | changed: [instance]
2026-08-20 01:08:45.804832 | instance |
2026-08-20 01:08:45.804837 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-20 01:08:45.804842 | instance | Thursday 20 August 2026  01:08:45 +0000 (0:00:01.646)       0:00:38.217 *******
2026-08-20 01:08:46.014306 | instance | ok: [instance]
2026-08-20 01:08:46.014348 | instance |
2026-08-20 01:08:46.014356 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-20 01:08:46.014363 | instance | Thursday 20 August 2026  01:08:46 +0000 (0:00:00.209)       0:00:38.427 *******
2026-08-20 01:08:46.433914 | instance | changed: [instance]
2026-08-20 01:08:46.433980 | instance |
2026-08-20 01:08:46.434271 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-20 01:08:46.434319 | instance | Thursday 20 August 2026  01:08:46 +0000 (0:00:00.420)       0:00:38.847 *******
2026-08-20 01:08:46.831909 | instance | changed: [instance]
2026-08-20 01:08:46.832336 | instance |
2026-08-20 01:08:46.832407 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-20 01:08:46.832414 | instance | Thursday 20 August 2026  01:08:46 +0000 (0:00:00.397)       0:00:39.244 *******
2026-08-20 01:08:46.946221 | instance | ok: [instance]
2026-08-20 01:08:46.946652 | instance |
2026-08-20 01:08:46.946768 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-20 01:08:46.946775 | instance | Thursday 20 August 2026  01:08:46 +0000 (0:00:00.114)       0:00:39.359 *******
2026-08-20 01:08:47.179702 | instance | ok: [instance] => (item=instance)
2026-08-20 01:08:47.179872 | instance |
2026-08-20 01:08:47.179887 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-20 01:08:47.180015 | instance | Thursday 20 August 2026  01:08:47 +0000 (0:00:00.233)       0:00:39.592 *******
2026-08-20 01:08:47.236688 | instance | ok: [instance]
2026-08-20 01:08:47.237103 | instance |
2026-08-20 01:08:47.237150 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-20 01:08:47.237156 | instance | Thursday 20 August 2026  01:08:47 +0000 (0:00:00.057)       0:00:39.649 *******
2026-08-20 01:08:47.320310 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-20 01:08:47.320539 | instance |
2026-08-20 01:08:47.320821 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-20 01:08:47.321091 | instance | Thursday 20 August 2026  01:08:47 +0000 (0:00:00.083)       0:00:39.733 *******
2026-08-20 01:08:47.630057 | instance | changed: [instance]
2026-08-20 01:08:47.630237 | instance |
2026-08-20 01:08:47.630502 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-20 01:08:47.630765 | instance | Thursday 20 August 2026  01:08:47 +0000 (0:00:00.309)       0:00:40.043 *******
2026-08-20 01:08:48.316544 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-20 01:08:48.316797 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-20 01:08:48.317071 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-20 01:08:48.317335 | instance |
2026-08-20 01:08:48.317599 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-20 01:08:48.317861 | instance | Thursday 20 August 2026  01:08:48 +0000 (0:00:00.686)       0:00:40.729 *******
2026-08-20 01:10:19.717547 | instance | ok: [instance]
2026-08-20 01:10:19.717618 | instance |
2026-08-20 01:10:19.717638 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-20 01:10:19.717849 | instance | Thursday 20 August 2026  01:10:19 +0000 (0:01:31.400)       0:02:12.129 *******
2026-08-20 01:10:19.944279 | instance | changed: [instance]
2026-08-20 01:10:19.944348 | instance |
2026-08-20 01:10:19.944643 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-20 01:10:19.944910 | instance | Thursday 20 August 2026  01:10:19 +0000 (0:00:00.227)       0:02:12.357 *******
2026-08-20 01:10:20.030861 | instance | ok: [instance]
2026-08-20 01:10:20.030929 | instance |
2026-08-20 01:10:20.031058 | instance | TASK [Install Ceph host] *******************************************************
2026-08-20 01:10:20.031178 | instance | Thursday 20 August 2026  01:10:20 +0000 (0:00:00.086)       0:02:12.444 *******
2026-08-20 01:10:20.112883 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-20 01:10:20.112923 | instance |
2026-08-20 01:10:20.113062 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-20 01:10:20.113176 | instance | Thursday 20 August 2026  01:10:20 +0000 (0:00:00.081)       0:02:12.526 *******
2026-08-20 01:10:21.685897 | instance | ok: [instance]
2026-08-20 01:10:21.686136 | instance |
2026-08-20 01:10:21.686438 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-20 01:10:21.686716 | instance | Thursday 20 August 2026  01:10:21 +0000 (0:00:01.573)       0:02:14.099 *******
2026-08-20 01:10:21.732504 | instance | ok: [instance] => (item=instance)
2026-08-20 01:10:21.732795 | instance |
2026-08-20 01:10:21.733072 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-20 01:10:21.733339 | instance | Thursday 20 August 2026  01:10:21 +0000 (0:00:00.046)       0:02:14.146 *******
2026-08-20 01:10:22.067555 | instance | ok: [instance]
2026-08-20 01:10:22.067683 | instance |
2026-08-20 01:10:22.067871 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-20 01:10:22.068036 | instance | Thursday 20 August 2026  01:10:22 +0000 (0:00:00.334)       0:02:14.481 *******
2026-08-20 01:10:24.311918 | instance | ok: [instance]
2026-08-20 01:10:24.311971 | instance |
2026-08-20 01:10:24.311982 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-20 01:10:24.311997 | instance | Thursday 20 August 2026  01:10:24 +0000 (0:00:02.243)       0:02:16.724 *******
2026-08-20 01:11:07.648756 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-20 01:11:07.649783 | 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_xfbsd1q4/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_xfbsd1q4/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_xfbsd1q4/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_xfbsd1q4/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDTU4ZqCPzLDCAA8j6hjJy+3xo88qzlM59LIyGoH+plMaosHBniUM9prWk=: Malformed input [buffer:3]\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDTU4ZqCPzLDCAA8j6hjJy+3xo88qzlM59LIyGoH+plMaosHBniUM9prWk=: Malformed input [buffer:3]\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDTU4ZqCPzLDCAA8j6hjJy+3xo88qzlM59LIyGoH+plMaosHBniUM9prWk=: Malformed input [buffer:3]\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T01:11:07.492+0000 7f662a1f2640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-20 01:11:07.655978 | instance |
2026-08-20 01:11:07.656041 | instance | PLAY RECAP *********************************************************************
2026-08-20 01:11:07.656049 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-20 01:11:07.656056 | instance |
2026-08-20 01:11:07.656061 | instance | Thursday 20 August 2026  01:11:07 +0000 (0:00:43.341)       0:03:00.066 *******
2026-08-20 01:11:07.656067 | instance | ===============================================================================
2026-08-20 01:11:07.656073 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 91.40s
2026-08-20 01:11:07.656079 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.34s
2026-08-20 01:11:07.656085 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.22s
2026-08-20 01:11:07.656090 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.97s
2026-08-20 01:11:07.656096 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.32s
2026-08-20 01:11:07.656101 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.81s
2026-08-20 01:11:07.656107 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.24s
2026-08-20 01:11:07.656113 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.65s
2026-08-20 01:11:07.656135 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.59s
2026-08-20 01:11:07.656141 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.57s
2026-08-20 01:11:07.656147 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.53s
2026-08-20 01:11:07.656153 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.14s
2026-08-20 01:11:07.656158 | instance | Gathering Facts --------------------------------------------------------- 1.03s
2026-08-20 01:11:07.656164 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.99s
2026-08-20 01:11:07.656169 | instance | Gathering Facts --------------------------------------------------------- 0.90s
2026-08-20 01:11:07.656174 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.89s
2026-08-20 01:11:07.656187 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-20 01:11:07.656193 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-20 01:11:07.656556 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.69s
2026-08-20 01:11:07.656579 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.65s
2026-08-20 01:11:07.830490 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 01:11:07.830799 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-20 01:11:07.830992 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 01:11:07.930807 | instance | ERROR
2026-08-20 01:11:07.930982 | instance | {
2026-08-20 01:11:07.931023 | instance |   "delta": "0:03:47.437041",
2026-08-20 01:11:07.931046 | instance |   "end": "2026-08-20 01:11:07.880116",
2026-08-20 01:11:07.931064 | instance |   "msg": "non-zero return code",
2026-08-20 01:11:07.931082 | instance |   "rc": 2,
2026-08-20 01:11:07.931100 | instance |   "start": "2026-08-20 01:07:20.443075"
2026-08-20 01:11:07.931118 | instance | }
failure
2026-08-20 01:11:07.935806 | 
2026-08-20 01:11:07.935854 | PLAY RECAP
2026-08-20 01:11:07.935898 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-20 01:11:07.935921 | 
2026-08-20 01:11:08.094904 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 01:11:08.099196 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 01:11:08.690153 | 
2026-08-20 01:11:08.690269 | PLAY [all]
2026-08-20 01:11:08.704211 | 
2026-08-20 01:11:08.704288 | TASK [gather-host-logs : creating directory for system status]
2026-08-20 01:11:09.042633 | instance | changed
2026-08-20 01:11:09.050947 | 
2026-08-20 01:11:09.051036 | TASK [gather-host-logs : Get logs for each host]
2026-08-20 01:11:09.399739 | instance | + systemd-cgls --full --all --no-pager
2026-08-20 01:11:09.415584 | instance | + ip addr
2026-08-20 01:11:09.417076 | instance | + ip route
2026-08-20 01:11:09.418050 | instance | + lsblk
2026-08-20 01:11:09.422702 | instance | + mount
2026-08-20 01:11:09.425106 | instance | + docker images
2026-08-20 01:11:09.447986 | instance | + brctl show
2026-08-20 01:11:09.448536 | instance | /bin/bash: line 8: brctl: command not found
2026-08-20 01:11:09.448811 | instance | + ps aux --sort=-%mem
2026-08-20 01:11:09.471519 | instance | + dpkg -l
2026-08-20 01:11:09.481486 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-20 01:11:09.482014 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-20 01:11:09.500276 | instance | + '[' '!' -z '' ']'
2026-08-20 01:11:09.588660 | instance | ok: Runtime: 0:00:00.105388
2026-08-20 01:11:09.596583 | 
2026-08-20 01:11:09.596671 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-20 01:11:10.269636 | instance | changed:
2026-08-20 01:11:10.269894 | instance | created directory /var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/logs/instance
2026-08-20 01:11:10.269937 | instance | cd+++++++++ system/
2026-08-20 01:11:10.269972 | instance | >f+++++++++ system/brctl-show.txt
2026-08-20 01:11:10.270004 | instance | >f+++++++++ system/docker-images.txt
2026-08-20 01:11:10.270034 | instance | >f+++++++++ system/ip-addr.txt
2026-08-20 01:11:10.270070 | instance | >f+++++++++ system/ip-route.txt
2026-08-20 01:11:10.270126 | instance | >f+++++++++ system/lsblk.txt
2026-08-20 01:11:10.270159 | instance | >f+++++++++ system/mount.txt
2026-08-20 01:11:10.270189 | instance | >f+++++++++ system/packages.txt
2026-08-20 01:11:10.270218 | instance | >f+++++++++ system/ps.txt
2026-08-20 01:11:10.270251 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-20 01:11:10.283660 | 
2026-08-20 01:11:10.283805 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-20 01:11:10.498883 | instance | changed: "values"
2026-08-20 01:11:10.692061 | instance | changed: "releases"
2026-08-20 01:11:10.711227 | 
2026-08-20 01:11:10.711439 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-20 01:11:10.931951 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-20 01:11:11.249710 | instance | ok: Runtime: 0:00:00.007425
2026-08-20 01:11:11.257072 | 
2026-08-20 01:11:11.257219 | TASK [helm-release-status : Downloads logs to executor]
2026-08-20 01:11:11.737978 | instance | changed:
2026-08-20 01:11:11.738231 | instance | cd+++++++++ helm/
2026-08-20 01:11:11.738273 | instance | cd+++++++++ helm/releases/
2026-08-20 01:11:11.738305 | instance | cd+++++++++ helm/values/
2026-08-20 01:11:11.749612 | 
2026-08-20 01:11:11.749768 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-20 01:11:11.944841 | instance | changed
2026-08-20 01:11:11.951857 | 
2026-08-20 01:11:11.951960 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-20 01:11:12.196885 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 01:11:12.197063 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 01:11:12.202751 | instance | environment: line 1: kubectl: command not found
2026-08-20 01:11:12.204019 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 01:11:12.205174 | instance | environment: line 1: kubectl: command not found
2026-08-20 01:11:12.206591 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 01:11:12.207426 | instance | environment: line 1: kubectl: command not found
2026-08-20 01:11:12.208918 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 01:11:12.210738 | instance | environment: line 1: kubectl: command not found
2026-08-20 01:11:12.211952 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 01:11:12.212405 | instance | environment: line 1: kubectl: command not found
2026-08-20 01:11:12.213245 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 01:11:12.491485 | instance | ok: Runtime: 0:00:00.025977
2026-08-20 01:11:12.497381 | 
2026-08-20 01:11:12.497450 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-20 01:11:12.695399 | instance | changed
2026-08-20 01:11:12.700897 | 
2026-08-20 01:11:12.700982 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-20 01:11:12.904643 | instance | environment: line 5: kubectl: command not found
2026-08-20 01:11:12.905280 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 01:11:12.905466 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 01:11:12.906333 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 01:11:13.239189 | instance | ok: Runtime: 0:00:00.007946
2026-08-20 01:11:13.245427 | 
2026-08-20 01:11:13.245501 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-20 01:11:13.727249 | instance | changed:
2026-08-20 01:11:13.727534 | instance | cd+++++++++ objects/
2026-08-20 01:11:13.727597 | instance | cd+++++++++ objects/cluster/
2026-08-20 01:11:13.727649 | instance | cd+++++++++ objects/namespaced/
2026-08-20 01:11:13.736591 | 
2026-08-20 01:11:13.736659 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-20 01:11:13.931034 | instance | changed
2026-08-20 01:11:13.937230 | 
2026-08-20 01:11:13.937337 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-20 01:11:14.135866 | instance | changed
2026-08-20 01:11:14.143597 | 
2026-08-20 01:11:14.143690 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-20 01:11:14.348566 | instance | environment: line 3: kubectl: command not found
2026-08-20 01:11:14.685923 | instance | ok: Runtime: 0:00:00.009147
2026-08-20 01:11:14.693139 | 
2026-08-20 01:11:14.693292 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-20 01:11:15.174648 | instance | changed:
2026-08-20 01:11:15.174894 | instance | cd+++++++++ pod-logs/
2026-08-20 01:11:15.174954 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-20 01:11:15.188251 | 
2026-08-20 01:11:15.188316 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-20 01:11:15.415970 | instance | changed
2026-08-20 01:11:15.423238 | 
2026-08-20 01:11:15.423340 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-20 01:11:15.631277 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 01:11:15.957604 | instance | ok: Runtime: 0:00:00.036149
2026-08-20 01:11:15.962443 | 
2026-08-20 01:11:15.962512 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-20 01:11:16.165501 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 01:11:16.198703 | instance | ceph-mgr endpoints:
2026-08-20 01:11:16.497806 | instance | ok: Runtime: 0:00:00.038174
2026-08-20 01:11:16.506614 | 
2026-08-20 01:11:16.507094 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-20 01:11:16.714575 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-20 01:11:17.055173 | instance | ok: Runtime: 0:00:00.036497
2026-08-20 01:11:17.063265 | 
2026-08-20 01:11:17.063331 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-20 01:11:17.541871 | instance | changed: cd+++++++++ prometheus/
2026-08-20 01:11:17.552742 | 
2026-08-20 01:11:17.552807 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-20 01:11:17.747478 | instance | changed
2026-08-20 01:11:17.753165 | 
2026-08-20 01:11:17.753232 | TASK [gather-selenium-data : Get selenium data]
2026-08-20 01:11:17.987848 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-20 01:11:17.989534 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-20 01:11:18.286303 | instance | ERROR
2026-08-20 01:11:18.286579 | instance | {
2026-08-20 01:11:18.286629 | instance |   "delta": "0:00:00.007330",
2026-08-20 01:11:18.286659 | instance |   "end": "2026-08-20 01:11:17.990058",
2026-08-20 01:11:18.286688 | instance |   "msg": "non-zero return code",
2026-08-20 01:11:18.286715 | instance |   "rc": 1,
2026-08-20 01:11:18.286740 | instance |   "start": "2026-08-20 01:11:17.982728"
2026-08-20 01:11:18.286764 | instance | }
2026-08-20 01:11:18.286796 | instance | ERROR: Ignoring Errors
2026-08-20 01:11:18.294052 | 
2026-08-20 01:11:18.294131 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-20 01:11:18.787604 | instance | changed: cd+++++++++ selenium/
2026-08-20 01:11:18.794240 | 
2026-08-20 01:11:18.794300 | PLAY RECAP
2026-08-20 01:11:18.794346 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-20 01:11:18.794368 | 
2026-08-20 01:11:18.951401 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 01:11:18.957103 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 01:11:19.769215 | 
2026-08-20 01:11:19.769353 | PLAY [all]
2026-08-20 01:11:19.781462 | 
2026-08-20 01:11:19.781551 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-20 01:11:19.817425 | instance | skipping: Conditional result was False
2026-08-20 01:11:19.827290 | 
2026-08-20 01:11:19.827375 | TASK [fetch-output : Set log path for single node]
2026-08-20 01:11:19.871218 | instance | ok
2026-08-20 01:11:19.877573 | 
2026-08-20 01:11:19.877649 | LOOP [fetch-output : Ensure local output dirs]
2026-08-20 01:11:20.323248 | instance -> localhost | ok: "/var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/logs"
2026-08-20 01:11:20.557060 | instance -> localhost | changed: "/var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/artifacts"
2026-08-20 01:11:20.793637 | instance -> localhost | changed: "/var/lib/zuul/builds/fea730c2c333442c98d673fd12cbf1a9/work/docs"
2026-08-20 01:11:20.811795 | 
2026-08-20 01:11:20.811926 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-20 01:11:21.472727 | instance | changed: .d..t...... ./
2026-08-20 01:11:21.472972 | instance | changed: All items complete
2026-08-20 01:11:21.473018 | 
2026-08-20 01:11:21.948588 | instance | changed: .d..t...... ./
2026-08-20 01:11:22.400958 | instance | changed: .d..t...... ./
2026-08-20 01:11:22.431197 | 
2026-08-20 01:11:22.431380 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-20 01:11:22.882049 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.011714
2026-08-20 01:11:23.110197 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006942
2026-08-20 01:11:23.134549 | 
2026-08-20 01:11:23.134660 | PLAY [all]
2026-08-20 01:11:23.144407 | 
2026-08-20 01:11:23.144475 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-20 01:11:23.576533 | instance | changed
2026-08-20 01:11:23.583014 | 
2026-08-20 01:11:23.583064 | PLAY RECAP
2026-08-20 01:11:23.583109 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-20 01:11:23.583131 | 
2026-08-20 01:11:23.712158 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 01:11:23.716885 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-20 01:11:24.323554 | 
2026-08-20 01:11:24.323695 | PLAY [localhost]
2026-08-20 01:11:24.344469 | 
2026-08-20 01:11:24.344618 | TASK [Generate Zuul manifest]
2026-08-20 01:11:24.368844 | localhost | ok
2026-08-20 01:11:24.392313 | 
2026-08-20 01:11:24.392417 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-20 01:11:24.806687 | localhost | changed
2026-08-20 01:11:24.818253 | 
2026-08-20 01:11:24.818349 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-20 01:11:24.850554 | localhost | ok
2026-08-20 01:11:24.858283 | 
2026-08-20 01:11:24.858349 | TASK [Upload logs]
2026-08-20 01:11:24.880047 | localhost | ok
2026-08-20 01:11:24.936338 | 
2026-08-20 01:11:24.936449 | TASK [Set zuul-log-path fact]
2026-08-20 01:11:24.957892 | localhost | ok
2026-08-20 01:11:24.971707 | 
2026-08-20 01:11:24.971809 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 01:11:25.003104 | localhost | ok
2026-08-20 01:11:25.012128 | 
2026-08-20 01:11:25.012205 | TASK [upload-logs : Create log directories]
2026-08-20 01:11:25.419096 | localhost | changed
2026-08-20 01:11:25.425872 | 
2026-08-20 01:11:25.425954 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-20 01:11:25.801724 | localhost -> localhost | ok: Runtime: 0:00:00.004319
2026-08-20 01:11:25.808364 | 
2026-08-20 01:11:25.808431 | TASK [upload-logs : Upload logs to log server]
2026-08-20 01:11:26.276259 | localhost | Output suppressed because no_log was given
2026-08-20 01:11:26.312488 | 
2026-08-20 01:11:26.312627 | LOOP [upload-logs : Compress console log and json output]
2026-08-20 01:11:26.355801 | localhost | skipping: Conditional result was False
2026-08-20 01:11:26.363775 | localhost | skipping: Conditional result was False
2026-08-20 01:11:26.375423 | 
2026-08-20 01:11:26.375588 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-20 01:11:26.418107 | localhost | skipping: Conditional result was False
2026-08-20 01:11:26.418486 | 
2026-08-20 01:11:26.422979 | localhost | skipping: Conditional result was False
2026-08-20 01:11:26.439683 | 
2026-08-20 01:11:26.439850 | LOOP [upload-logs : Upload console log and json output]