2026-09-17 14:10:08.062787 | Job console starting
2026-09-17 14:10:08.088599 | Updating git repos
2026-09-17 14:10:10.840336 | Cloning repos into workspace
2026-09-17 14:10:30.553823 | Restoring repo states
2026-09-17 14:10:42.032202 | Merging changes
2026-09-17 14:10:43.516397 | Checking out repos
2026-09-17 14:10:47.309282 | Preparing playbooks
2026-09-17 14:10:50.462852 | Running Ansible setup
2026-09-17 14:10:53.900750 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-17 14:10:54.482393 | 
2026-09-17 14:10:54.482516 | PLAY [localhost]
2026-09-17 14:10:54.489516 | 
2026-09-17 14:10:54.489585 | TASK [Gathering Facts]
2026-09-17 14:10:55.316413 | localhost | ok
2026-09-17 14:10:55.323693 | 
2026-09-17 14:10:55.323764 | TASK [Setup log path fact]
2026-09-17 14:10:55.339434 | localhost | ok
2026-09-17 14:10:55.348095 | 
2026-09-17 14:10:55.348157 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-17 14:10:55.373510 | localhost | ok
2026-09-17 14:10:55.378372 | 
2026-09-17 14:10:55.378431 | TASK [emit-job-header : Print job information]
2026-09-17 14:10:55.414142 | # Job Information
2026-09-17 14:10:55.414240 | Ansible Version: 2.16.18
2026-09-17 14:10:55.414268 | Job: atmosphere-molecule-csi-rbd
2026-09-17 14:10:55.414287 | Pipeline: check
2026-09-17 14:10:55.414305 | Executor: 2d72f0692154
2026-09-17 14:10:55.414322 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4376
2026-09-17 14:10:55.414345 | Event ID: 5a2f63d0-b2a1-11f1-9364-7571c579de6c
2026-09-17 14:10:55.416794 | 
2026-09-17 14:10:55.416853 | LOOP [emit-job-header : Print node information]
2026-09-17 14:10:55.504722 | localhost | ok:
2026-09-17 14:10:55.505415 | localhost | # Node Information
2026-09-17 14:10:55.505529 | localhost | Inventory Hostname: instance
2026-09-17 14:10:55.505575 | localhost | Hostname: np0000193013
2026-09-17 14:10:55.505666 | localhost | Username: zuul
2026-09-17 14:10:55.505749 | localhost | Distro: Ubuntu 22.04
2026-09-17 14:10:55.505842 | localhost | Provider: yul1
2026-09-17 14:10:55.505918 | localhost | Region: ca-ymq-1
2026-09-17 14:10:55.506013 | localhost | Label: ubuntu-jammy
2026-09-17 14:10:55.506130 | localhost | Product Name: OpenStack Nova
2026-09-17 14:10:55.506260 | localhost | Interface IP: 162.253.55.77
2026-09-17 14:10:55.516276 | 
2026-09-17 14:10:55.516385 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-17 14:10:56.106412 | localhost -> localhost | changed
2026-09-17 14:10:56.116885 | 
2026-09-17 14:10:56.117014 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-17 14:10:57.098379 | localhost -> localhost | changed
2026-09-17 14:10:57.109247 | 
2026-09-17 14:10:57.109355 | PLAY [all]
2026-09-17 14:10:57.124894 | 
2026-09-17 14:10:57.125039 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-17 14:10:57.400189 | instance -> localhost | ok
2026-09-17 14:10:57.412138 | 
2026-09-17 14:10:57.412309 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-17 14:10:57.447073 | instance | ok
2026-09-17 14:10:57.476685 | instance | included: /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-17 14:10:57.484195 | 
2026-09-17 14:10:57.484334 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-17 14:10:58.479372 | instance -> localhost | Generating public/private rsa key pair.
2026-09-17 14:10:58.479585 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/08f41c75fc9149989f6f1410f8222fbf_id_rsa
2026-09-17 14:10:58.479622 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/08f41c75fc9149989f6f1410f8222fbf_id_rsa.pub
2026-09-17 14:10:58.479651 | instance -> localhost | The key fingerprint is:
2026-09-17 14:10:58.479678 | instance -> localhost | SHA256:XI7dKBJtfnMqsRsnN/iYzJ/c84VcJzZhxgMzdG/I3wo zuul-build-sshkey
2026-09-17 14:10:58.479725 | instance -> localhost | The key's randomart image is:
2026-09-17 14:10:58.479753 | instance -> localhost | +---[RSA 3072]----+
2026-09-17 14:10:58.479784 | instance -> localhost | |           .= .  |
2026-09-17 14:10:58.479813 | instance -> localhost | |       .     B o |
2026-09-17 14:10:58.479839 | instance -> localhost | |      . o .   O o|
2026-09-17 14:10:58.479864 | instance -> localhost | |       = = o o =.|
2026-09-17 14:10:58.479890 | instance -> localhost | |      . S * E + =|
2026-09-17 14:10:58.479915 | instance -> localhost | |       . * + + *.|
2026-09-17 14:10:58.479940 | instance -> localhost | |        * =   + .|
2026-09-17 14:10:58.479966 | instance -> localhost | |       o % +.  . |
2026-09-17 14:10:58.479994 | instance -> localhost | |        *.= .o.  |
2026-09-17 14:10:58.480020 | instance -> localhost | +----[SHA256]-----+
2026-09-17 14:10:58.480094 | instance -> localhost | ok: Runtime: 0:00:00.526689
2026-09-17 14:10:58.490160 | 
2026-09-17 14:10:58.490304 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-17 14:10:58.521131 | instance | ok
2026-09-17 14:10:58.528896 | instance | included: /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-17 14:10:58.535622 | 
2026-09-17 14:10:58.535694 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-17 14:10:58.560128 | instance | skipping: Conditional result was False
2026-09-17 14:10:58.566431 | 
2026-09-17 14:10:58.566529 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-17 14:10:58.994840 | instance | changed
2026-09-17 14:10:59.007568 | 
2026-09-17 14:10:59.007769 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-17 14:10:59.225170 | instance | ok
2026-09-17 14:10:59.236389 | 
2026-09-17 14:10:59.236588 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-17 14:10:59.749015 | instance | changed
2026-09-17 14:10:59.758701 | 
2026-09-17 14:10:59.758971 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-17 14:11:00.260724 | instance | changed
2026-09-17 14:11:00.272110 | 
2026-09-17 14:11:00.272234 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-17 14:11:00.298664 | instance | skipping: Conditional result was False
2026-09-17 14:11:00.310949 | 
2026-09-17 14:11:00.311196 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-17 14:11:00.703930 | instance -> localhost | changed
2026-09-17 14:11:00.725088 | 
2026-09-17 14:11:00.725318 | TASK [add-build-sshkey : Add back temp key]
2026-09-17 14:11:01.068616 | instance -> localhost | Identity added: /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/08f41c75fc9149989f6f1410f8222fbf_id_rsa (zuul-build-sshkey)
2026-09-17 14:11:01.069043 | instance -> localhost | ok: Runtime: 0:00:00.018139
2026-09-17 14:11:01.080428 | 
2026-09-17 14:11:01.080637 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-17 14:11:01.433957 | instance | ok
2026-09-17 14:11:01.443981 | 
2026-09-17 14:11:01.444170 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-17 14:11:01.480434 | instance | skipping: Conditional result was False
2026-09-17 14:11:01.501202 | 
2026-09-17 14:11:01.501435 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-17 14:11:01.851912 | instance | ok
2026-09-17 14:11:01.867255 | 
2026-09-17 14:11:01.867520 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-17 14:11:05.378908 | instance | Output suppressed because no_log was given
2026-09-17 14:11:05.392906 | 
2026-09-17 14:11:05.392988 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-17 14:11:05.602658 | instance | ok: "logs"
2026-09-17 14:11:05.603163 | instance | ok: All items complete
2026-09-17 14:11:05.603278 | 
2026-09-17 14:11:05.738284 | instance | ok: "artifacts"
2026-09-17 14:11:05.884557 | instance | ok: "docs"
2026-09-17 14:11:05.903307 | 
2026-09-17 14:11:05.903458 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-17 14:11:06.095832 | instance | changed: "logs"
2026-09-17 14:11:06.246575 | instance | changed: "artifacts"
2026-09-17 14:11:06.383469 | instance | changed: "docs"
2026-09-17 14:11:06.399610 | 
2026-09-17 14:11:06.399767 | PLAY RECAP
2026-09-17 14:11:06.399859 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-17 14:11:06.399914 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 14:11:06.399958 | 
2026-09-17 14:11:06.541193 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-17 14:11:06.546607 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-17 14:11:07.166441 | 
2026-09-17 14:11:07.166680 | PLAY [all]
2026-09-17 14:11:07.188849 | 
2026-09-17 14:11:07.189028 | TASK [setup-uv : Extract archive]
2026-09-17 14:11:09.602785 | instance | changed
2026-09-17 14:11:09.615676 | 
2026-09-17 14:11:09.615895 | TASK [setup-uv : Print version]
2026-09-17 14:11:10.003704 | instance | uv 0.8.13
2026-09-17 14:11:10.162728 | instance | ok: Runtime: 0:00:00.014253
2026-09-17 14:11:10.179984 | 
2026-09-17 14:11:10.180129 | TASK [Install Ansible collection siblings]
2026-09-17 14:11:19.491570 | instance | changed:
2026-09-17 14:11:19.491756 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-17 14:11:19.491800 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-17 14:11:19.491957 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-17 14:11:19.491996 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-17 14:11:19.492027 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-17 14:11:19.492063 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-17 14:11:19.492111 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-17 14:11:19.492146 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-17 14:11:19.492175 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-17 14:11:19.492203 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-17 14:11:19.492231 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-17 14:11:19.492311 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-17 14:11:19.492361 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-17 14:11:19.492395 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-17 14:11:19.492424 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0
2026-09-17 14:11:19.492452 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-17 14:11:19.492480 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-17 14:11:19.492560 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-17 14:11:19.492591 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-17 14:11:19.492618 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-17 14:11:19.492645 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-17 14:11:19.492671 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-17 14:11:19.492703 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-17 14:11:19.492744 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-17 14:11:19.492774 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0,>=6.0.0
2026-09-17 14:11:19.492801 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-17 14:11:19.492828 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-17 14:11:19.492854 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-17 14:11:19.492876 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-17 14:11:19.492900 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-17 14:11:19.492926 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-17 14:11:19.492954 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-17 14:11:19.492979 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-17 14:11:19.493004 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-17 14:11:19.493148 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.493237 | instance | Process install dependency map
2026-09-17 14:11:19.493288 | instance | Starting collection install process
2026-09-17 14:11:19.493374 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-17 14:11:19.493458 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-17 14:11:19.493694 | instance | ansible.netcommon:* was installed successfully
2026-09-17 14:11:19.493848 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-17 14:11:19.494143 | instance | Creating virtual environment at: .venv
2026-09-17 14:11:19.494232 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-17 14:11:19.494320 | instance | Downloading pygments (1.2MiB)
2026-09-17 14:11:19.494451 | instance | Downloading cryptography (4.2MiB)
2026-09-17 14:11:19.494509 | instance | Downloading netaddr (2.2MiB)
2026-09-17 14:11:19.494543 | instance | Downloading openstacksdk (1.7MiB)
2026-09-17 14:11:19.494572 | instance | Downloading setuptools (1.1MiB)
2026-09-17 14:11:19.494650 | instance | Downloading pydantic-core (2.0MiB)
2026-09-17 14:11:19.494684 | instance | Downloading ansible-core (2.1MiB)
2026-09-17 14:11:19.494753 | instance | Downloading kubernetes (1.9MiB)
2026-09-17 14:11:19.494789 | instance | Downloading rjsonnet (1.2MiB)
2026-09-17 14:11:19.494818 | instance |    Building pyperclip==1.9.0
2026-09-17 14:11:19.494849 | instance |  Downloading rjsonnet
2026-09-17 14:11:19.494876 | instance |  Downloading pydantic-core
2026-09-17 14:11:19.494902 | instance |  Downloading netaddr
2026-09-17 14:11:19.494929 | instance |  Downloading pygments
2026-09-17 14:11:19.495267 | instance |  Downloading cryptography
2026-09-17 14:11:19.495313 | instance |  Downloading setuptools
2026-09-17 14:11:19.495344 | instance |  Downloading kubernetes
2026-09-17 14:11:19.495372 | instance |  Downloading ansible-core
2026-09-17 14:11:19.495399 | instance |  Downloading openstacksdk
2026-09-17 14:11:19.495424 | instance |       Built pyperclip==1.9.0
2026-09-17 14:11:19.495452 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-17 14:11:19.495479 | instance | Installed 83 packages in 53ms
2026-09-17 14:11:19.495505 | instance | Checked out ansible.posix to 1.6.0
2026-09-17 14:11:19.495570 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-17 14:11:19.495610 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.495640 | instance | Process install dependency map
2026-09-17 14:11:19.495678 | instance | Starting collection install process
2026-09-17 14:11:19.495707 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-17 14:11:19.495733 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-17 14:11:19.495800 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-17 14:11:19.495832 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.495857 | instance | 2.17.12
2026-09-17 14:11:19.495922 | instance | Checked out ansible.utils to v6.1.1
2026-09-17 14:11:19.495956 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-17 14:11:19.495982 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.496009 | instance | Process install dependency map
2026-09-17 14:11:19.496032 | instance | Starting collection install process
2026-09-17 14:11:19.496058 | instance | Installing 'ansible.utils:6.1.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-17 14:11:19.496084 | instance | Created collection for ansible.utils:6.1.1 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-17 14:11:19.496130 | instance | ansible.utils:6.1.1 was installed successfully
2026-09-17 14:11:19.496158 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.496182 | instance | 2.17.12
2026-09-17 14:11:19.496203 | instance | Checked out atmosphere.common to v0.7.0
2026-09-17 14:11:19.496225 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-17 14:11:19.496246 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.496267 | instance | Process install dependency map
2026-09-17 14:11:19.496288 | instance | Starting collection install process
2026-09-17 14:11:19.496309 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-17 14:11:19.496333 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-17 14:11:19.496356 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-17 14:11:19.496377 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.496397 | instance | 2.17.12
2026-09-17 14:11:19.496421 | instance | Checked out community.crypto to 2.2.3
2026-09-17 14:11:19.496443 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-17 14:11:19.496465 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.496486 | instance | Process install dependency map
2026-09-17 14:11:19.496772 | instance | Starting collection install process
2026-09-17 14:11:19.496860 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-17 14:11:19.496897 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-17 14:11:19.496928 | instance | community.crypto:2.2.3 was installed successfully
2026-09-17 14:11:19.496958 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.496986 | instance | 2.17.12
2026-09-17 14:11:19.497013 | instance | Checked out community.general to 7.3.0
2026-09-17 14:11:19.497041 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-17 14:11:19.497076 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.497179 | instance | Process install dependency map
2026-09-17 14:11:19.497210 | instance | Starting collection install process
2026-09-17 14:11:19.497230 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-17 14:11:19.497247 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-17 14:11:19.497264 | instance | community.general:7.3.0 was installed successfully
2026-09-17 14:11:19.497281 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.497298 | instance | 2.17.12
2026-09-17 14:11:19.497314 | instance | Checked out community.mysql to 3.6.0
2026-09-17 14:11:19.497332 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-17 14:11:19.497349 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.497365 | instance | Process install dependency map
2026-09-17 14:11:19.497380 | instance | Starting collection install process
2026-09-17 14:11:19.497396 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-17 14:11:19.497412 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-17 14:11:19.497427 | instance | community.mysql:3.6.0 was installed successfully
2026-09-17 14:11:19.497442 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.497457 | instance | 2.17.12
2026-09-17 14:11:19.497473 | instance | Checked out kubernetes.core to 2.4.0
2026-09-17 14:11:19.497488 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-17 14:11:19.497503 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.497518 | instance | Process install dependency map
2026-09-17 14:11:19.497534 | instance | Starting collection install process
2026-09-17 14:11:19.497549 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-17 14:11:19.497564 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-17 14:11:19.497579 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-17 14:11:19.497594 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.497609 | instance | 2.17.12
2026-09-17 14:11:19.497624 | instance | Checked out openstack.cloud to 2.6.0
2026-09-17 14:11:19.497639 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-17 14:11:19.497654 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.497669 | instance | Process install dependency map
2026-09-17 14:11:19.497684 | instance | Starting collection install process
2026-09-17 14:11:19.497699 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-17 14:11:19.497713 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-17 14:11:19.497728 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-17 14:11:19.497743 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.497966 | instance | 2.17.12
2026-09-17 14:11:19.498039 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-17 14:11:19.498080 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-17 14:11:19.498157 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.498214 | instance | Process install dependency map
2026-09-17 14:11:19.498255 | instance | Starting collection install process
2026-09-17 14:11:19.498315 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-17 14:11:19.498352 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-17 14:11:19.498419 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-17 14:11:19.498472 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.498514 | instance | 2.17.12
2026-09-17 14:11:19.498533 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-17 14:11:19.498549 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-17 14:11:19.498565 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.498582 | instance | Process install dependency map
2026-09-17 14:11:19.498596 | instance | Starting collection install process
2026-09-17 14:11:19.498612 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-17 14:11:19.498627 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-17 14:11:19.498642 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-17 14:11:19.498657 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.498673 | instance | 2.17.12
2026-09-17 14:11:19.498825 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-17 14:11:19.498852 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-17 14:11:19.498869 | instance | Starting galaxy collection install process
2026-09-17 14:11:19.498886 | instance | Process install dependency map
2026-09-17 14:11:19.498901 | instance | Starting collection install process
2026-09-17 14:11:19.498917 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-17 14:11:19.498933 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-17 14:11:19.498949 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-17 14:11:19.498964 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-17 14:11:19.498980 | instance | 2.17.12
2026-09-17 14:11:19.503891 | 
2026-09-17 14:11:19.504152 | PLAY RECAP
2026-09-17 14:11:19.504218 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 14:11:19.504241 | 
2026-09-17 14:11:19.660069 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-17 14:11:19.664063 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-17 14:11:20.240036 | 
2026-09-17 14:11:20.240218 | PLAY [all]
2026-09-17 14:11:20.251472 | 
2026-09-17 14:11:20.251602 | TASK [Install "jq" for log collection]
2026-09-17 14:11:29.372462 | instance | changed
2026-09-17 14:11:29.378076 | 
2026-09-17 14:11:29.378235 | PLAY RECAP
2026-09-17 14:11:29.378338 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-17 14:11:29.378461 | 
2026-09-17 14:11:29.514856 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-17 14:11:29.519005 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-17 14:11:30.156237 | 
2026-09-17 14:11:30.156387 | PLAY [all]
2026-09-17 14:11:30.166730 | 
2026-09-17 14:11:30.166853 | LOOP [Check inventory directories]
2026-09-17 14:11:30.573049 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-17 14:11:30.758531 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-17 14:11:30.923558 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-17 14:11:30.936368 | 
2026-09-17 14:11:30.936670 | LOOP [Copy inventory file for Zuul]
2026-09-17 14:11:31.800868 | instance | changed:
2026-09-17 14:11:31.801208 | instance | {
2026-09-17 14:11:31.801270 | instance |   "ansible_loop_var": "item",
2026-09-17 14:11:31.801318 | instance |   "changed": false,
2026-09-17 14:11:31.801360 | instance |   "failed": false,
2026-09-17 14:11:31.801402 | instance |   "invocation": {
2026-09-17 14:11:31.801441 | instance |     "module_args": {
2026-09-17 14:11:31.801478 | instance |       "checksum_algorithm": "sha1",
2026-09-17 14:11:31.801515 | instance |       "follow": true,
2026-09-17 14:11:31.801553 | instance |       "get_attributes": true,
2026-09-17 14:11:31.801592 | instance |       "get_checksum": true,
2026-09-17 14:11:31.801629 | instance |       "get_mime": true,
2026-09-17 14:11:31.801665 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-17 14:11:31.801701 | instance |     }
2026-09-17 14:11:31.801738 | instance |   },
2026-09-17 14:11:31.801774 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-17 14:11:31.801811 | instance |   "stat": {
2026-09-17 14:11:31.801846 | instance |     "atime": 1789654272.0681102,
2026-09-17 14:11:31.801884 | instance |     "attr_flags": "e",
2026-09-17 14:11:31.801921 | instance |     "attributes": [
2026-09-17 14:11:31.801956 | instance |       "extents"
2026-09-17 14:11:31.801992 | instance |     ],
2026-09-17 14:11:31.802027 | instance |     "block_size": 4096,
2026-09-17 14:11:31.802063 | instance |     "blocks": 8,
2026-09-17 14:11:31.802099 | instance |     "charset": "unknown",
2026-09-17 14:11:31.802160 | instance |     "ctime": 1789654271.0760908,
2026-09-17 14:11:31.802197 | instance |     "dev": 64513,
2026-09-17 14:11:31.802233 | instance |     "device_type": 0,
2026-09-17 14:11:31.802269 | instance |     "executable": true,
2026-09-17 14:11:31.802303 | instance |     "exists": true,
2026-09-17 14:11:31.802339 | instance |     "gid": 1000,
2026-09-17 14:11:31.802374 | instance |     "gr_name": "zuul",
2026-09-17 14:11:31.802409 | instance |     "inode": 1049011,
2026-09-17 14:11:31.802444 | instance |     "isblk": false,
2026-09-17 14:11:31.802480 | instance |     "ischr": false,
2026-09-17 14:11:31.802516 | instance |     "isdir": true,
2026-09-17 14:11:31.802551 | instance |     "isfifo": false,
2026-09-17 14:11:31.802585 | instance |     "isgid": false,
2026-09-17 14:11:31.802618 | instance |     "islnk": false,
2026-09-17 14:11:31.802652 | instance |     "isreg": false,
2026-09-17 14:11:31.802686 | instance |     "issock": false,
2026-09-17 14:11:31.802719 | instance |     "isuid": false,
2026-09-17 14:11:31.802753 | instance |     "mimetype": "unknown",
2026-09-17 14:11:31.802788 | instance |     "mode": "0755",
2026-09-17 14:11:31.802821 | instance |     "mtime": 1789654271.0760908,
2026-09-17 14:11:31.802856 | instance |     "nlink": 22,
2026-09-17 14:11:31.802890 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-17 14:11:31.802926 | instance |     "pw_name": "zuul",
2026-09-17 14:11:31.802964 | instance |     "readable": true,
2026-09-17 14:11:31.803001 | instance |     "rgrp": true,
2026-09-17 14:11:31.803036 | instance |     "roth": true,
2026-09-17 14:11:31.803100 | instance |     "rusr": true,
2026-09-17 14:11:31.803163 | instance |     "size": 4096,
2026-09-17 14:11:31.803199 | instance |     "uid": 1000,
2026-09-17 14:11:31.803234 | instance |     "version": "671151230",
2026-09-17 14:11:31.803271 | instance |     "wgrp": false,
2026-09-17 14:11:31.803309 | instance |     "woth": false,
2026-09-17 14:11:31.803346 | instance |     "writeable": true,
2026-09-17 14:11:31.803382 | instance |     "wusr": true,
2026-09-17 14:11:31.803418 | instance |     "xgrp": true,
2026-09-17 14:11:31.803452 | instance |     "xoth": true,
2026-09-17 14:11:31.803487 | instance |     "xusr": true
2026-09-17 14:11:31.803522 | instance |   }
2026-09-17 14:11:31.803558 | instance | }
2026-09-17 14:11:31.803627 | instance | ok: All items complete
2026-09-17 14:11:31.803671 | 
2026-09-17 14:11:31.806288 | instance | skipping: Conditional result was False
2026-09-17 14:11:31.809082 | instance | skipping: Conditional result was False
2026-09-17 14:11:31.827403 | 
2026-09-17 14:11:31.827684 | LOOP [Switch "ansible_host" to private IP]
2026-09-17 14:11:32.181276 | instance | changed: 1 replacements made
2026-09-17 14:11:32.184657 | instance | skipping: Conditional result was False
2026-09-17 14:11:32.186169 | instance | skipping: Conditional result was False
2026-09-17 14:11:32.206915 | 
2026-09-17 14:11:32.207061 | TASK [Run Molecule scenario]
2026-09-17 14:11:33.201883 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-17 14:11:33.638845 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-17 14:11:33.638930 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-17 14:11:44.113214 | instance | INFO     [csi > dependency] Executing
2026-09-17 14:11:44.113586 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-17 14:11:44.114578 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-17 14:11:44.115321 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-17 14:11:44.131303 | instance | INFO     [csi > cleanup] Executing
2026-09-17 14:11:44.131909 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-17 14:11:44.146352 | instance | INFO     [csi > destroy] Executing
2026-09-17 14:11:44.146492 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-17 14:11:44.146633 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-17 14:11:44.161234 | instance | INFO     [csi > syntax] Executing
2026-09-17 14:11:45.671103 | instance |
2026-09-17 14:11:45.671415 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-17 14:11:45.739467 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-17 14:11:45.754920 | instance | INFO     [csi > create] Executing
2026-09-17 14:11:45.758464 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-17 14:11:45.773158 | instance | INFO     [csi > prepare] Executing
2026-09-17 14:11:46.500682 | instance |
2026-09-17 14:11:46.500941 | instance | PLAY [Prepare] *****************************************************************
2026-09-17 14:11:46.501209 | instance |
2026-09-17 14:11:46.501456 | instance | TASK [Gathering Facts] *********************************************************
2026-09-17 14:11:46.501704 | instance | Thursday 17 September 2026  14:11:46 +0000 (0:00:00.023)       0:00:00.023 ****
2026-09-17 14:11:47.758347 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-17 14:11:47.758563 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-17 14:11:47.758808 | instance | interpreter could change the meaning of that path. See
2026-09-17 14:11:47.759092 | instance | https://docs.ansible.com/ansible-
2026-09-17 14:11:47.759349 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-17 14:11:47.768784 | instance | ok: [instance]
2026-09-17 14:11:47.768983 | instance |
2026-09-17 14:11:47.769235 | instance | TASK [Configure short hostname] ************************************************
2026-09-17 14:11:47.769470 | instance | Thursday 17 September 2026  14:11:47 +0000 (0:00:01.268)       0:00:01.291 ****
2026-09-17 14:11:48.506694 | instance | changed: [instance]
2026-09-17 14:11:48.506954 | instance |
2026-09-17 14:11:48.507205 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-17 14:11:48.507445 | instance | Thursday 17 September 2026  14:11:48 +0000 (0:00:00.737)       0:00:02.029 ****
2026-09-17 14:11:48.801660 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-17 14:11:48.801865 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-17 14:11:48.802112 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-17 14:11:48.806596 | instance | changed: [instance]
2026-09-17 14:11:48.806783 | instance |
2026-09-17 14:11:48.807026 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-17 14:11:48.807264 | instance | Thursday 17 September 2026  14:11:48 +0000 (0:00:00.300)       0:00:02.330 ****
2026-09-17 14:11:49.577707 | instance | ok: [instance]
2026-09-17 14:11:49.577985 | instance |
2026-09-17 14:11:49.578288 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-17 14:11:49.578526 | instance |
2026-09-17 14:11:49.578764 | instance | TASK [Gathering Facts] *********************************************************
2026-09-17 14:11:49.579022 | instance | Thursday 17 September 2026  14:11:49 +0000 (0:00:00.770)       0:00:03.100 ****
2026-09-17 14:11:50.346054 | instance | ok: [instance]
2026-09-17 14:11:50.346246 | instance |
2026-09-17 14:11:50.346490 | instance | TASK [Install depedencies] *****************************************************
2026-09-17 14:11:50.346729 | instance | Thursday 17 September 2026  14:11:50 +0000 (0:00:00.768)       0:00:03.868 ****
2026-09-17 14:12:14.622957 | instance | changed: [instance]
2026-09-17 14:12:14.623024 | instance |
2026-09-17 14:12:14.623034 | instance | TASK [Start up service] ********************************************************
2026-09-17 14:12:14.623042 | instance | Thursday 17 September 2026  14:12:14 +0000 (0:00:24.276)       0:00:28.145 ****
2026-09-17 14:12:15.186786 | instance | ok: [instance]
2026-09-17 14:12:15.186850 | instance |
2026-09-17 14:12:15.186858 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-17 14:12:15.186865 | instance | Thursday 17 September 2026  14:12:15 +0000 (0:00:00.564)       0:00:28.709 ****
2026-09-17 14:12:15.512050 | instance | ok: [instance]
2026-09-17 14:12:15.512099 | instance |
2026-09-17 14:12:15.512111 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-17 14:12:15.512121 | instance | Thursday 17 September 2026  14:12:15 +0000 (0:00:00.324)       0:00:29.033 ****
2026-09-17 14:12:16.242541 | instance | changed: [instance]
2026-09-17 14:12:16.242598 | instance |
2026-09-17 14:12:16.242610 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-17 14:12:16.242621 | instance | Thursday 17 September 2026  14:12:16 +0000 (0:00:00.729)       0:00:29.763 ****
2026-09-17 14:12:16.460275 | instance | ok: [instance]
2026-09-17 14:12:16.460981 | instance |
2026-09-17 14:12:16.461028 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-17 14:12:16.461040 | instance | Thursday 17 September 2026  14:12:16 +0000 (0:00:00.218)       0:00:29.982 ****
2026-09-17 14:12:16.481288 | instance | skipping: [instance]
2026-09-17 14:12:16.481776 | instance |
2026-09-17 14:12:16.481819 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-17 14:12:16.481828 | instance | Thursday 17 September 2026  14:12:16 +0000 (0:00:00.021)       0:00:30.004 ****
2026-09-17 14:12:17.066228 | instance | changed: [instance] => (item=osd0)
2026-09-17 14:12:17.067041 | instance | changed: [instance] => (item=osd1)
2026-09-17 14:12:17.067060 | instance | changed: [instance] => (item=osd2)
2026-09-17 14:12:17.067502 | instance |
2026-09-17 14:12:17.067541 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-17 14:12:17.067954 | instance | Thursday 17 September 2026  14:12:17 +0000 (0:00:00.584)       0:00:30.589 ****
2026-09-17 14:12:17.757783 | instance | changed: [instance] => (item=osd0)
2026-09-17 14:12:17.759027 | instance | changed: [instance] => (item=osd1)
2026-09-17 14:12:17.759293 | instance | changed: [instance] => (item=osd2)
2026-09-17 14:12:17.759307 | instance |
2026-09-17 14:12:17.759318 | instance | TASK [Start loop devices] ******************************************************
2026-09-17 14:12:17.759329 | instance | Thursday 17 September 2026  14:12:17 +0000 (0:00:00.690)       0:00:31.279 ****
2026-09-17 14:12:18.527777 | instance | changed: [instance] => (item=osd0)
2026-09-17 14:12:18.527841 | instance | changed: [instance] => (item=osd1)
2026-09-17 14:12:18.527853 | instance | changed: [instance] => (item=osd2)
2026-09-17 14:12:18.527862 | instance |
2026-09-17 14:12:18.527880 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-17 14:12:18.528053 | instance | Thursday 17 September 2026  14:12:18 +0000 (0:00:00.770)       0:00:32.050 ****
2026-09-17 14:12:21.960576 | instance | changed: [instance] => (item=osd0)
2026-09-17 14:12:21.960688 | instance | changed: [instance] => (item=osd1)
2026-09-17 14:12:21.961280 | instance | changed: [instance] => (item=osd2)
2026-09-17 14:12:21.961339 | instance |
2026-09-17 14:12:21.961347 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-17 14:12:21.961354 | instance | Thursday 17 September 2026  14:12:21 +0000 (0:00:03.433)       0:00:35.483 ****
2026-09-17 14:12:23.882053 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-17 14:12:23.882182 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-17 14:12:23.882296 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-17 14:12:23.883151 | instance |
2026-09-17 14:12:23.883176 | instance | PLAY RECAP *********************************************************************
2026-09-17 14:12:23.883188 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-17 14:12:23.883198 | instance |
2026-09-17 14:12:23.883210 | instance | Thursday 17 September 2026  14:12:23 +0000 (0:00:01.922)       0:00:37.405 ****
2026-09-17 14:12:23.883808 | instance | ===============================================================================
2026-09-17 14:12:23.883871 | instance | Install depedencies ---------------------------------------------------- 24.28s
2026-09-17 14:12:23.883883 | instance | Create a volume group for each loop device ------------------------------ 3.43s
2026-09-17 14:12:23.883900 | instance | Create a logical volume for each loop device ---------------------------- 1.92s
2026-09-17 14:12:23.886156 | instance | Gathering Facts --------------------------------------------------------- 1.27s
2026-09-17 14:12:23.886208 | instance | Purge "snapd" package --------------------------------------------------- 0.77s
2026-09-17 14:12:23.886217 | instance | Start loop devices ------------------------------------------------------ 0.77s
2026-09-17 14:12:23.886223 | instance | Gathering Facts --------------------------------------------------------- 0.77s
2026-09-17 14:12:23.886230 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-17 14:12:23.886236 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s
2026-09-17 14:12:23.886243 | instance | Set permissions on loopback devices ------------------------------------- 0.69s
2026-09-17 14:12:23.886249 | instance | Create devices for Ceph ------------------------------------------------- 0.58s
2026-09-17 14:12:23.886255 | instance | Start up service -------------------------------------------------------- 0.56s
2026-09-17 14:12:23.886262 | instance | Generate lvm.conf ------------------------------------------------------- 0.32s
2026-09-17 14:12:23.886268 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-17 14:12:23.886275 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-17 14:12:23.886281 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-09-17 14:12:24.027933 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-17 14:12:24.043276 | instance | INFO     [csi > converge] Executing
2026-09-17 14:12:25.421648 | instance |
2026-09-17 14:12:25.422063 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-17 14:12:25.422384 | instance |
2026-09-17 14:12:25.422822 | instance | TASK [Gathering Facts] *********************************************************
2026-09-17 14:12:25.423266 | instance | Thursday 17 September 2026  14:12:25 +0000 (0:00:00.007)       0:00:00.007 ****
2026-09-17 14:12:26.481334 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-17 14:12:26.481381 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-17 14:12:26.481388 | instance | interpreter could change the meaning of that path. See
2026-09-17 14:12:26.481395 | instance | https://docs.ansible.com/ansible-
2026-09-17 14:12:26.481401 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-17 14:12:26.492782 | instance | ok: [instance]
2026-09-17 14:12:26.492805 | instance |
2026-09-17 14:12:26.492813 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-17 14:12:26.492819 | instance | Thursday 17 September 2026  14:12:26 +0000 (0:00:01.070)       0:00:01.078 ****
2026-09-17 14:12:26.547109 | instance | ok: [instance] => {
2026-09-17 14:12:26.547176 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-17 14:12:26.547194 | instance | }
2026-09-17 14:12:26.547272 | instance |
2026-09-17 14:12:26.547415 | instance | PLAY [all] *********************************************************************
2026-09-17 14:12:26.547571 | instance |
2026-09-17 14:12:26.547742 | instance | TASK [Gathering Facts] *********************************************************
2026-09-17 14:12:26.547870 | instance | Thursday 17 September 2026  14:12:26 +0000 (0:00:00.055)       0:00:01.133 ****
2026-09-17 14:12:27.488638 | instance | ok: [instance]
2026-09-17 14:12:27.488689 | instance |
2026-09-17 14:12:27.488701 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-09-17 14:12:27.488711 | instance | Thursday 17 September 2026  14:12:27 +0000 (0:00:00.939)       0:00:02.073 ****
2026-09-17 14:12:27.532143 | instance | skipping: [instance]
2026-09-17 14:12:27.532194 | instance |
2026-09-17 14:12:27.532482 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-17 14:12:27.532537 | instance | Thursday 17 September 2026  14:12:27 +0000 (0:00:00.044)       0:00:02.118 ****
2026-09-17 14:12:27.734069 | instance | ok: [instance]
2026-09-17 14:12:27.734182 | instance |
2026-09-17 14:12:27.734192 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-17 14:12:27.734201 | instance |
2026-09-17 14:12:27.734355 | instance | TASK [Gathering Facts] *********************************************************
2026-09-17 14:12:27.734556 | instance | Thursday 17 September 2026  14:12:27 +0000 (0:00:00.202)       0:00:02.320 ****
2026-09-17 14:12:28.696473 | instance | ok: [instance]
2026-09-17 14:12:28.696635 | instance |
2026-09-17 14:12:28.696986 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-17 14:12:28.697283 | instance | Thursday 17 September 2026  14:12:28 +0000 (0:00:00.961)       0:00:03.282 ****
2026-09-17 14:12:29.014862 | instance | ok: [instance]
2026-09-17 14:12:29.015091 | instance |
2026-09-17 14:12:29.015474 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-17 14:12:29.015791 | instance | Thursday 17 September 2026  14:12:29 +0000 (0:00:00.318)       0:00:03.600 ****
2026-09-17 14:12:29.069922 | instance | skipping: [instance]
2026-09-17 14:12:29.070107 | instance |
2026-09-17 14:12:29.070466 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-17 14:12:29.070776 | instance | Thursday 17 September 2026  14:12:29 +0000 (0:00:00.054)       0:00:03.655 ****
2026-09-17 14:12:29.415605 | instance | changed: [instance]
2026-09-17 14:12:29.415750 | instance |
2026-09-17 14:12:29.415999 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-17 14:12:29.416207 | instance | Thursday 17 September 2026  14:12:29 +0000 (0:00:00.345)       0:00:04.001 ****
2026-09-17 14:12:29.507744 | instance | ok: [instance] => {
2026-09-17 14:12:29.507965 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-17 14:12:29.508288 | instance | }
2026-09-17 14:12:29.508592 | instance |
2026-09-17 14:12:29.508888 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-17 14:12:29.509179 | instance | Thursday 17 September 2026  14:12:29 +0000 (0:00:00.091)       0:00:04.092 ****
2026-09-17 14:12:30.459069 | instance | changed: [instance]
2026-09-17 14:12:30.459450 | instance |
2026-09-17 14:12:30.459786 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-17 14:12:30.460099 | instance | Thursday 17 September 2026  14:12:30 +0000 (0:00:00.949)       0:00:05.042 ****
2026-09-17 14:12:30.520545 | instance | skipping: [instance]
2026-09-17 14:12:30.520594 | instance |
2026-09-17 14:12:30.520605 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-17 14:12:30.520614 | instance | Thursday 17 September 2026  14:12:30 +0000 (0:00:00.063)       0:00:05.106 ****
2026-09-17 14:12:30.582047 | instance | skipping: [instance]
2026-09-17 14:12:30.582089 | instance |
2026-09-17 14:12:30.582098 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-17 14:12:30.582104 | instance | Thursday 17 September 2026  14:12:30 +0000 (0:00:00.061)       0:00:05.167 ****
2026-09-17 14:12:30.840143 | instance | ok: [instance]
2026-09-17 14:12:30.840188 | instance |
2026-09-17 14:12:30.840196 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-17 14:12:30.840202 | instance | Thursday 17 September 2026  14:12:30 +0000 (0:00:00.258)       0:00:05.426 ****
2026-09-17 14:12:32.181371 | instance | ok: [instance]
2026-09-17 14:12:32.181966 | instance |
2026-09-17 14:12:32.182111 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-17 14:12:32.182134 | instance | Thursday 17 September 2026  14:12:32 +0000 (0:00:01.341)       0:00:06.767 ****
2026-09-17 14:12:32.273046 | instance | ok: [instance] => {
2026-09-17 14:12:32.274665 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-17 14:12:32.274702 | instance | }
2026-09-17 14:12:32.274716 | instance |
2026-09-17 14:12:32.274729 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-17 14:12:32.274741 | instance | Thursday 17 September 2026  14:12:32 +0000 (0:00:00.091)       0:00:06.859 ****
2026-09-17 14:12:33.103564 | instance | changed: [instance]
2026-09-17 14:12:33.103757 | instance |
2026-09-17 14:12:33.104009 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-17 14:12:33.104249 | instance | Thursday 17 September 2026  14:12:33 +0000 (0:00:00.830)       0:00:07.689 ****
2026-09-17 14:12:36.108684 | instance | changed: [instance]
2026-09-17 14:12:36.108864 | instance |
2026-09-17 14:12:36.109113 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-17 14:12:36.109404 | instance | Thursday 17 September 2026  14:12:36 +0000 (0:00:03.004)       0:00:10.694 ****
2026-09-17 14:12:36.151085 | instance | skipping: [instance]
2026-09-17 14:12:36.151303 | instance |
2026-09-17 14:12:36.151952 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-17 14:12:36.152214 | instance | Thursday 17 September 2026  14:12:36 +0000 (0:00:00.042)       0:00:10.737 ****
2026-09-17 14:12:36.197364 | instance | skipping: [instance]
2026-09-17 14:12:36.197649 | instance |
2026-09-17 14:12:36.197865 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-17 14:12:36.198062 | instance | Thursday 17 September 2026  14:12:36 +0000 (0:00:00.045)       0:00:10.782 ****
2026-09-17 14:12:36.235584 | instance | skipping: [instance]
2026-09-17 14:12:36.235751 | instance |
2026-09-17 14:12:36.235953 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-17 14:12:36.236155 | instance | Thursday 17 September 2026  14:12:36 +0000 (0:00:00.039)       0:00:10.822 ****
2026-09-17 14:12:42.186801 | instance | changed: [instance]
2026-09-17 14:12:42.187189 | instance |
2026-09-17 14:12:42.187559 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-17 14:12:42.187866 | instance | Thursday 17 September 2026  14:12:42 +0000 (0:00:05.950)       0:00:16.772 ****
2026-09-17 14:12:42.795181 | instance | changed: [instance]
2026-09-17 14:12:42.795394 | instance |
2026-09-17 14:12:42.795794 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-17 14:12:42.795846 | instance | Thursday 17 September 2026  14:12:42 +0000 (0:00:00.608)       0:00:17.381 ****
2026-09-17 14:12:43.790906 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-17 14:12:43.791064 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-17 14:12:43.792343 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-17 14:12:43.792411 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-17 14:12:43.792423 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-17 14:12:43.792432 | instance |
2026-09-17 14:12:43.792441 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-17 14:12:43.792450 | instance | Thursday 17 September 2026  14:12:43 +0000 (0:00:00.996)       0:00:18.377 ****
2026-09-17 14:12:44.412464 | instance | changed: [instance]
2026-09-17 14:12:44.412520 | instance |
2026-09-17 14:12:44.413025 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-17 14:12:44.413040 | instance | Thursday 17 September 2026  14:12:44 +0000 (0:00:00.602)       0:00:18.979 ****
2026-09-17 14:12:44.413045 | instance |
2026-09-17 14:12:44.413050 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-17 14:12:44.413054 | instance | Thursday 17 September 2026  14:12:44 +0000 (0:00:00.019)       0:00:18.999 ****
2026-09-17 14:12:45.380580 | instance | ok: [instance]
2026-09-17 14:12:45.381324 | instance |
2026-09-17 14:12:45.381401 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-17 14:12:45.381414 | instance | Thursday 17 September 2026  14:12:45 +0000 (0:00:00.966)       0:00:19.966 ****
2026-09-17 14:12:45.855161 | instance | changed: [instance]
2026-09-17 14:12:45.855333 | instance |
2026-09-17 14:12:45.855652 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-17 14:12:45.855710 | instance | Thursday 17 September 2026  14:12:45 +0000 (0:00:00.475)       0:00:20.441 ****
2026-09-17 14:12:46.441680 | instance | changed: [instance]
2026-09-17 14:12:46.441801 | instance |
2026-09-17 14:12:46.442166 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-17 14:12:46.442246 | instance | Thursday 17 September 2026  14:12:46 +0000 (0:00:00.586)       0:00:21.027 ****
2026-09-17 14:12:46.693782 | instance | ok: [instance]
2026-09-17 14:12:46.693959 | instance |
2026-09-17 14:12:46.694554 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-17 14:12:46.694624 | instance | Thursday 17 September 2026  14:12:46 +0000 (0:00:00.251)       0:00:21.279 ****
2026-09-17 14:12:46.761982 | instance | ok: [instance] => {
2026-09-17 14:12:46.762116 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-17 14:12:46.762590 | instance | }
2026-09-17 14:12:46.762623 | instance |
2026-09-17 14:12:46.762636 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-17 14:12:46.762754 | instance | Thursday 17 September 2026  14:12:46 +0000 (0:00:00.068)       0:00:21.348 ****
2026-09-17 14:12:47.664905 | instance | changed: [instance]
2026-09-17 14:12:47.664987 | instance |
2026-09-17 14:12:47.665047 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-17 14:12:47.665207 | instance | Thursday 17 September 2026  14:12:47 +0000 (0:00:00.903)       0:00:22.251 ****
2026-09-17 14:12:52.121729 | instance | changed: [instance]
2026-09-17 14:12:52.121804 | instance |
2026-09-17 14:12:52.122156 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-17 14:12:52.122316 | instance | Thursday 17 September 2026  14:12:52 +0000 (0:00:04.456)       0:00:26.708 ****
2026-09-17 14:12:53.279078 | instance | ok: [instance]
2026-09-17 14:12:53.279134 | instance |
2026-09-17 14:12:53.279146 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-17 14:12:53.279156 | instance | Thursday 17 September 2026  14:12:53 +0000 (0:00:01.156)       0:00:27.864 ****
2026-09-17 14:12:53.663613 | instance | changed: [instance]
2026-09-17 14:12:53.664588 | instance |
2026-09-17 14:12:53.664624 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-17 14:12:53.664638 | instance | Thursday 17 September 2026  14:12:53 +0000 (0:00:00.385)       0:00:28.249 ****
2026-09-17 14:12:54.190422 | instance | changed: [instance]
2026-09-17 14:12:54.191094 | instance |
2026-09-17 14:12:54.191153 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-17 14:12:54.191306 | instance | Thursday 17 September 2026  14:12:54 +0000 (0:00:00.526)       0:00:28.776 ****
2026-09-17 14:12:54.831272 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-17 14:12:54.831338 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-17 14:12:54.831807 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-17 14:12:54.831953 | instance |
2026-09-17 14:12:54.831960 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-17 14:12:54.831964 | instance | Thursday 17 September 2026  14:12:54 +0000 (0:00:00.641)       0:00:29.417 ****
2026-09-17 14:12:55.396749 | instance | changed: [instance]
2026-09-17 14:12:55.397392 | instance |
2026-09-17 14:12:55.397446 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-17 14:12:55.397456 | instance | Thursday 17 September 2026  14:12:55 +0000 (0:00:00.564)       0:00:29.982 ****
2026-09-17 14:12:55.943991 | instance | changed: [instance]
2026-09-17 14:12:55.944099 | instance |
2026-09-17 14:12:55.944949 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-17 14:12:55.945019 | instance | Thursday 17 September 2026  14:12:55 +0000 (0:00:00.521)       0:00:30.504 ****
2026-09-17 14:12:55.945029 | instance |
2026-09-17 14:12:55.945038 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-17 14:12:55.945052 | instance | Thursday 17 September 2026  14:12:55 +0000 (0:00:00.026)       0:00:30.530 ****
2026-09-17 14:12:56.724532 | instance | ok: [instance]
2026-09-17 14:12:56.724588 | instance |
2026-09-17 14:12:56.724602 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-17 14:12:56.724638 | instance | Thursday 17 September 2026  14:12:56 +0000 (0:00:00.778)       0:00:31.309 ****
2026-09-17 14:12:57.924472 | instance | changed: [instance]
2026-09-17 14:12:57.924560 | instance |
2026-09-17 14:12:57.924914 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-17 14:12:57.924992 | instance | Thursday 17 September 2026  14:12:57 +0000 (0:00:01.200)       0:00:32.509 ****
2026-09-17 14:12:58.570723 | instance | changed: [instance]
2026-09-17 14:12:58.570847 | instance |
2026-09-17 14:12:58.571184 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-17 14:12:58.571306 | instance | Thursday 17 September 2026  14:12:58 +0000 (0:00:00.646)       0:00:33.156 ****
2026-09-17 14:12:58.661112 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-17 14:12:58.661622 | instance |
2026-09-17 14:12:58.661707 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-17 14:12:58.661716 | instance | Thursday 17 September 2026  14:12:58 +0000 (0:00:00.090)       0:00:33.246 ****
2026-09-17 14:13:04.607673 | instance | changed: [instance]
2026-09-17 14:13:04.608564 | instance |
2026-09-17 14:13:04.608717 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-17 14:13:04.608730 | instance | Thursday 17 September 2026  14:13:04 +0000 (0:00:05.946)       0:00:39.193 ****
2026-09-17 14:13:05.255001 | instance | ok: [instance] => (item=chronyd)
2026-09-17 14:13:05.255068 | instance | ok: [instance] => (item=sshd)
2026-09-17 14:13:05.255424 | instance |
2026-09-17 14:13:05.255471 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-17 14:13:05.255476 | instance | Thursday 17 September 2026  14:13:05 +0000 (0:00:00.648)       0:00:39.841 ****
2026-09-17 14:13:07.846824 | instance | changed: [instance]
2026-09-17 14:13:07.847183 | instance |
2026-09-17 14:13:07.847295 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-17 14:13:07.847597 | instance | Thursday 17 September 2026  14:13:07 +0000 (0:00:02.591)       0:00:42.432 ****
2026-09-17 14:13:08.077326 | instance | ok: [instance]
2026-09-17 14:13:08.077390 | instance |
2026-09-17 14:13:08.077640 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-17 14:13:08.077677 | instance | Thursday 17 September 2026  14:13:08 +0000 (0:00:00.230)       0:00:42.663 ****
2026-09-17 14:13:08.556083 | instance | changed: [instance]
2026-09-17 14:13:08.556934 | instance |
2026-09-17 14:13:08.556993 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-17 14:13:08.557007 | instance | Thursday 17 September 2026  14:13:08 +0000 (0:00:00.478)       0:00:43.141 ****
2026-09-17 14:13:08.950976 | instance | changed: [instance]
2026-09-17 14:13:08.951499 | instance |
2026-09-17 14:13:08.951523 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-17 14:13:08.951531 | instance | Thursday 17 September 2026  14:13:08 +0000 (0:00:00.395)       0:00:43.537 ****
2026-09-17 14:13:09.094267 | instance | ok: [instance]
2026-09-17 14:13:09.095316 | instance |
2026-09-17 14:13:09.095522 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-17 14:13:09.095546 | instance | Thursday 17 September 2026  14:13:09 +0000 (0:00:00.142)       0:00:43.679 ****
2026-09-17 14:13:09.348849 | instance | ok: [instance] => (item=instance)
2026-09-17 14:13:09.348973 | instance |
2026-09-17 14:13:09.349043 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-17 14:13:09.349213 | instance | Thursday 17 September 2026  14:13:09 +0000 (0:00:00.255)       0:00:43.935 ****
2026-09-17 14:13:09.417572 | instance | ok: [instance]
2026-09-17 14:13:09.417623 | instance |
2026-09-17 14:13:09.417904 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-17 14:13:09.417971 | instance | Thursday 17 September 2026  14:13:09 +0000 (0:00:00.068)       0:00:44.003 ****
2026-09-17 14:13:09.517845 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-17 14:13:09.517959 | instance |
2026-09-17 14:13:09.517983 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-17 14:13:09.518168 | instance | Thursday 17 September 2026  14:13:09 +0000 (0:00:00.100)       0:00:44.103 ****
2026-09-17 14:13:09.860939 | instance | changed: [instance]
2026-09-17 14:13:09.861004 | instance |
2026-09-17 14:13:09.861229 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-17 14:13:09.861265 | instance | Thursday 17 September 2026  14:13:09 +0000 (0:00:00.343)       0:00:44.447 ****
2026-09-17 14:13:10.702603 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-17 14:13:10.702725 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-17 14:13:10.702738 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-17 14:13:10.703133 | instance |
2026-09-17 14:13:10.703201 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-17 14:13:10.703208 | instance | Thursday 17 September 2026  14:13:10 +0000 (0:00:00.841)       0:00:45.288 ****
2026-09-17 14:14:46.516911 | instance | ok: [instance]
2026-09-17 14:14:46.516963 | instance |
2026-09-17 14:14:46.516975 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-17 14:14:46.516985 | instance | Thursday 17 September 2026  14:14:46 +0000 (0:01:35.813)       0:02:21.102 ****
2026-09-17 14:14:46.752154 | instance | changed: [instance]
2026-09-17 14:14:46.752396 | instance |
2026-09-17 14:14:46.752622 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-17 14:14:46.752851 | instance | Thursday 17 September 2026  14:14:46 +0000 (0:00:00.235)       0:02:21.338 ****
2026-09-17 14:14:46.797145 | instance | ok: [instance]
2026-09-17 14:14:46.797352 | instance |
2026-09-17 14:14:46.797649 | instance | TASK [Install Ceph host] *******************************************************
2026-09-17 14:14:46.797897 | instance | Thursday 17 September 2026  14:14:46 +0000 (0:00:00.045)       0:02:21.383 ****
2026-09-17 14:14:46.916530 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-17 14:14:46.916593 | instance |
2026-09-17 14:14:46.916809 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-17 14:14:46.916851 | instance | Thursday 17 September 2026  14:14:46 +0000 (0:00:00.119)       0:02:21.503 ****
2026-09-17 14:14:48.573691 | instance | ok: [instance]
2026-09-17 14:14:48.573759 | instance |
2026-09-17 14:14:48.573788 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-17 14:14:48.573803 | instance | Thursday 17 September 2026  14:14:48 +0000 (0:00:01.655)       0:02:23.158 ****
2026-09-17 14:14:48.637794 | instance | ok: [instance] => (item=instance)
2026-09-17 14:14:48.637850 | instance |
2026-09-17 14:14:48.637862 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-17 14:14:48.637872 | instance | Thursday 17 September 2026  14:14:48 +0000 (0:00:00.063)       0:02:23.222 ****
2026-09-17 14:14:49.008640 | instance | ok: [instance]
2026-09-17 14:14:49.008720 | instance |
2026-09-17 14:14:49.008732 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-17 14:14:49.008743 | instance | Thursday 17 September 2026  14:14:49 +0000 (0:00:00.370)       0:02:23.593 ****
2026-09-17 14:14:51.400169 | instance | ok: [instance]
2026-09-17 14:14:51.400752 | instance |
2026-09-17 14:14:51.400779 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-17 14:14:51.400789 | instance | Thursday 17 September 2026  14:14:51 +0000 (0:00:02.392)       0:02:25.986 ****
2026-09-17 14:15:47.142788 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-17 14:15:47.143575 | 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_ksu57yq8/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_ksu57yq8/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_ksu57yq8/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_ksu57yq8/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCu9atqXV+EGyAA1Sw4fSn/7mFO+HrG5Zc37uWJBrHnvUTKWeEM7N5tYIQ=: Malformed input [buffer:3]\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCu9atqXV+EGyAA1Sw4fSn/7mFO+HrG5Zc37uWJBrHnvUTKWeEM7N5tYIQ=: Malformed input [buffer:3]\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCu9atqXV+EGyAA1Sw4fSn/7mFO+HrG5Zc37uWJBrHnvUTKWeEM7N5tYIQ=: Malformed input [buffer:3]\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T14:15:46.974+0000 7f245c803640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-17 14:15:47.145559 | instance |
2026-09-17 14:15:47.145699 | instance | PLAY RECAP *********************************************************************
2026-09-17 14:15:47.145869 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-09-17 14:15:47.147094 | instance |
2026-09-17 14:15:47.147147 | instance | Thursday 17 September 2026  14:15:47 +0000 (0:00:55.746)       0:03:21.732 ****
2026-09-17 14:15:47.147155 | instance | ===============================================================================
2026-09-17 14:15:47.147161 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 95.81s
2026-09-17 14:15:47.147167 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 55.75s
2026-09-17 14:15:47.147173 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.95s
2026-09-17 14:15:47.147178 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.95s
2026-09-17 14:15:47.147184 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.46s
2026-09-17 14:15:47.147196 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.00s
2026-09-17 14:15:47.149046 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 2.59s
2026-09-17 14:15:47.149094 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.39s
2026-09-17 14:15:47.149101 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.75s
2026-09-17 14:15:47.149107 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.66s
2026-09-17 14:15:47.149113 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.34s
2026-09-17 14:15:47.149120 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.20s
2026-09-17 14:15:47.149125 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.16s
2026-09-17 14:15:47.149131 | instance | Gathering Facts --------------------------------------------------------- 1.07s
2026-09-17 14:15:47.149137 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.00s
2026-09-17 14:15:47.149142 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-17 14:15:47.149148 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.95s
2026-09-17 14:15:47.149153 | instance | Gathering Facts --------------------------------------------------------- 0.94s
2026-09-17 14:15:47.149159 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.90s
2026-09-17 14:15:47.149164 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.84s
2026-09-17 14:15:47.264507 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-17 14:15:47.264802 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-17 14:15:47.264997 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-17 14:15:47.581047 | instance | ERROR
2026-09-17 14:15:47.581945 | instance | {
2026-09-17 14:15:47.582044 | instance |   "delta": "0:04:14.721966",
2026-09-17 14:15:47.582107 | instance |   "end": "2026-09-17 14:15:47.331326",
2026-09-17 14:15:47.582161 | instance |   "msg": "non-zero return code",
2026-09-17 14:15:47.582213 | instance |   "rc": 2,
2026-09-17 14:15:47.582266 | instance |   "start": "2026-09-17 14:11:32.609360"
2026-09-17 14:15:47.582320 | instance | }
failure
2026-09-17 14:15:47.592806 | 
2026-09-17 14:15:47.593016 | PLAY RECAP
2026-09-17 14:15:47.593324 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-17 14:15:47.593392 | 
2026-09-17 14:15:47.746186 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-17 14:15:47.750029 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-17 14:15:48.435800 | 
2026-09-17 14:15:48.436251 | PLAY [all]
2026-09-17 14:15:48.453036 | 
2026-09-17 14:15:48.453224 | TASK [gather-host-logs : creating directory for system status]
2026-09-17 14:15:48.843175 | instance | changed
2026-09-17 14:15:48.853689 | 
2026-09-17 14:15:48.853910 | TASK [gather-host-logs : Get logs for each host]
2026-09-17 14:15:49.211495 | instance | + systemd-cgls --full --all --no-pager
2026-09-17 14:15:49.229011 | instance | + ip addr
2026-09-17 14:15:49.232300 | instance | + ip route
2026-09-17 14:15:49.235089 | instance | + lsblk
2026-09-17 14:15:49.240453 | instance | + mount
2026-09-17 14:15:49.243276 | instance | + docker images
2026-09-17 14:15:49.265149 | instance | + brctl show
2026-09-17 14:15:49.265715 | instance | /bin/bash: line 8: brctl: command not found
2026-09-17 14:15:49.266042 | instance | + ip neigh
2026-09-17 14:15:49.268823 | instance | + bridge fdb show
2026-09-17 14:15:49.272833 | instance | + ps aux --sort=-%mem
2026-09-17 14:15:49.294608 | instance | + dpkg -l
2026-09-17 14:15:49.305828 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-17 14:15:49.306426 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-17 14:15:49.327956 | instance | + '[' '!' -z '' ']'
2026-09-17 14:15:49.398975 | instance | ok: Runtime: 0:00:00.121265
2026-09-17 14:15:49.409069 | 
2026-09-17 14:15:49.409278 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-17 14:15:50.113706 | instance | changed:
2026-09-17 14:15:50.113962 | instance | created directory /var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/logs/instance
2026-09-17 14:15:50.114020 | instance | cd+++++++++ system/
2026-09-17 14:15:50.114063 | instance | >f+++++++++ system/brctl-show.txt
2026-09-17 14:15:50.114103 | instance | >f+++++++++ system/bridge-fdb.txt
2026-09-17 14:15:50.114141 | instance | >f+++++++++ system/docker-images.txt
2026-09-17 14:15:50.114183 | instance | >f+++++++++ system/ip-addr.txt
2026-09-17 14:15:50.114224 | instance | >f+++++++++ system/ip-neigh.txt
2026-09-17 14:15:50.114262 | instance | >f+++++++++ system/ip-route.txt
2026-09-17 14:15:50.114305 | instance | >f+++++++++ system/lsblk.txt
2026-09-17 14:15:50.114342 | instance | >f+++++++++ system/mount.txt
2026-09-17 14:15:50.114378 | instance | >f+++++++++ system/packages.txt
2026-09-17 14:15:50.114414 | instance | >f+++++++++ system/ps.txt
2026-09-17 14:15:50.114453 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-17 14:15:50.131514 | 
2026-09-17 14:15:50.131639 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-17 14:15:50.360636 | instance | changed: "values"
2026-09-17 14:15:50.540647 | instance | changed: "releases"
2026-09-17 14:15:50.558508 | 
2026-09-17 14:15:50.558710 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-17 14:15:50.834309 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-17 14:15:51.112078 | instance | ok: Runtime: 0:00:00.005559
2026-09-17 14:15:51.122225 | 
2026-09-17 14:15:51.122367 | TASK [helm-release-status : Downloads logs to executor]
2026-09-17 14:15:51.632372 | instance | changed:
2026-09-17 14:15:51.632675 | instance | cd+++++++++ helm/
2026-09-17 14:15:51.632732 | instance | cd+++++++++ helm/releases/
2026-09-17 14:15:51.632773 | instance | cd+++++++++ helm/values/
2026-09-17 14:15:51.647721 | 
2026-09-17 14:15:51.647804 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-17 14:15:51.874352 | instance | changed
2026-09-17 14:15:51.885791 | 
2026-09-17 14:15:51.885936 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-17 14:15:52.190750 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-17 14:15:52.191458 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-17 14:15:52.197371 | instance | environment: line 1: kubectl: command not found
2026-09-17 14:15:52.198959 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-17 14:15:52.199920 | instance | environment: line 1: kubectl: command not found
2026-09-17 14:15:52.200671 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-17 14:15:52.202288 | instance | environment: line 1: kubectl: command not found
2026-09-17 14:15:52.204057 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-17 14:15:52.205927 | instance | environment: line 1: kubectl: command not found
2026-09-17 14:15:52.207431 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-17 14:15:52.208321 | instance | environment: line 1: kubectl: command not found
2026-09-17 14:15:52.209643 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-17 14:15:52.436392 | instance | ok: Runtime: 0:00:00.025667
2026-09-17 14:15:52.445104 | 
2026-09-17 14:15:52.445233 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-17 14:15:52.660865 | instance | changed
2026-09-17 14:15:52.670830 | 
2026-09-17 14:15:52.670970 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-17 14:15:52.926749 | instance | environment: line 5: kubectl: command not found
2026-09-17 14:15:52.927583 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-17 14:15:52.927654 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-17 14:15:52.928756 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-17 14:15:53.218026 | instance | ok: Runtime: 0:00:00.008679
2026-09-17 14:15:53.226361 | 
2026-09-17 14:15:53.226722 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-17 14:15:53.746740 | instance | changed:
2026-09-17 14:15:53.746999 | instance | cd+++++++++ objects/
2026-09-17 14:15:53.747052 | instance | cd+++++++++ objects/cluster/
2026-09-17 14:15:53.747092 | instance | cd+++++++++ objects/namespaced/
2026-09-17 14:15:53.765296 | 
2026-09-17 14:15:53.765517 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-17 14:15:53.989694 | instance | changed
2026-09-17 14:15:53.996263 | 
2026-09-17 14:15:53.996346 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-17 14:15:54.214942 | instance | changed
2026-09-17 14:15:54.224601 | 
2026-09-17 14:15:54.224812 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-17 14:15:54.482111 | instance | environment: line 3: kubectl: command not found
2026-09-17 14:15:54.773705 | instance | ok: Runtime: 0:00:00.007426
2026-09-17 14:15:54.783719 | 
2026-09-17 14:15:54.783845 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-17 14:15:55.315670 | instance | changed:
2026-09-17 14:15:55.315921 | instance | cd+++++++++ pod-logs/
2026-09-17 14:15:55.315976 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-17 14:15:55.335077 | 
2026-09-17 14:15:55.335264 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-17 14:15:55.554376 | instance | changed
2026-09-17 14:15:55.567071 | 
2026-09-17 14:15:55.567297 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-17 14:15:55.824891 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-17 14:15:56.110444 | instance | ok: Runtime: 0:00:00.052849
2026-09-17 14:15:56.114689 | 
2026-09-17 14:15:56.114752 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-17 14:15:56.330002 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-17 14:15:56.375100 | instance | ceph-mgr endpoints:
2026-09-17 14:15:56.644587 | instance | ok: Runtime: 0:00:00.050826
2026-09-17 14:15:56.654866 | 
2026-09-17 14:15:56.655014 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-17 14:15:56.903732 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-17 14:15:57.202498 | instance | ok: Runtime: 0:00:00.049705
2026-09-17 14:15:57.211873 | 
2026-09-17 14:15:57.212006 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-17 14:15:57.753458 | instance | changed: cd+++++++++ prometheus/
2026-09-17 14:15:57.772783 | 
2026-09-17 14:15:57.772988 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-17 14:15:57.991977 | instance | changed
2026-09-17 14:15:58.002065 | 
2026-09-17 14:15:58.002206 | TASK [gather-selenium-data : Get selenium data]
2026-09-17 14:15:58.309043 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-17 14:15:58.310361 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-17 14:15:58.558869 | instance | ERROR
2026-09-17 14:15:58.559144 | instance | {
2026-09-17 14:15:58.559201 | instance |   "delta": "0:00:00.005668",
2026-09-17 14:15:58.559240 | instance |   "end": "2026-09-17 14:15:58.310766",
2026-09-17 14:15:58.559277 | instance |   "msg": "non-zero return code",
2026-09-17 14:15:58.559310 | instance |   "rc": 1,
2026-09-17 14:15:58.559344 | instance |   "start": "2026-09-17 14:15:58.305098"
2026-09-17 14:15:58.559377 | instance | }
2026-09-17 14:15:58.559421 | instance | ERROR: Ignoring Errors
2026-09-17 14:15:58.568636 | 
2026-09-17 14:15:58.568754 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-17 14:15:59.079677 | instance | changed: cd+++++++++ selenium/
2026-09-17 14:15:59.091005 | 
2026-09-17 14:15:59.091119 | PLAY RECAP
2026-09-17 14:15:59.091210 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-17 14:15:59.091252 | 
2026-09-17 14:15:59.240598 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-17 14:15:59.245024 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-17 14:15:59.891726 | 
2026-09-17 14:15:59.892081 | PLAY [all]
2026-09-17 14:15:59.904117 | 
2026-09-17 14:15:59.904251 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-17 14:15:59.959421 | instance | skipping: Conditional result was False
2026-09-17 14:15:59.966673 | 
2026-09-17 14:15:59.966820 | TASK [fetch-output : Set log path for single node]
2026-09-17 14:16:00.010851 | instance | ok
2026-09-17 14:16:00.018514 | 
2026-09-17 14:16:00.018649 | LOOP [fetch-output : Ensure local output dirs]
2026-09-17 14:16:00.401208 | instance -> localhost | ok: "/var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/logs"
2026-09-17 14:16:00.638528 | instance -> localhost | changed: "/var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/artifacts"
2026-09-17 14:16:00.863215 | instance -> localhost | changed: "/var/lib/zuul/builds/08f41c75fc9149989f6f1410f8222fbf/work/docs"
2026-09-17 14:16:00.881455 | 
2026-09-17 14:16:00.881757 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-17 14:16:01.600208 | instance | changed: .d..t...... ./
2026-09-17 14:16:01.600661 | instance | changed: All items complete
2026-09-17 14:16:01.600743 | 
2026-09-17 14:16:02.088902 | instance | changed: .d..t...... ./
2026-09-17 14:16:02.578603 | instance | changed: .d..t...... ./
2026-09-17 14:16:02.604170 | 
2026-09-17 14:16:02.604420 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-17 14:16:03.079750 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008394
2026-09-17 14:16:03.308614 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006075
2026-09-17 14:16:03.328440 | 
2026-09-17 14:16:03.328606 | PLAY [all]
2026-09-17 14:16:03.334937 | 
2026-09-17 14:16:03.335050 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-17 14:16:03.733270 | instance | changed
2026-09-17 14:16:03.742654 | 
2026-09-17 14:16:03.742748 | PLAY RECAP
2026-09-17 14:16:03.742826 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-17 14:16:03.742869 | 
2026-09-17 14:16:03.860090 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-17 14:16:03.864275 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-17 14:16:04.397062 | 
2026-09-17 14:16:04.397200 | PLAY [localhost]
2026-09-17 14:16:04.406329 | 
2026-09-17 14:16:04.406398 | TASK [Generate Zuul manifest]
2026-09-17 14:16:04.421946 | localhost | ok
2026-09-17 14:16:04.436408 | 
2026-09-17 14:16:04.436546 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-17 14:16:04.807688 | localhost | changed
2026-09-17 14:16:04.820873 | 
2026-09-17 14:16:04.820981 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-17 14:16:04.848292 | localhost | ok
2026-09-17 14:16:04.858317 | 
2026-09-17 14:16:04.858434 | TASK [Upload logs]
2026-09-17 14:16:04.879370 | localhost | ok
2026-09-17 14:16:04.950896 | 
2026-09-17 14:16:04.951031 | TASK [Set zuul-log-path fact]
2026-09-17 14:16:04.967545 | localhost | ok
2026-09-17 14:16:04.979399 | 
2026-09-17 14:16:04.979479 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-17 14:16:05.005221 | localhost | ok
2026-09-17 14:16:05.011746 | 
2026-09-17 14:16:05.011835 | TASK [upload-logs : Create log directories]
2026-09-17 14:16:05.415357 | localhost | changed
2026-09-17 14:16:05.424753 | 
2026-09-17 14:16:05.424892 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-17 14:16:05.856358 | localhost -> localhost | ok: Runtime: 0:00:00.005127
2026-09-17 14:16:05.860679 | 
2026-09-17 14:16:05.860741 | TASK [upload-logs : Upload logs to log server]
2026-09-17 14:16:06.346520 | localhost | Output suppressed because no_log was given
2026-09-17 14:16:06.389179 | 
2026-09-17 14:16:06.389339 | LOOP [upload-logs : Compress console log and json output]
2026-09-17 14:16:06.452193 | localhost | skipping: Conditional result was False
2026-09-17 14:16:06.461736 | localhost | skipping: Conditional result was False
2026-09-17 14:16:06.471309 | 
2026-09-17 14:16:06.471535 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-17 14:16:06.531184 | localhost | skipping: Conditional result was False
2026-09-17 14:16:06.531563 | 
2026-09-17 14:16:06.539896 | localhost | skipping: Conditional result was False
2026-09-17 14:16:06.554033 | 
2026-09-17 14:16:06.554257 | LOOP [upload-logs : Upload console log and json output]