2026-09-12 03:55:51.897232 | Job console starting
2026-09-12 03:55:51.937095 | Updating git repos
2026-09-12 03:55:57.219862 | Cloning repos into workspace
2026-09-12 03:56:12.170228 | Restoring repo states
2026-09-12 03:56:21.818358 | Merging changes
2026-09-12 03:56:23.575874 | Checking out repos
2026-09-12 03:56:29.932445 | Preparing playbooks
2026-09-12 03:56:33.203252 | Running Ansible setup
2026-09-12 03:56:36.703559 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-12 03:56:37.295862 | 
2026-09-12 03:56:37.296010 | PLAY [localhost]
2026-09-12 03:56:37.305021 | 
2026-09-12 03:56:37.305108 | TASK [Gathering Facts]
2026-09-12 03:56:39.173124 | localhost | ok
2026-09-12 03:56:39.186112 | 
2026-09-12 03:56:39.186267 | TASK [Setup log path fact]
2026-09-12 03:56:39.207242 | localhost | ok
2026-09-12 03:56:39.227209 | 
2026-09-12 03:56:39.227374 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-12 03:56:39.268403 | localhost | ok
2026-09-12 03:56:39.280719 | 
2026-09-12 03:56:39.280881 | TASK [emit-job-header : Print job information]
2026-09-12 03:56:39.331926 | # Job Information
2026-09-12 03:56:39.332191 | Ansible Version: 2.16.18
2026-09-12 03:56:39.332242 | Job: atmosphere-molecule-csi-rbd
2026-09-12 03:56:39.332285 | Pipeline: check
2026-09-12 03:56:39.332321 | Executor: 2d72f0692154
2026-09-12 03:56:39.332356 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4368
2026-09-12 03:56:39.332393 | Event ID: eb99de70-ae5c-11f1-83d1-ffe5cb97fde1
2026-09-12 03:56:39.337991 | 
2026-09-12 03:56:39.338186 | LOOP [emit-job-header : Print node information]
2026-09-12 03:56:39.435528 | localhost | ok:
2026-09-12 03:56:39.435806 | localhost | # Node Information
2026-09-12 03:56:39.435865 | localhost | Inventory Hostname: instance
2026-09-12 03:56:39.435909 | localhost | Hostname: np0000192696
2026-09-12 03:56:39.435949 | localhost | Username: zuul
2026-09-12 03:56:39.435994 | localhost | Distro: Ubuntu 22.04
2026-09-12 03:56:39.436033 | localhost | Provider: yul1
2026-09-12 03:56:39.436071 | localhost | Region: ca-ymq-1
2026-09-12 03:56:39.436107 | localhost | Label: ubuntu-jammy
2026-09-12 03:56:39.436142 | localhost | Product Name: OpenStack Nova
2026-09-12 03:56:39.436179 | localhost | Interface IP: 162.253.55.208
2026-09-12 03:56:39.447660 | 
2026-09-12 03:56:39.447818 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-12 03:56:39.888737 | localhost -> localhost | changed
2026-09-12 03:56:39.898316 | 
2026-09-12 03:56:39.898509 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-12 03:56:40.823664 | localhost -> localhost | changed
2026-09-12 03:56:40.830959 | 
2026-09-12 03:56:40.831013 | PLAY [all]
2026-09-12 03:56:40.839389 | 
2026-09-12 03:56:40.839466 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-12 03:56:41.099411 | instance -> localhost | ok
2026-09-12 03:56:41.108446 | 
2026-09-12 03:56:41.108661 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-12 03:56:41.140515 | instance | ok
2026-09-12 03:56:41.155017 | instance | included: /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-12 03:56:41.161002 | 
2026-09-12 03:56:41.161097 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-12 03:56:42.107416 | instance -> localhost | Generating public/private rsa key pair.
2026-09-12 03:56:42.107618 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/db6669bc16154554a283978f9926bd62_id_rsa
2026-09-12 03:56:42.107648 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/db6669bc16154554a283978f9926bd62_id_rsa.pub
2026-09-12 03:56:42.107669 | instance -> localhost | The key fingerprint is:
2026-09-12 03:56:42.107689 | instance -> localhost | SHA256:WxD6M/EcCMUbE6Kv21FhmFT+uNe2/odIR9zSTYQgCn8 zuul-build-sshkey
2026-09-12 03:56:42.107720 | instance -> localhost | The key's randomart image is:
2026-09-12 03:56:42.107763 | instance -> localhost | +---[RSA 3072]----+
2026-09-12 03:56:42.107803 | instance -> localhost | |      =+=.. .. o.|
2026-09-12 03:56:42.107824 | instance -> localhost | |     o X++ .  . .|
2026-09-12 03:56:42.107842 | instance -> localhost | |    . + X+E  . +.|
2026-09-12 03:56:42.107860 | instance -> localhost | |     . o.X .  + +|
2026-09-12 03:56:42.107878 | instance -> localhost | |      . S =  . . |
2026-09-12 03:56:42.107895 | instance -> localhost | |     . . * .. .  |
2026-09-12 03:56:42.107912 | instance -> localhost | |    . . o ..oo . |
2026-09-12 03:56:42.107960 | instance -> localhost | |     o . . .... .|
2026-09-12 03:56:42.107986 | instance -> localhost | |    . .    .o... |
2026-09-12 03:56:42.108004 | instance -> localhost | +----[SHA256]-----+
2026-09-12 03:56:42.108051 | instance -> localhost | ok: Runtime: 0:00:00.420968
2026-09-12 03:56:42.125702 | 
2026-09-12 03:56:42.125956 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-12 03:56:42.166946 | instance | ok
2026-09-12 03:56:42.179517 | instance | included: /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-12 03:56:42.189287 | 
2026-09-12 03:56:42.189378 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-12 03:56:42.214321 | instance | skipping: Conditional result was False
2026-09-12 03:56:42.222864 | 
2026-09-12 03:56:42.222998 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-12 03:56:42.714305 | instance | changed
2026-09-12 03:56:42.731882 | 
2026-09-12 03:56:42.732098 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-12 03:56:42.942858 | instance | ok
2026-09-12 03:56:42.957999 | 
2026-09-12 03:56:42.958192 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-12 03:56:43.490470 | instance | changed
2026-09-12 03:56:43.501079 | 
2026-09-12 03:56:43.501170 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-12 03:56:44.004160 | instance | changed
2026-09-12 03:56:44.016979 | 
2026-09-12 03:56:44.017195 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-12 03:56:44.042511 | instance | skipping: Conditional result was False
2026-09-12 03:56:44.055538 | 
2026-09-12 03:56:44.055731 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-12 03:56:44.455090 | instance -> localhost | changed
2026-09-12 03:56:44.465109 | 
2026-09-12 03:56:44.465169 | TASK [add-build-sshkey : Add back temp key]
2026-09-12 03:56:44.803846 | instance -> localhost | Identity added: /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/db6669bc16154554a283978f9926bd62_id_rsa (zuul-build-sshkey)
2026-09-12 03:56:44.804080 | instance -> localhost | ok: Runtime: 0:00:00.016178
2026-09-12 03:56:44.812030 | 
2026-09-12 03:56:44.812199 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-12 03:56:45.169182 | instance | ok
2026-09-12 03:56:45.185313 | 
2026-09-12 03:56:45.185506 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-12 03:56:45.209759 | instance | skipping: Conditional result was False
2026-09-12 03:56:45.225489 | 
2026-09-12 03:56:45.225575 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-12 03:56:45.590768 | instance | ok
2026-09-12 03:56:45.604762 | 
2026-09-12 03:56:45.604927 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-12 03:56:49.624553 | instance | Output suppressed because no_log was given
2026-09-12 03:56:49.636315 | 
2026-09-12 03:56:49.636446 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-12 03:56:49.861360 | instance | ok: "logs"
2026-09-12 03:56:49.900165 | instance | ok: All items complete
2026-09-12 03:56:49.900302 | 
2026-09-12 03:56:50.035221 | instance | ok: "artifacts"
2026-09-12 03:56:50.224015 | instance | ok: "docs"
2026-09-12 03:56:50.236910 | 
2026-09-12 03:56:50.237033 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-12 03:56:50.460209 | instance | changed: "logs"
2026-09-12 03:56:50.635316 | instance | changed: "artifacts"
2026-09-12 03:56:50.815380 | instance | changed: "docs"
2026-09-12 03:56:50.845669 | 
2026-09-12 03:56:50.845856 | PLAY RECAP
2026-09-12 03:56:50.845949 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-12 03:56:50.846005 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-12 03:56:50.846049 | 
2026-09-12 03:56:51.087614 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-12 03:56:51.097704 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-12 03:56:51.798049 | 
2026-09-12 03:56:51.798197 | PLAY [all]
2026-09-12 03:56:51.808461 | 
2026-09-12 03:56:51.808674 | TASK [setup-uv : Extract archive]
2026-09-12 03:56:54.007922 | instance | changed
2026-09-12 03:56:54.022701 | 
2026-09-12 03:56:54.022970 | TASK [setup-uv : Print version]
2026-09-12 03:56:54.397144 | instance | uv 0.8.13
2026-09-12 03:56:54.574367 | instance | ok: Runtime: 0:00:00.007786
2026-09-12 03:56:54.591549 | 
2026-09-12 03:56:54.591680 | TASK [Install Ansible collection siblings]
2026-09-12 03:57:04.937345 | instance | changed:
2026-09-12 03:57:04.937551 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-12 03:57:04.937587 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-12 03:57:04.937614 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-12 03:57:04.937638 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-12 03:57:04.937662 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-12 03:57:04.937691 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-12 03:57:04.937716 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-12 03:57:04.937741 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-12 03:57:04.937766 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-12 03:57:04.937803 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-12 03:57:04.937829 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-12 03:57:04.937852 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-12 03:57:04.937874 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-12 03:57:04.937897 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-12 03:57:04.937919 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-12 03:57:04.937943 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-12 03:57:04.937965 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-12 03:57:04.937988 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-12 03:57:04.938010 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-12 03:57:04.938033 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-12 03:57:04.938055 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-12 03:57:04.938077 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-12 03:57:04.938101 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-12 03:57:04.938140 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-12 03:57:04.938164 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-12 03:57:04.938187 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-12 03:57:04.938209 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-12 03:57:04.938231 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-12 03:57:04.938253 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-12 03:57:04.938275 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-12 03:57:04.938298 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-12 03:57:04.938320 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-12 03:57:04.938342 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-12 03:57:04.938365 | 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-12 03:57:04.938394 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.938416 | instance | Process install dependency map
2026-09-12 03:57:04.938438 | instance | Starting collection install process
2026-09-12 03:57:04.938459 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-12 03:57:04.938480 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-12 03:57:04.938564 | instance | ansible.netcommon:* was installed successfully
2026-09-12 03:57:04.938591 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-12 03:57:04.938614 | instance | Creating virtual environment at: .venv
2026-09-12 03:57:04.938636 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-12 03:57:04.938658 | instance |    Building pyperclip==1.9.0
2026-09-12 03:57:04.938680 | instance | Downloading rjsonnet (1.2MiB)
2026-09-12 03:57:04.938707 | instance |  Downloading rjsonnet
2026-09-12 03:57:04.938730 | instance | Downloading cryptography (4.2MiB)
2026-09-12 03:57:04.938751 | instance | Downloading ansible-core (2.1MiB)
2026-09-12 03:57:04.938772 | instance |  Downloading cryptography
2026-09-12 03:57:04.938808 | instance | Downloading netaddr (2.2MiB)
2026-09-12 03:57:04.938831 | instance | Downloading setuptools (1.1MiB)
2026-09-12 03:57:04.938852 | instance |  Downloading netaddr
2026-09-12 03:57:04.938874 | instance | Downloading pygments (1.2MiB)
2026-09-12 03:57:04.938897 | instance |  Downloading setuptools
2026-09-12 03:57:04.938919 | instance |  Downloading pygments
2026-09-12 03:57:04.938941 | instance |  Downloading ansible-core
2026-09-12 03:57:04.938962 | instance | Downloading kubernetes (1.9MiB)
2026-09-12 03:57:04.938984 | instance | Downloading openstacksdk (1.7MiB)
2026-09-12 03:57:04.939005 | instance |  Downloading kubernetes
2026-09-12 03:57:04.939025 | instance |  Downloading openstacksdk
2026-09-12 03:57:04.939046 | instance |       Built pyperclip==1.9.0
2026-09-12 03:57:04.939067 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-12 03:57:04.939089 | instance | Installed 79 packages in 54ms
2026-09-12 03:57:04.939111 | instance | Checked out ansible.posix to 1.6.0
2026-09-12 03:57:04.939132 | 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-12 03:57:04.939154 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.939175 | instance | Process install dependency map
2026-09-12 03:57:04.939199 | instance | Starting collection install process
2026-09-12 03:57:04.939221 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-12 03:57:04.939249 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-12 03:57:04.939271 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-12 03:57:04.939292 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.939314 | instance | 2.17.12
2026-09-12 03:57:04.939335 | instance | Checked out ansible.utils to v6.1.0
2026-09-12 03:57:04.939356 | 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-12 03:57:04.939378 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.939398 | instance | Process install dependency map
2026-09-12 03:57:04.939420 | instance | Starting collection install process
2026-09-12 03:57:04.939441 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-12 03:57:04.939462 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-12 03:57:04.939484 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-12 03:57:04.939507 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.939528 | instance | 2.17.12
2026-09-12 03:57:04.939550 | instance | Checked out atmosphere.common to v0.7.0
2026-09-12 03:57:04.939571 | 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-12 03:57:04.939592 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.939613 | instance | Process install dependency map
2026-09-12 03:57:04.939634 | instance | Starting collection install process
2026-09-12 03:57:04.939655 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-12 03:57:04.939676 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-12 03:57:04.939698 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-12 03:57:04.939719 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.939739 | instance | 2.17.12
2026-09-12 03:57:04.939760 | instance | Checked out community.crypto to 2.2.3
2026-09-12 03:57:04.939782 | 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-12 03:57:04.939821 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.939843 | instance | Process install dependency map
2026-09-12 03:57:04.939863 | instance | Starting collection install process
2026-09-12 03:57:04.939884 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-12 03:57:04.939905 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-12 03:57:04.939926 | instance | community.crypto:2.2.3 was installed successfully
2026-09-12 03:57:04.939947 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.939968 | instance | 2.17.12
2026-09-12 03:57:04.939989 | instance | Checked out community.general to 7.3.0
2026-09-12 03:57:04.940010 | 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-12 03:57:04.940032 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.940058 | instance | Process install dependency map
2026-09-12 03:57:04.940080 | instance | Starting collection install process
2026-09-12 03:57:04.940101 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-12 03:57:04.940122 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-12 03:57:04.940143 | instance | community.general:7.3.0 was installed successfully
2026-09-12 03:57:04.940164 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.940185 | instance | 2.17.12
2026-09-12 03:57:04.940206 | instance | Checked out community.mysql to 3.6.0
2026-09-12 03:57:04.940227 | 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-12 03:57:04.940248 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.940271 | instance | Process install dependency map
2026-09-12 03:57:04.940294 | instance | Starting collection install process
2026-09-12 03:57:04.940315 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-12 03:57:04.940336 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-12 03:57:04.940358 | instance | community.mysql:3.6.0 was installed successfully
2026-09-12 03:57:04.940380 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.940402 | instance | 2.17.12
2026-09-12 03:57:04.940423 | instance | Checked out kubernetes.core to 2.4.0
2026-09-12 03:57:04.940445 | 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-12 03:57:04.940466 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.940487 | instance | Process install dependency map
2026-09-12 03:57:04.940533 | instance | Starting collection install process
2026-09-12 03:57:04.940556 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-12 03:57:04.940578 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-12 03:57:04.940599 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-12 03:57:04.940620 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.940642 | instance | 2.17.12
2026-09-12 03:57:04.940663 | instance | Checked out openstack.cloud to 2.6.0
2026-09-12 03:57:04.940685 | 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-12 03:57:04.940706 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.940727 | instance | Process install dependency map
2026-09-12 03:57:04.940748 | instance | Starting collection install process
2026-09-12 03:57:04.940769 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-12 03:57:04.940806 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-12 03:57:04.940829 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-12 03:57:04.940850 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.940871 | instance | 2.17.12
2026-09-12 03:57:04.940892 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-12 03:57:04.940914 | 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-12 03:57:04.940942 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.940965 | instance | Process install dependency map
2026-09-12 03:57:04.940986 | instance | Starting collection install process
2026-09-12 03:57:04.941007 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-12 03:57:04.941028 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-12 03:57:04.941050 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-12 03:57:04.941071 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.941092 | instance | 2.17.12
2026-09-12 03:57:04.941114 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-12 03:57:04.941135 | 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-12 03:57:04.941157 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.941178 | instance | Process install dependency map
2026-09-12 03:57:04.941199 | instance | Starting collection install process
2026-09-12 03:57:04.941221 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-12 03:57:04.941242 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-12 03:57:04.941264 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-12 03:57:04.941286 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.941307 | instance | 2.17.12
2026-09-12 03:57:04.941329 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-12 03:57:04.941351 | 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-12 03:57:04.941374 | instance | Starting galaxy collection install process
2026-09-12 03:57:04.941395 | instance | Process install dependency map
2026-09-12 03:57:04.941415 | instance | Starting collection install process
2026-09-12 03:57:04.941436 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-12 03:57:04.941458 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-12 03:57:04.941479 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-12 03:57:04.941500 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-12 03:57:04.941521 | instance | 2.17.12
2026-09-12 03:57:04.948395 | 
2026-09-12 03:57:04.948455 | PLAY RECAP
2026-09-12 03:57:04.948723 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-12 03:57:04.948764 | 
2026-09-12 03:57:05.068824 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-12 03:57:05.070634 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-12 03:57:05.644639 | 
2026-09-12 03:57:05.644757 | PLAY [all]
2026-09-12 03:57:05.655050 | 
2026-09-12 03:57:05.655132 | TASK [Install "jq" for log collection]
2026-09-12 03:57:14.696153 | instance | changed
2026-09-12 03:57:14.701000 | 
2026-09-12 03:57:14.701162 | PLAY RECAP
2026-09-12 03:57:14.701312 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-12 03:57:14.701449 | 
2026-09-12 03:57:14.834256 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-12 03:57:14.836115 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-12 03:57:15.398501 | 
2026-09-12 03:57:15.398626 | PLAY [all]
2026-09-12 03:57:15.408591 | 
2026-09-12 03:57:15.408656 | LOOP [Check inventory directories]
2026-09-12 03:57:15.757718 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-12 03:57:15.939202 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-12 03:57:16.113659 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-12 03:57:16.126460 | 
2026-09-12 03:57:16.126629 | LOOP [Copy inventory file for Zuul]
2026-09-12 03:57:16.929978 | instance | changed:
2026-09-12 03:57:16.930277 | instance | {
2026-09-12 03:57:16.930353 | instance |   "ansible_loop_var": "item",
2026-09-12 03:57:16.930406 | instance |   "changed": false,
2026-09-12 03:57:16.930453 | instance |   "failed": false,
2026-09-12 03:57:16.930504 | instance |   "invocation": {
2026-09-12 03:57:16.930558 | instance |     "module_args": {
2026-09-12 03:57:16.930601 | instance |       "checksum_algorithm": "sha1",
2026-09-12 03:57:16.930643 | instance |       "follow": true,
2026-09-12 03:57:16.930685 | instance |       "get_attributes": true,
2026-09-12 03:57:16.930729 | instance |       "get_checksum": true,
2026-09-12 03:57:16.930770 | instance |       "get_mime": true,
2026-09-12 03:57:16.930833 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-12 03:57:16.930876 | instance |     }
2026-09-12 03:57:16.930916 | instance |   },
2026-09-12 03:57:16.930956 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-12 03:57:16.930996 | instance |   "stat": {
2026-09-12 03:57:16.931036 | instance |     "atime": 1789185417.9333,
2026-09-12 03:57:16.931076 | instance |     "attr_flags": "e",
2026-09-12 03:57:16.931116 | instance |     "attributes": [
2026-09-12 03:57:16.931157 | instance |       "extents"
2026-09-12 03:57:16.931197 | instance |     ],
2026-09-12 03:57:16.931237 | instance |     "block_size": 4096,
2026-09-12 03:57:16.931278 | instance |     "blocks": 8,
2026-09-12 03:57:16.931318 | instance |     "charset": "unknown",
2026-09-12 03:57:16.931363 | instance |     "ctime": 1789185415.5651639,
2026-09-12 03:57:16.931405 | instance |     "dev": 64513,
2026-09-12 03:57:16.931445 | instance |     "device_type": 0,
2026-09-12 03:57:16.931486 | instance |     "executable": true,
2026-09-12 03:57:16.931526 | instance |     "exists": true,
2026-09-12 03:57:16.931566 | instance |     "gid": 1000,
2026-09-12 03:57:16.931606 | instance |     "gr_name": "zuul",
2026-09-12 03:57:16.931646 | instance |     "inode": 1048201,
2026-09-12 03:57:16.931685 | instance |     "isblk": false,
2026-09-12 03:57:16.931727 | instance |     "ischr": false,
2026-09-12 03:57:16.931767 | instance |     "isdir": true,
2026-09-12 03:57:16.931824 | instance |     "isfifo": false,
2026-09-12 03:57:16.931865 | instance |     "isgid": false,
2026-09-12 03:57:16.931905 | instance |     "islnk": false,
2026-09-12 03:57:16.931944 | instance |     "isreg": false,
2026-09-12 03:57:16.931983 | instance |     "issock": false,
2026-09-12 03:57:16.932021 | instance |     "isuid": false,
2026-09-12 03:57:16.932060 | instance |     "mimetype": "unknown",
2026-09-12 03:57:16.932099 | instance |     "mode": "0755",
2026-09-12 03:57:16.932138 | instance |     "mtime": 1789185415.5651639,
2026-09-12 03:57:16.932178 | instance |     "nlink": 21,
2026-09-12 03:57:16.932217 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-12 03:57:16.932258 | instance |     "pw_name": "zuul",
2026-09-12 03:57:16.932299 | instance |     "readable": true,
2026-09-12 03:57:16.932339 | instance |     "rgrp": true,
2026-09-12 03:57:16.932379 | instance |     "roth": true,
2026-09-12 03:57:16.932419 | instance |     "rusr": true,
2026-09-12 03:57:16.932458 | instance |     "size": 4096,
2026-09-12 03:57:16.932683 | instance |     "uid": 1000,
2026-09-12 03:57:16.932768 | instance |     "version": "1536218704",
2026-09-12 03:57:16.932833 | instance |     "wgrp": false,
2026-09-12 03:57:16.932873 | instance |     "woth": false,
2026-09-12 03:57:16.932907 | instance |     "writeable": true,
2026-09-12 03:57:16.932940 | instance |     "wusr": true,
2026-09-12 03:57:16.932973 | instance |     "xgrp": true,
2026-09-12 03:57:16.933005 | instance |     "xoth": true,
2026-09-12 03:57:16.933038 | instance |     "xusr": true
2026-09-12 03:57:16.933071 | instance |   }
2026-09-12 03:57:16.933104 | instance | }
2026-09-12 03:57:16.933175 | instance | ok: All items complete
2026-09-12 03:57:16.933216 | 
2026-09-12 03:57:16.935530 | instance | skipping: Conditional result was False
2026-09-12 03:57:16.936729 | instance | skipping: Conditional result was False
2026-09-12 03:57:16.957664 | 
2026-09-12 03:57:16.958150 | LOOP [Switch "ansible_host" to private IP]
2026-09-12 03:57:17.325765 | instance | changed: 1 replacements made
2026-09-12 03:57:17.339782 | instance | skipping: Conditional result was False
2026-09-12 03:57:17.345735 | instance | skipping: Conditional result was False
2026-09-12 03:57:17.363116 | 
2026-09-12 03:57:17.363318 | TASK [Run Molecule scenario]
2026-09-12 03:57:18.341180 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-12 03:57:18.747885 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-12 03:57:18.747996 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-12 03:57:29.257909 | instance | INFO     [csi > dependency] Executing
2026-09-12 03:57:29.258308 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-12 03:57:29.258728 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-12 03:57:29.258951 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-12 03:57:29.273354 | instance | INFO     [csi > cleanup] Executing
2026-09-12 03:57:29.273952 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-12 03:57:29.287843 | instance | INFO     [csi > destroy] Executing
2026-09-12 03:57:29.287892 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-12 03:57:29.288013 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-12 03:57:29.297357 | instance | INFO     [csi > syntax] Executing
2026-09-12 03:57:30.807971 | instance |
2026-09-12 03:57:30.808159 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-12 03:57:30.883278 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-12 03:57:30.899005 | instance | INFO     [csi > create] Executing
2026-09-12 03:57:30.902563 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-12 03:57:30.917872 | instance | INFO     [csi > prepare] Executing
2026-09-12 03:57:31.658242 | instance |
2026-09-12 03:57:31.658423 | instance | PLAY [Prepare] *****************************************************************
2026-09-12 03:57:31.658712 | instance |
2026-09-12 03:57:31.659051 | instance | TASK [Gathering Facts] *********************************************************
2026-09-12 03:57:31.659339 | instance | Saturday 12 September 2026  03:57:31 +0000 (0:00:00.025)       0:00:00.025 ****
2026-09-12 03:57:32.948945 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-12 03:57:32.949284 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-12 03:57:32.949692 | instance | interpreter could change the meaning of that path. See
2026-09-12 03:57:32.950060 | instance | https://docs.ansible.com/ansible-
2026-09-12 03:57:32.950436 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-12 03:57:32.960979 | instance | ok: [instance]
2026-09-12 03:57:32.961262 | instance |
2026-09-12 03:57:32.961613 | instance | TASK [Configure short hostname] ************************************************
2026-09-12 03:57:32.961968 | instance | Saturday 12 September 2026  03:57:32 +0000 (0:00:01.302)       0:00:01.328 ****
2026-09-12 03:57:33.703985 | instance | changed: [instance]
2026-09-12 03:57:33.704273 | instance |
2026-09-12 03:57:33.704721 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-12 03:57:33.704949 | instance | Saturday 12 September 2026  03:57:33 +0000 (0:00:00.742)       0:00:02.070 ****
2026-09-12 03:57:33.985719 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-12 03:57:33.985960 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-12 03:57:33.986222 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-12 03:57:33.995182 | instance | changed: [instance]
2026-09-12 03:57:33.995456 | instance |
2026-09-12 03:57:33.995781 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-12 03:57:33.996045 | instance | Saturday 12 September 2026  03:57:33 +0000 (0:00:00.291)       0:00:02.362 ****
2026-09-12 03:57:34.830758 | instance | ok: [instance]
2026-09-12 03:57:34.831008 | instance |
2026-09-12 03:57:34.831220 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-12 03:57:34.831443 | instance |
2026-09-12 03:57:34.831723 | instance | TASK [Gathering Facts] *********************************************************
2026-09-12 03:57:34.831975 | instance | Saturday 12 September 2026  03:57:34 +0000 (0:00:00.835)       0:00:03.197 ****
2026-09-12 03:57:35.601985 | instance | ok: [instance]
2026-09-12 03:57:35.602169 | instance |
2026-09-12 03:57:35.602413 | instance | TASK [Install depedencies] *****************************************************
2026-09-12 03:57:35.602664 | instance | Saturday 12 September 2026  03:57:35 +0000 (0:00:00.770)       0:00:03.967 ****
2026-09-12 03:57:59.777660 | instance | changed: [instance]
2026-09-12 03:57:59.777877 | instance |
2026-09-12 03:57:59.778135 | instance | TASK [Start up service] ********************************************************
2026-09-12 03:57:59.778417 | instance | Saturday 12 September 2026  03:57:59 +0000 (0:00:24.176)       0:00:28.144 ****
2026-09-12 03:58:00.331648 | instance | ok: [instance]
2026-09-12 03:58:00.331852 | instance |
2026-09-12 03:58:00.332094 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-12 03:58:00.332332 | instance | Saturday 12 September 2026  03:58:00 +0000 (0:00:00.554)       0:00:28.698 ****
2026-09-12 03:58:00.645100 | instance | ok: [instance]
2026-09-12 03:58:00.645410 | instance |
2026-09-12 03:58:00.645744 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-12 03:58:00.646041 | instance | Saturday 12 September 2026  03:58:00 +0000 (0:00:00.313)       0:00:29.012 ****
2026-09-12 03:58:01.335333 | instance | changed: [instance]
2026-09-12 03:58:01.335398 | instance |
2026-09-12 03:58:01.335407 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-12 03:58:01.335414 | instance | Saturday 12 September 2026  03:58:01 +0000 (0:00:00.689)       0:00:29.702 ****
2026-09-12 03:58:01.541717 | instance | ok: [instance]
2026-09-12 03:58:01.542514 | instance |
2026-09-12 03:58:01.542570 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-12 03:58:01.542582 | instance | Saturday 12 September 2026  03:58:01 +0000 (0:00:00.206)       0:00:29.908 ****
2026-09-12 03:58:01.567406 | instance | skipping: [instance]
2026-09-12 03:58:01.568150 | instance |
2026-09-12 03:58:01.568190 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-12 03:58:01.568203 | instance | Saturday 12 September 2026  03:58:01 +0000 (0:00:00.025)       0:00:29.934 ****
2026-09-12 03:58:02.138835 | instance | changed: [instance] => (item=osd0)
2026-09-12 03:58:02.138912 | instance | changed: [instance] => (item=osd1)
2026-09-12 03:58:02.139341 | instance | changed: [instance] => (item=osd2)
2026-09-12 03:58:02.139369 | instance |
2026-09-12 03:58:02.139374 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-12 03:58:02.139379 | instance | Saturday 12 September 2026  03:58:02 +0000 (0:00:00.572)       0:00:30.506 ****
2026-09-12 03:58:02.774800 | instance | changed: [instance] => (item=osd0)
2026-09-12 03:58:02.775984 | instance | changed: [instance] => (item=osd1)
2026-09-12 03:58:02.776016 | instance | changed: [instance] => (item=osd2)
2026-09-12 03:58:02.776027 | instance |
2026-09-12 03:58:02.776037 | instance | TASK [Start loop devices] ******************************************************
2026-09-12 03:58:02.776047 | instance | Saturday 12 September 2026  03:58:02 +0000 (0:00:00.635)       0:00:31.142 ****
2026-09-12 03:58:03.505689 | instance | changed: [instance] => (item=osd0)
2026-09-12 03:58:03.506907 | instance | changed: [instance] => (item=osd1)
2026-09-12 03:58:03.506960 | instance | changed: [instance] => (item=osd2)
2026-09-12 03:58:03.506973 | instance |
2026-09-12 03:58:03.506983 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-12 03:58:03.506993 | instance | Saturday 12 September 2026  03:58:03 +0000 (0:00:00.730)       0:00:31.872 ****
2026-09-12 03:58:06.705808 | instance | changed: [instance] => (item=osd0)
2026-09-12 03:58:06.705876 | instance | changed: [instance] => (item=osd1)
2026-09-12 03:58:06.706298 | instance | changed: [instance] => (item=osd2)
2026-09-12 03:58:06.706345 | instance |
2026-09-12 03:58:06.706351 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-12 03:58:06.706356 | instance | Saturday 12 September 2026  03:58:06 +0000 (0:00:03.200)       0:00:35.073 ****
2026-09-12 03:58:08.665047 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-12 03:58:08.665343 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-12 03:58:08.665728 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-12 03:58:08.666137 | instance |
2026-09-12 03:58:08.666499 | instance | PLAY RECAP *********************************************************************
2026-09-12 03:58:08.666843 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-12 03:58:08.667146 | instance |
2026-09-12 03:58:08.667491 | instance | Saturday 12 September 2026  03:58:08 +0000 (0:00:01.959)       0:00:37.032 ****
2026-09-12 03:58:08.667798 | instance | ===============================================================================
2026-09-12 03:58:08.668108 | instance | Install depedencies ---------------------------------------------------- 24.18s
2026-09-12 03:58:08.668440 | instance | Create a volume group for each loop device ------------------------------ 3.20s
2026-09-12 03:58:08.668858 | instance | Create a logical volume for each loop device ---------------------------- 1.96s
2026-09-12 03:58:08.669223 | instance | Gathering Facts --------------------------------------------------------- 1.30s
2026-09-12 03:58:08.669587 | instance | Purge "snapd" package --------------------------------------------------- 0.84s
2026-09-12 03:58:08.670005 | instance | Gathering Facts --------------------------------------------------------- 0.77s
2026-09-12 03:58:08.670400 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-12 03:58:08.670740 | instance | Start loop devices ------------------------------------------------------ 0.73s
2026-09-12 03:58:08.671073 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.69s
2026-09-12 03:58:08.671425 | instance | Set permissions on loopback devices ------------------------------------- 0.64s
2026-09-12 03:58:08.671758 | instance | Create devices for Ceph ------------------------------------------------- 0.57s
2026-09-12 03:58:08.672084 | instance | Start up service -------------------------------------------------------- 0.55s
2026-09-12 03:58:08.672437 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-09-12 03:58:08.672915 | instance | Ensure hostname inside hosts file --------------------------------------- 0.29s
2026-09-12 03:58:08.673280 | instance | Get list of all loopback devices ---------------------------------------- 0.21s
2026-09-12 03:58:08.673651 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-12 03:58:08.733457 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-12 03:58:08.749880 | instance | INFO     [csi > converge] Executing
2026-09-12 03:58:10.080083 | instance |
2026-09-12 03:58:10.080478 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-12 03:58:10.080804 | instance |
2026-09-12 03:58:10.081091 | instance | TASK [Gathering Facts] *********************************************************
2026-09-12 03:58:10.081502 | instance | Saturday 12 September 2026  03:58:10 +0000 (0:00:00.007)       0:00:00.007 ****
2026-09-12 03:58:11.154750 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-12 03:58:11.155126 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-12 03:58:11.155467 | instance | interpreter could change the meaning of that path. See
2026-09-12 03:58:11.155810 | instance | https://docs.ansible.com/ansible-
2026-09-12 03:58:11.156210 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-12 03:58:11.168987 | instance | ok: [instance]
2026-09-12 03:58:11.169412 | instance |
2026-09-12 03:58:11.169809 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-12 03:58:11.170127 | instance | Saturday 12 September 2026  03:58:11 +0000 (0:00:01.088)       0:00:01.095 ****
2026-09-12 03:58:11.230596 | instance | ok: [instance] => {
2026-09-12 03:58:11.230943 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-12 03:58:11.231236 | instance | }
2026-09-12 03:58:11.231540 | instance |
2026-09-12 03:58:11.231830 | instance | PLAY [all] *********************************************************************
2026-09-12 03:58:11.232105 | instance |
2026-09-12 03:58:11.232578 | instance | TASK [Gathering Facts] *********************************************************
2026-09-12 03:58:11.233036 | instance | Saturday 12 September 2026  03:58:11 +0000 (0:00:00.061)       0:00:01.157 ****
2026-09-12 03:58:12.192862 | instance | ok: [instance]
2026-09-12 03:58:12.192923 | instance |
2026-09-12 03:58:12.192935 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-12 03:58:12.192951 | instance | Saturday 12 September 2026  03:58:12 +0000 (0:00:00.960)       0:00:02.117 ****
2026-09-12 03:58:12.400571 | instance | ok: [instance]
2026-09-12 03:58:12.400640 | instance |
2026-09-12 03:58:12.401085 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-12 03:58:12.401214 | instance |
2026-09-12 03:58:12.401220 | instance | TASK [Gathering Facts] *********************************************************
2026-09-12 03:58:12.401224 | instance | Saturday 12 September 2026  03:58:12 +0000 (0:00:00.209)       0:00:02.327 ****
2026-09-12 03:58:13.358854 | instance | ok: [instance]
2026-09-12 03:58:13.359678 | instance |
2026-09-12 03:58:13.359733 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-12 03:58:13.359753 | instance | Saturday 12 September 2026  03:58:13 +0000 (0:00:00.957)       0:00:03.285 ****
2026-09-12 03:58:13.647670 | instance | ok: [instance]
2026-09-12 03:58:13.647879 | instance |
2026-09-12 03:58:13.648088 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-12 03:58:13.648310 | instance | Saturday 12 September 2026  03:58:13 +0000 (0:00:00.288)       0:00:03.574 ****
2026-09-12 03:58:13.695670 | instance | skipping: [instance]
2026-09-12 03:58:13.695825 | instance |
2026-09-12 03:58:13.696078 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-12 03:58:13.696292 | instance | Saturday 12 September 2026  03:58:13 +0000 (0:00:00.048)       0:00:03.622 ****
2026-09-12 03:58:14.003917 | instance | changed: [instance]
2026-09-12 03:58:14.003960 | instance |
2026-09-12 03:58:14.003971 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-12 03:58:14.003981 | instance | Saturday 12 September 2026  03:58:13 +0000 (0:00:00.307)       0:00:03.929 ****
2026-09-12 03:58:14.093964 | instance | ok: [instance] => {
2026-09-12 03:58:14.094718 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-12 03:58:14.094737 | instance | }
2026-09-12 03:58:14.094744 | instance |
2026-09-12 03:58:14.094750 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-12 03:58:14.094756 | instance | Saturday 12 September 2026  03:58:14 +0000 (0:00:00.091)       0:00:04.020 ****
2026-09-12 03:58:14.822568 | instance | changed: [instance]
2026-09-12 03:58:14.823341 | instance |
2026-09-12 03:58:14.823389 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-12 03:58:14.823401 | instance | Saturday 12 September 2026  03:58:14 +0000 (0:00:00.727)       0:00:04.748 ****
2026-09-12 03:58:14.888243 | instance | skipping: [instance]
2026-09-12 03:58:14.888736 | instance |
2026-09-12 03:58:14.888776 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-12 03:58:14.888784 | instance | Saturday 12 September 2026  03:58:14 +0000 (0:00:00.066)       0:00:04.815 ****
2026-09-12 03:58:14.952321 | instance | skipping: [instance]
2026-09-12 03:58:14.952442 | instance |
2026-09-12 03:58:14.952824 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-12 03:58:14.952894 | instance | Saturday 12 September 2026  03:58:14 +0000 (0:00:00.064)       0:00:04.879 ****
2026-09-12 03:58:15.185196 | instance | ok: [instance]
2026-09-12 03:58:15.185647 | instance |
2026-09-12 03:58:15.185689 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-12 03:58:15.185696 | instance | Saturday 12 September 2026  03:58:15 +0000 (0:00:00.232)       0:00:05.111 ****
2026-09-12 03:58:16.411245 | instance | ok: [instance]
2026-09-12 03:58:16.411286 | instance |
2026-09-12 03:58:16.411293 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-12 03:58:16.411300 | instance | Saturday 12 September 2026  03:58:16 +0000 (0:00:01.225)       0:00:06.337 ****
2026-09-12 03:58:16.504358 | instance | ok: [instance] => {
2026-09-12 03:58:16.504404 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-12 03:58:16.504432 | instance | }
2026-09-12 03:58:16.504442 | instance |
2026-09-12 03:58:16.504452 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-12 03:58:16.504461 | instance | Saturday 12 September 2026  03:58:16 +0000 (0:00:00.092)       0:00:06.429 ****
2026-09-12 03:58:17.489178 | instance | changed: [instance]
2026-09-12 03:58:17.489958 | instance |
2026-09-12 03:58:17.490011 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-12 03:58:17.490023 | instance | Saturday 12 September 2026  03:58:17 +0000 (0:00:00.985)       0:00:07.415 ****
2026-09-12 03:58:20.356099 | instance | changed: [instance]
2026-09-12 03:58:20.356568 | instance |
2026-09-12 03:58:20.356610 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-12 03:58:20.356618 | instance | Saturday 12 September 2026  03:58:20 +0000 (0:00:02.867)       0:00:10.282 ****
2026-09-12 03:58:20.394560 | instance | skipping: [instance]
2026-09-12 03:58:20.395019 | instance |
2026-09-12 03:58:20.395136 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-12 03:58:20.395145 | instance | Saturday 12 September 2026  03:58:20 +0000 (0:00:00.038)       0:00:10.321 ****
2026-09-12 03:58:20.432606 | instance | skipping: [instance]
2026-09-12 03:58:20.433655 | instance |
2026-09-12 03:58:20.433707 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-12 03:58:20.433718 | instance | Saturday 12 September 2026  03:58:20 +0000 (0:00:00.037)       0:00:10.359 ****
2026-09-12 03:58:20.471569 | instance | skipping: [instance]
2026-09-12 03:58:20.471789 | instance |
2026-09-12 03:58:20.472195 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-12 03:58:20.472511 | instance | Saturday 12 September 2026  03:58:20 +0000 (0:00:00.038)       0:00:10.398 ****
2026-09-12 03:58:26.101813 | instance | changed: [instance]
2026-09-12 03:58:26.102178 | instance |
2026-09-12 03:58:26.102502 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-12 03:58:26.102810 | instance | Saturday 12 September 2026  03:58:26 +0000 (0:00:05.629)       0:00:16.027 ****
2026-09-12 03:58:26.723315 | instance | changed: [instance]
2026-09-12 03:58:26.723400 | instance |
2026-09-12 03:58:26.723413 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-12 03:58:26.723424 | instance | Saturday 12 September 2026  03:58:26 +0000 (0:00:00.621)       0:00:16.649 ****
2026-09-12 03:58:27.693103 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-12 03:58:27.693446 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-12 03:58:27.693717 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-12 03:58:27.693993 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-12 03:58:27.694292 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-12 03:58:27.694559 | instance |
2026-09-12 03:58:27.694828 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-12 03:58:27.695126 | instance | Saturday 12 September 2026  03:58:27 +0000 (0:00:00.970)       0:00:17.619 ****
2026-09-12 03:58:28.275666 | instance | changed: [instance]
2026-09-12 03:58:28.276035 | instance |
2026-09-12 03:58:28.276313 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-12 03:58:28.276556 | instance | Saturday 12 September 2026  03:58:28 +0000 (0:00:00.553)       0:00:18.173 ****
2026-09-12 03:58:28.276810 | instance |
2026-09-12 03:58:28.277044 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-12 03:58:28.277317 | instance | Saturday 12 September 2026  03:58:28 +0000 (0:00:00.028)       0:00:18.202 ****
2026-09-12 03:58:29.253568 | instance | ok: [instance]
2026-09-12 03:58:29.253631 | instance |
2026-09-12 03:58:29.253819 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-12 03:58:29.253967 | instance | Saturday 12 September 2026  03:58:29 +0000 (0:00:00.977)       0:00:19.180 ****
2026-09-12 03:58:29.707748 | instance | changed: [instance]
2026-09-12 03:58:29.707965 | instance |
2026-09-12 03:58:29.708249 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-12 03:58:29.708502 | instance | Saturday 12 September 2026  03:58:29 +0000 (0:00:00.454)       0:00:19.634 ****
2026-09-12 03:58:30.303158 | instance | changed: [instance]
2026-09-12 03:58:30.303377 | instance |
2026-09-12 03:58:30.303391 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-12 03:58:30.303401 | instance | Saturday 12 September 2026  03:58:30 +0000 (0:00:00.594)       0:00:20.228 ****
2026-09-12 03:58:30.519470 | instance | ok: [instance]
2026-09-12 03:58:30.519581 | instance |
2026-09-12 03:58:30.519916 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-12 03:58:30.519958 | instance | Saturday 12 September 2026  03:58:30 +0000 (0:00:00.217)       0:00:20.446 ****
2026-09-12 03:58:30.593376 | instance | ok: [instance] => {
2026-09-12 03:58:30.594707 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-12 03:58:30.594772 | instance | }
2026-09-12 03:58:30.594787 | instance |
2026-09-12 03:58:30.594800 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-12 03:58:30.594813 | instance | Saturday 12 September 2026  03:58:30 +0000 (0:00:00.073)       0:00:20.519 ****
2026-09-12 03:58:32.506940 | instance | changed: [instance]
2026-09-12 03:58:32.507807 | instance |
2026-09-12 03:58:32.507867 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-12 03:58:32.507880 | instance | Saturday 12 September 2026  03:58:32 +0000 (0:00:01.913)       0:00:22.433 ****
2026-09-12 03:58:36.860136 | instance | changed: [instance]
2026-09-12 03:58:36.860227 | instance |
2026-09-12 03:58:36.860546 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-12 03:58:36.860588 | instance | Saturday 12 September 2026  03:58:36 +0000 (0:00:04.354)       0:00:26.787 ****
2026-09-12 03:58:38.006026 | instance | ok: [instance]
2026-09-12 03:58:38.006697 | instance |
2026-09-12 03:58:38.006914 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-12 03:58:38.006949 | instance | Saturday 12 September 2026  03:58:37 +0000 (0:00:01.145)       0:00:27.932 ****
2026-09-12 03:58:38.367689 | instance | changed: [instance]
2026-09-12 03:58:38.367762 | instance |
2026-09-12 03:58:38.368020 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-12 03:58:38.368059 | instance | Saturday 12 September 2026  03:58:38 +0000 (0:00:00.362)       0:00:28.294 ****
2026-09-12 03:58:38.863326 | instance | changed: [instance]
2026-09-12 03:58:38.863392 | instance |
2026-09-12 03:58:38.863633 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-12 03:58:38.863673 | instance | Saturday 12 September 2026  03:58:38 +0000 (0:00:00.495)       0:00:28.790 ****
2026-09-12 03:58:39.419514 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-12 03:58:39.419592 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-12 03:58:39.420039 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-12 03:58:39.420077 | instance |
2026-09-12 03:58:39.420082 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-12 03:58:39.420087 | instance | Saturday 12 September 2026  03:58:39 +0000 (0:00:00.556)       0:00:29.346 ****
2026-09-12 03:58:39.905164 | instance | changed: [instance]
2026-09-12 03:58:39.906397 | instance |
2026-09-12 03:58:39.906457 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-12 03:58:39.906469 | instance | Saturday 12 September 2026  03:58:39 +0000 (0:00:00.484)       0:00:29.831 ****
2026-09-12 03:58:40.460771 | instance | changed: [instance]
2026-09-12 03:58:40.460840 | instance |
2026-09-12 03:58:40.460852 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-12 03:58:40.460869 | instance | Saturday 12 September 2026  03:58:40 +0000 (0:00:00.533)       0:00:30.365 ****
2026-09-12 03:58:40.461417 | instance |
2026-09-12 03:58:40.461461 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-12 03:58:40.461469 | instance | Saturday 12 September 2026  03:58:40 +0000 (0:00:00.022)       0:00:30.387 ****
2026-09-12 03:58:41.255146 | instance | ok: [instance]
2026-09-12 03:58:41.255862 | instance |
2026-09-12 03:58:41.256091 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-12 03:58:41.256113 | instance | Saturday 12 September 2026  03:58:41 +0000 (0:00:00.794)       0:00:31.181 ****
2026-09-12 03:58:42.336391 | instance | changed: [instance]
2026-09-12 03:58:42.336793 | instance |
2026-09-12 03:58:42.337257 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-12 03:58:42.337292 | instance | Saturday 12 September 2026  03:58:42 +0000 (0:00:01.081)       0:00:32.262 ****
2026-09-12 03:58:42.981454 | instance | changed: [instance]
2026-09-12 03:58:42.981948 | instance |
2026-09-12 03:58:42.981970 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-12 03:58:42.981977 | instance | Saturday 12 September 2026  03:58:42 +0000 (0:00:00.645)       0:00:32.908 ****
2026-09-12 03:58:43.038367 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-12 03:58:43.039125 | instance |
2026-09-12 03:58:43.039157 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-12 03:58:43.039169 | instance | Saturday 12 September 2026  03:58:43 +0000 (0:00:00.056)       0:00:32.965 ****
2026-09-12 03:58:47.882950 | instance | changed: [instance]
2026-09-12 03:58:47.883617 | instance |
2026-09-12 03:58:47.883650 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-12 03:58:47.883662 | instance | Saturday 12 September 2026  03:58:47 +0000 (0:00:04.844)       0:00:37.809 ****
2026-09-12 03:58:48.563354 | instance | ok: [instance] => (item=chronyd)
2026-09-12 03:58:48.564487 | instance | ok: [instance] => (item=sshd)
2026-09-12 03:58:48.564521 | instance |
2026-09-12 03:58:48.564532 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-12 03:58:48.564542 | instance | Saturday 12 September 2026  03:58:48 +0000 (0:00:00.680)       0:00:38.489 ****
2026-09-12 03:58:59.374443 | instance | changed: [instance]
2026-09-12 03:58:59.375204 | instance |
2026-09-12 03:58:59.375262 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-12 03:58:59.375278 | instance | Saturday 12 September 2026  03:58:59 +0000 (0:00:10.810)       0:00:49.300 ****
2026-09-12 03:58:59.591824 | instance | ok: [instance]
2026-09-12 03:58:59.592826 | instance |
2026-09-12 03:58:59.592897 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-12 03:58:59.592970 | instance | Saturday 12 September 2026  03:58:59 +0000 (0:00:00.217)       0:00:49.518 ****
2026-09-12 03:59:00.053794 | instance | changed: [instance]
2026-09-12 03:59:00.053866 | instance |
2026-09-12 03:59:00.054199 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-12 03:59:00.054246 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.462)       0:00:49.981 ****
2026-09-12 03:59:00.425893 | instance | changed: [instance]
2026-09-12 03:59:00.426671 | instance |
2026-09-12 03:59:00.426725 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-12 03:59:00.426738 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.371)       0:00:50.352 ****
2026-09-12 03:59:00.557448 | instance | ok: [instance]
2026-09-12 03:59:00.558366 | instance |
2026-09-12 03:59:00.558415 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-12 03:59:00.558429 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.131)       0:00:50.483 ****
2026-09-12 03:59:00.816128 | instance | ok: [instance] => (item=instance)
2026-09-12 03:59:00.816699 | instance |
2026-09-12 03:59:00.816722 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-12 03:59:00.816868 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.258)       0:00:50.742 ****
2026-09-12 03:59:00.888410 | instance | ok: [instance]
2026-09-12 03:59:00.888747 | instance |
2026-09-12 03:59:00.889207 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-12 03:59:00.889241 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.072)       0:00:50.814 ****
2026-09-12 03:59:00.984908 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-12 03:59:00.985381 | instance |
2026-09-12 03:59:00.985424 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-12 03:59:00.985432 | instance | Saturday 12 September 2026  03:59:00 +0000 (0:00:00.097)       0:00:50.911 ****
2026-09-12 03:59:01.313327 | instance | changed: [instance]
2026-09-12 03:59:01.313449 | instance |
2026-09-12 03:59:01.313980 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-12 03:59:01.314022 | instance | Saturday 12 September 2026  03:59:01 +0000 (0:00:00.328)       0:00:51.240 ****
2026-09-12 03:59:02.029464 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-12 03:59:02.029554 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-12 03:59:02.029984 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-12 03:59:02.030001 | instance |
2026-09-12 03:59:02.030006 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-12 03:59:02.030011 | instance | Saturday 12 September 2026  03:59:02 +0000 (0:00:00.716)       0:00:51.956 ****
2026-09-12 04:00:34.899053 | instance | ok: [instance]
2026-09-12 04:00:34.899171 | instance |
2026-09-12 04:00:34.899343 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-12 04:00:34.899498 | instance | Saturday 12 September 2026  04:00:34 +0000 (0:01:32.869)       0:02:24.825 ****
2026-09-12 04:00:35.136498 | instance | changed: [instance]
2026-09-12 04:00:35.136737 | instance |
2026-09-12 04:00:35.137011 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-12 04:00:35.137251 | instance | Saturday 12 September 2026  04:00:35 +0000 (0:00:00.236)       0:02:25.062 ****
2026-09-12 04:00:35.191177 | instance | ok: [instance]
2026-09-12 04:00:35.191372 | instance |
2026-09-12 04:00:35.191612 | instance | TASK [Install Ceph host] *******************************************************
2026-09-12 04:00:35.191835 | instance | Saturday 12 September 2026  04:00:35 +0000 (0:00:00.055)       0:02:25.117 ****
2026-09-12 04:00:35.275532 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-12 04:00:35.275744 | instance |
2026-09-12 04:00:35.276021 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-12 04:00:35.276263 | instance | Saturday 12 September 2026  04:00:35 +0000 (0:00:00.084)       0:02:25.202 ****
2026-09-12 04:00:36.923817 | instance | ok: [instance]
2026-09-12 04:00:36.924036 | instance |
2026-09-12 04:00:36.924314 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-12 04:00:36.924562 | instance | Saturday 12 September 2026  04:00:36 +0000 (0:00:01.648)       0:02:26.850 ****
2026-09-12 04:00:37.005453 | instance | ok: [instance] => (item=instance)
2026-09-12 04:00:37.005671 | instance |
2026-09-12 04:00:37.005964 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-12 04:00:37.006169 | instance | Saturday 12 September 2026  04:00:36 +0000 (0:00:00.081)       0:02:26.931 ****
2026-09-12 04:00:37.426837 | instance | ok: [instance]
2026-09-12 04:00:37.427059 | instance |
2026-09-12 04:00:37.428733 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-12 04:00:37.428764 | instance | Saturday 12 September 2026  04:00:37 +0000 (0:00:00.421)       0:02:27.353 ****
2026-09-12 04:00:39.836814 | instance | ok: [instance]
2026-09-12 04:00:39.836888 | instance |
2026-09-12 04:00:39.836908 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-12 04:00:39.837147 | instance | Saturday 12 September 2026  04:00:39 +0000 (0:00:02.409)       0:02:29.762 ****
2026-09-12 04:01:31.536551 | 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-12 04:01:31.537399 | 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_jrt26k37/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_jrt26k37/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_jrt26k37/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_jrt26k37/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-12T04:01:31.356+0000 7f0653fff640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA6zqRqpbytACAAAqGzy2ddkAWIfj5cB+H4Q5PIuCeqfFWUd0+9WsRP38w=: Malformed input [buffer:3]\n2026-09-12T04:01:31.356+0000 7f0653fff640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-12T04:01:31.360+0000 7f0653fff640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA6zqRqpbytACAAAqGzy2ddkAWIfj5cB+H4Q5PIuCeqfFWUd0+9WsRP38w=: Malformed input [buffer:3]\n2026-09-12T04:01:31.360+0000 7f0653fff640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-12T04:01:31.360+0000 7f0653fff640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA6zqRqpbytACAAAqGzy2ddkAWIfj5cB+H4Q5PIuCeqfFWUd0+9WsRP38w=: Malformed input [buffer:3]\n2026-09-12T04:01:31.360+0000 7f0653fff640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-12T04:01:31.360+0000 7f0653fff640 -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-12 04:01:31.540195 | instance |
2026-09-12 04:01:31.540433 | instance | PLAY RECAP *********************************************************************
2026-09-12 04:01:31.540775 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-12 04:01:31.541044 | instance |
2026-09-12 04:01:31.544747 | instance | Saturday 12 September 2026  04:01:31 +0000 (0:00:51.704)       0:03:21.467 ****
2026-09-12 04:01:31.544802 | instance | ===============================================================================
2026-09-12 04:01:31.544813 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 92.87s
2026-09-12 04:01:31.544822 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 51.70s
2026-09-12 04:01:31.544830 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 10.81s
2026-09-12 04:01:31.544839 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.63s
2026-09-12 04:01:31.544848 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.84s
2026-09-12 04:01:31.544856 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.35s
2026-09-12 04:01:31.544865 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-09-12 04:01:31.544874 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.41s
2026-09-12 04:01:31.544916 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.91s
2026-09-12 04:01:31.544925 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.77s
2026-09-12 04:01:31.544934 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.65s
2026-09-12 04:01:31.544942 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.23s
2026-09-12 04:01:31.544951 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.15s
2026-09-12 04:01:31.544960 | instance | Gathering Facts --------------------------------------------------------- 1.09s
2026-09-12 04:01:31.544976 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.08s
2026-09-12 04:01:31.545075 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.99s
2026-09-12 04:01:31.545389 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.97s
2026-09-12 04:01:31.545682 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-12 04:01:31.545998 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-09-12 04:01:31.546294 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.73s
2026-09-12 04:01:31.643208 | 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-12 04:01:31.643272 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-12 04:01:31.643285 | 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-12 04:01:31.755210 | instance | ERROR
2026-09-12 04:01:31.755508 | instance | {
2026-09-12 04:01:31.755616 | instance |   "delta": "0:04:13.931978",
2026-09-12 04:01:31.755682 | instance |   "end": "2026-09-12 04:01:31.687922",
2026-09-12 04:01:31.755773 | instance |   "msg": "non-zero return code",
2026-09-12 04:01:31.755912 | instance |   "rc": 2,
2026-09-12 04:01:31.756004 | instance |   "start": "2026-09-12 03:57:17.755944"
2026-09-12 04:01:31.756066 | instance | }
failure
2026-09-12 04:01:31.766086 | 
2026-09-12 04:01:31.766156 | PLAY RECAP
2026-09-12 04:01:31.766210 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-12 04:01:31.766236 | 
2026-09-12 04:01:31.926251 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-12 04:01:31.931520 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-12 04:01:32.629452 | 
2026-09-12 04:01:32.629620 | PLAY [all]
2026-09-12 04:01:32.646132 | 
2026-09-12 04:01:32.646242 | TASK [gather-host-logs : creating directory for system status]
2026-09-12 04:01:33.000409 | instance | changed
2026-09-12 04:01:33.005700 | 
2026-09-12 04:01:33.005785 | TASK [gather-host-logs : Get logs for each host]
2026-09-12 04:01:33.420847 | instance | + systemd-cgls --full --all --no-pager
2026-09-12 04:01:33.440927 | instance | + ip addr
2026-09-12 04:01:33.443768 | instance | + ip route
2026-09-12 04:01:33.446171 | instance | + lsblk
2026-09-12 04:01:33.450789 | instance | + mount
2026-09-12 04:01:33.453163 | instance | + docker images
2026-09-12 04:01:33.478353 | instance | + brctl show
2026-09-12 04:01:33.478791 | instance | /bin/bash: line 8: brctl: command not found
2026-09-12 04:01:33.479167 | instance | + ip neigh
2026-09-12 04:01:33.481724 | instance | + bridge fdb show
2026-09-12 04:01:33.485108 | instance | + ps aux --sort=-%mem
2026-09-12 04:01:33.521007 | instance | + dpkg -l
2026-09-12 04:01:33.532419 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-12 04:01:33.532867 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-12 04:01:33.554001 | instance | + '[' '!' -z '' ']'
2026-09-12 04:01:34.059281 | instance | ok: Runtime: 0:00:00.137485
2026-09-12 04:01:34.071223 | 
2026-09-12 04:01:34.071406 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-12 04:01:34.760444 | instance | changed:
2026-09-12 04:01:34.760625 | instance | created directory /var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/logs/instance
2026-09-12 04:01:34.760652 | instance | cd+++++++++ system/
2026-09-12 04:01:34.760672 | instance | >f+++++++++ system/brctl-show.txt
2026-09-12 04:01:34.760690 | instance | >f+++++++++ system/bridge-fdb.txt
2026-09-12 04:01:34.760707 | instance | >f+++++++++ system/docker-images.txt
2026-09-12 04:01:34.760727 | instance | >f+++++++++ system/ip-addr.txt
2026-09-12 04:01:34.760745 | instance | >f+++++++++ system/ip-neigh.txt
2026-09-12 04:01:34.760763 | instance | >f+++++++++ system/ip-route.txt
2026-09-12 04:01:34.760782 | instance | >f+++++++++ system/lsblk.txt
2026-09-12 04:01:34.760799 | instance | >f+++++++++ system/mount.txt
2026-09-12 04:01:34.760815 | instance | >f+++++++++ system/packages.txt
2026-09-12 04:01:34.760831 | instance | >f+++++++++ system/ps.txt
2026-09-12 04:01:34.760863 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-12 04:01:34.768704 | 
2026-09-12 04:01:34.768765 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-12 04:01:34.978028 | instance | changed: "values"
2026-09-12 04:01:35.161791 | instance | changed: "releases"
2026-09-12 04:01:35.176108 | 
2026-09-12 04:01:35.176332 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-12 04:01:35.433336 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-12 04:01:35.728592 | instance | ok: Runtime: 0:00:00.005533
2026-09-12 04:01:35.738642 | 
2026-09-12 04:01:35.738778 | TASK [helm-release-status : Downloads logs to executor]
2026-09-12 04:01:36.313490 | instance | changed:
2026-09-12 04:01:36.313685 | instance | cd+++++++++ helm/
2026-09-12 04:01:36.313722 | instance | cd+++++++++ helm/releases/
2026-09-12 04:01:36.313749 | instance | cd+++++++++ helm/values/
2026-09-12 04:01:36.328609 | 
2026-09-12 04:01:36.328679 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-12 04:01:36.540688 | instance | changed
2026-09-12 04:01:36.547994 | 
2026-09-12 04:01:36.548077 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-12 04:01:36.833364 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-12 04:01:36.833447 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-12 04:01:36.838616 | instance | environment: line 1: kubectl: command not found
2026-09-12 04:01:36.839896 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-12 04:01:36.842203 | instance | environment: line 1: kubectl: command not found
2026-09-12 04:01:36.843432 | instance | environment: line 1: kubectl: command not found
2026-09-12 04:01:36.843674 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-12 04:01:36.845409 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-12 04:01:36.847259 | instance | environment: line 1: kubectl: command not found
2026-09-12 04:01:36.848436 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-12 04:01:36.848717 | instance | environment: line 1: kubectl: command not found
2026-09-12 04:01:36.850055 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-12 04:01:37.087290 | instance | ok: Runtime: 0:00:00.023918
2026-09-12 04:01:37.097147 | 
2026-09-12 04:01:37.097301 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-12 04:01:37.313814 | instance | changed
2026-09-12 04:01:37.325970 | 
2026-09-12 04:01:37.326283 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-12 04:01:37.584482 | instance | environment: line 5: kubectl: command not found
2026-09-12 04:01:37.585312 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-12 04:01:37.585529 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-12 04:01:37.585551 | instance |
2026-09-12 04:01:37.880376 | instance | ok: Runtime: 0:00:00.008420
2026-09-12 04:01:37.892360 | 
2026-09-12 04:01:37.892603 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-12 04:01:38.419367 | instance | changed:
2026-09-12 04:01:38.419524 | instance | cd+++++++++ objects/
2026-09-12 04:01:38.419557 | instance | cd+++++++++ objects/cluster/
2026-09-12 04:01:38.419582 | instance | cd+++++++++ objects/namespaced/
2026-09-12 04:01:38.429806 | 
2026-09-12 04:01:38.429892 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-12 04:01:38.653900 | instance | changed
2026-09-12 04:01:38.663665 | 
2026-09-12 04:01:38.663784 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-12 04:01:38.881347 | instance | changed
2026-09-12 04:01:38.890457 | 
2026-09-12 04:01:38.890581 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-12 04:01:39.135222 | instance | environment: line 3: kubectl: command not found
2026-09-12 04:01:39.437766 | instance | ok: Runtime: 0:00:00.006978
2026-09-12 04:01:39.447341 | 
2026-09-12 04:01:39.447458 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-12 04:01:39.967275 | instance | changed:
2026-09-12 04:01:39.967519 | instance | cd+++++++++ pod-logs/
2026-09-12 04:01:39.967574 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-12 04:01:39.985623 | 
2026-09-12 04:01:39.985746 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-12 04:01:40.191878 | instance | changed
2026-09-12 04:01:40.201137 | 
2026-09-12 04:01:40.201262 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-12 04:01:40.447435 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-12 04:01:40.748112 | instance | ok: Runtime: 0:00:00.051457
2026-09-12 04:01:40.757441 | 
2026-09-12 04:01:40.757572 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-12 04:01:41.010906 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-12 04:01:41.055470 | instance | ceph-mgr endpoints:
2026-09-12 04:01:41.306640 | instance | ok: Runtime: 0:00:00.050058
2026-09-12 04:01:41.316942 | 
2026-09-12 04:01:41.317096 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-12 04:01:41.583087 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-12 04:01:41.930551 | instance | ok: Runtime: 0:00:00.051321
2026-09-12 04:01:41.940784 | 
2026-09-12 04:01:41.940939 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-12 04:01:42.461980 | instance | changed: cd+++++++++ prometheus/
2026-09-12 04:01:42.482200 | 
2026-09-12 04:01:42.482436 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-12 04:01:42.715269 | instance | changed
2026-09-12 04:01:42.725053 | 
2026-09-12 04:01:42.725192 | TASK [gather-selenium-data : Get selenium data]
2026-09-12 04:01:43.028614 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-12 04:01:43.030117 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-12 04:01:43.272325 | instance | ERROR
2026-09-12 04:01:43.272632 | instance | {
2026-09-12 04:01:43.272698 | instance |   "delta": "0:00:00.006228",
2026-09-12 04:01:43.272739 | instance |   "end": "2026-09-12 04:01:43.030485",
2026-09-12 04:01:43.272775 | instance |   "msg": "non-zero return code",
2026-09-12 04:01:43.272810 | instance |   "rc": 1,
2026-09-12 04:01:43.272866 | instance |   "start": "2026-09-12 04:01:43.024257"
2026-09-12 04:01:43.272902 | instance | }
2026-09-12 04:01:43.272947 | instance | ERROR: Ignoring Errors
2026-09-12 04:01:43.282362 | 
2026-09-12 04:01:43.282488 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-12 04:01:43.825412 | instance | changed: cd+++++++++ selenium/
2026-09-12 04:01:43.837651 | 
2026-09-12 04:01:43.837744 | PLAY RECAP
2026-09-12 04:01:43.837826 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-12 04:01:43.837897 | 
2026-09-12 04:01:43.990630 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-12 04:01:43.996090 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-12 04:01:44.562985 | 
2026-09-12 04:01:44.563117 | PLAY [all]
2026-09-12 04:01:44.581443 | 
2026-09-12 04:01:44.581724 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-12 04:01:44.639067 | instance | skipping: Conditional result was False
2026-09-12 04:01:44.649572 | 
2026-09-12 04:01:44.649740 | TASK [fetch-output : Set log path for single node]
2026-09-12 04:01:44.694793 | instance | ok
2026-09-12 04:01:44.704227 | 
2026-09-12 04:01:44.704361 | LOOP [fetch-output : Ensure local output dirs]
2026-09-12 04:01:45.127647 | instance -> localhost | ok: "/var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/logs"
2026-09-12 04:01:45.359319 | instance -> localhost | changed: "/var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/artifacts"
2026-09-12 04:01:45.582855 | instance -> localhost | changed: "/var/lib/zuul/builds/db6669bc16154554a283978f9926bd62/work/docs"
2026-09-12 04:01:45.602909 | 
2026-09-12 04:01:45.603061 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-12 04:01:46.282946 | instance | changed: .d..t...... ./
2026-09-12 04:01:46.283180 | instance | changed: All items complete
2026-09-12 04:01:46.283222 | 
2026-09-12 04:01:46.757114 | instance | changed: .d..t...... ./
2026-09-12 04:01:47.290195 | instance | changed: .d..t...... ./
2026-09-12 04:01:47.313514 | 
2026-09-12 04:01:47.313713 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-12 04:01:47.764071 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006372
2026-09-12 04:01:48.053141 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008168
2026-09-12 04:01:48.075603 | 
2026-09-12 04:01:48.075774 | PLAY [all]
2026-09-12 04:01:48.087920 | 
2026-09-12 04:01:48.088048 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-12 04:01:48.517923 | instance | changed
2026-09-12 04:01:48.526377 | 
2026-09-12 04:01:48.526559 | PLAY RECAP
2026-09-12 04:01:48.526649 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-12 04:01:48.526692 | 
2026-09-12 04:01:48.659822 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-12 04:01:48.661811 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-12 04:01:49.187382 | 
2026-09-12 04:01:49.187508 | PLAY [localhost]
2026-09-12 04:01:49.196222 | 
2026-09-12 04:01:49.196292 | TASK [Generate Zuul manifest]
2026-09-12 04:01:49.212768 | localhost | ok
2026-09-12 04:01:49.227515 | 
2026-09-12 04:01:49.227590 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-12 04:01:49.611328 | localhost | changed
2026-09-12 04:01:49.630555 | 
2026-09-12 04:01:49.630787 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-12 04:01:49.671931 | localhost | ok
2026-09-12 04:01:49.684471 | 
2026-09-12 04:01:49.684629 | TASK [Upload logs]
2026-09-12 04:01:49.707603 | localhost | ok
2026-09-12 04:01:49.784458 | 
2026-09-12 04:01:49.784607 | TASK [Set zuul-log-path fact]
2026-09-12 04:01:49.802790 | localhost | ok
2026-09-12 04:01:49.819263 | 
2026-09-12 04:01:49.819414 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-12 04:01:49.848541 | localhost | ok
2026-09-12 04:01:49.857320 | 
2026-09-12 04:01:49.857439 | TASK [upload-logs : Create log directories]
2026-09-12 04:01:50.284168 | localhost | changed
2026-09-12 04:01:50.292941 | 
2026-09-12 04:01:50.293084 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-12 04:01:50.821961 | localhost -> localhost | ok: Runtime: 0:00:00.091129
2026-09-12 04:01:50.831035 | 
2026-09-12 04:01:50.831162 | TASK [upload-logs : Upload logs to log server]
2026-09-12 04:01:51.352241 | localhost | Output suppressed because no_log was given
2026-09-12 04:01:51.408071 | 
2026-09-12 04:01:51.408245 | LOOP [upload-logs : Compress console log and json output]
2026-09-12 04:01:51.470423 | localhost | skipping: Conditional result was False
2026-09-12 04:01:51.479554 | localhost | skipping: Conditional result was False
2026-09-12 04:01:51.489618 | 
2026-09-12 04:01:51.489831 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-12 04:01:51.534009 | localhost | skipping: Conditional result was False
2026-09-12 04:01:51.534436 | 
2026-09-12 04:01:51.537992 | localhost | skipping: Conditional result was False
2026-09-12 04:01:51.551583 | 
2026-09-12 04:01:51.551786 | LOOP [upload-logs : Upload console log and json output]