2026-08-19 20:24:09.919064 | Job console starting
2026-08-19 20:24:09.948597 | Updating git repos
2026-08-19 20:24:14.576278 | Cloning repos into workspace
2026-08-19 20:24:51.830770 | Restoring repo states
2026-08-19 20:24:57.522295 | Merging changes
2026-08-19 20:25:08.023260 | Checking out repos
2026-08-19 20:25:32.449317 | Preparing playbooks
2026-08-19 20:25:54.385107 | Running Ansible setup
2026-08-19 20:25:58.193739 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:25:58.821390 | 
2026-08-19 20:25:58.822249 | PLAY [localhost]
2026-08-19 20:25:58.830672 | 
2026-08-19 20:25:58.830761 | TASK [Gathering Facts]
2026-08-19 20:25:59.719251 | localhost | ok
2026-08-19 20:25:59.732487 | 
2026-08-19 20:25:59.732574 | TASK [Setup log path fact]
2026-08-19 20:25:59.751430 | localhost | ok
2026-08-19 20:25:59.765922 | 
2026-08-19 20:25:59.766036 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:25:59.796029 | localhost | ok
2026-08-19 20:25:59.804945 | 
2026-08-19 20:25:59.805069 | TASK [emit-job-header : Print job information]
2026-08-19 20:25:59.847963 | # Job Information
2026-08-19 20:25:59.848295 | Ansible Version: 2.16.18
2026-08-19 20:25:59.848432 | Job: atmosphere-molecule-csi-rbd
2026-08-19 20:25:59.848510 | Pipeline: check
2026-08-19 20:25:59.848592 | Executor: 2d72f0692154
2026-08-19 20:25:59.848659 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4095
2026-08-19 20:25:59.848720 | Event ID: 23e6fd30-9c0b-11f1-8cc9-9e7c51652d18
2026-08-19 20:25:59.854444 | 
2026-08-19 20:25:59.854511 | LOOP [emit-job-header : Print node information]
2026-08-19 20:25:59.964003 | localhost | ok:
2026-08-19 20:25:59.964651 | localhost | # Node Information
2026-08-19 20:25:59.964719 | localhost | Inventory Hostname: instance
2026-08-19 20:25:59.964768 | localhost | Hostname: np0000190133
2026-08-19 20:25:59.964812 | localhost | Username: zuul
2026-08-19 20:25:59.964864 | localhost | Distro: Ubuntu 22.04
2026-08-19 20:25:59.964908 | localhost | Provider: yul1
2026-08-19 20:25:59.964987 | localhost | Region: ca-ymq-1
2026-08-19 20:25:59.965174 | localhost | Label: ubuntu-jammy
2026-08-19 20:25:59.965232 | localhost | Product Name: OpenStack Nova
2026-08-19 20:25:59.965276 | localhost | Interface IP: 199.204.45.44
2026-08-19 20:25:59.980991 | 
2026-08-19 20:25:59.981170 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-19 20:26:00.392326 | localhost -> localhost | changed
2026-08-19 20:26:00.397933 | 
2026-08-19 20:26:00.398023 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-19 20:26:01.274916 | localhost -> localhost | changed
2026-08-19 20:26:01.283520 | 
2026-08-19 20:26:01.283588 | PLAY [all]
2026-08-19 20:26:01.293450 | 
2026-08-19 20:26:01.293532 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-19 20:26:01.519486 | instance -> localhost | ok
2026-08-19 20:26:01.525402 | 
2026-08-19 20:26:01.525469 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-19 20:26:01.559146 | instance | ok
2026-08-19 20:26:01.882677 | instance | included: /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-19 20:26:01.888527 | 
2026-08-19 20:26:01.888604 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-19 20:26:02.935949 | instance -> localhost | Generating public/private rsa key pair.
2026-08-19 20:26:02.936128 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/1007d630e9094e208bcb951fa7753daf_id_rsa
2026-08-19 20:26:02.936157 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/1007d630e9094e208bcb951fa7753daf_id_rsa.pub
2026-08-19 20:26:02.936181 | instance -> localhost | The key fingerprint is:
2026-08-19 20:26:02.936202 | instance -> localhost | SHA256:bISVJzvNQyh5K4AHYJPXoSVgknTtAYD74zyVBCH4Va8 zuul-build-sshkey
2026-08-19 20:26:02.936237 | instance -> localhost | The key's randomart image is:
2026-08-19 20:26:02.936258 | instance -> localhost | +---[RSA 3072]----+
2026-08-19 20:26:02.936283 | instance -> localhost | |BX*B++o..o       |
2026-08-19 20:26:02.936305 | instance -> localhost | |Bo=.B+o+= o      |
2026-08-19 20:26:02.936325 | instance -> localhost | | o.=..oooO       |
2026-08-19 20:26:02.936345 | instance -> localhost | |. . ...++ +      |
2026-08-19 20:26:02.936365 | instance -> localhost | | . . .E.S. .     |
2026-08-19 20:26:02.936384 | instance -> localhost | |  o o  .         |
2026-08-19 20:26:02.936405 | instance -> localhost | | o o             |
2026-08-19 20:26:02.936424 | instance -> localhost | |  +              |
2026-08-19 20:26:02.936446 | instance -> localhost | |   .             |
2026-08-19 20:26:02.936467 | instance -> localhost | +----[SHA256]-----+
2026-08-19 20:26:02.936513 | instance -> localhost | ok: Runtime: 0:00:00.633819
2026-08-19 20:26:02.942661 | 
2026-08-19 20:26:02.942722 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-19 20:26:02.990758 | instance | ok
2026-08-19 20:26:03.003414 | instance | included: /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-19 20:26:03.011524 | 
2026-08-19 20:26:03.011588 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-19 20:26:03.037421 | instance | skipping: Conditional result was False
2026-08-19 20:26:03.048835 | 
2026-08-19 20:26:03.048932 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-19 20:26:03.487534 | instance | changed
2026-08-19 20:26:03.495990 | 
2026-08-19 20:26:03.496055 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-19 20:26:03.669367 | instance | ok
2026-08-19 20:26:03.695582 | 
2026-08-19 20:26:03.695651 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-19 20:26:04.166898 | instance | changed
2026-08-19 20:26:04.173029 | 
2026-08-19 20:26:04.173095 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-19 20:26:04.623841 | instance | changed
2026-08-19 20:26:04.636548 | 
2026-08-19 20:26:04.636735 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-19 20:26:04.664624 | instance | skipping: Conditional result was False
2026-08-19 20:26:04.675977 | 
2026-08-19 20:26:04.676161 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-19 20:26:05.069526 | instance -> localhost | changed
2026-08-19 20:26:05.089170 | 
2026-08-19 20:26:05.089325 | TASK [add-build-sshkey : Add back temp key]
2026-08-19 20:26:05.415051 | instance -> localhost | Identity added: /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/1007d630e9094e208bcb951fa7753daf_id_rsa (zuul-build-sshkey)
2026-08-19 20:26:05.415295 | instance -> localhost | ok: Runtime: 0:00:00.014116
2026-08-19 20:26:05.422118 | 
2026-08-19 20:26:05.422210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-19 20:26:05.730120 | instance | ok
2026-08-19 20:26:05.734633 | 
2026-08-19 20:26:05.734698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-19 20:26:05.759459 | instance | skipping: Conditional result was False
2026-08-19 20:26:05.769004 | 
2026-08-19 20:26:05.769092 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-19 20:26:06.105353 | instance | ok
2026-08-19 20:26:06.113336 | 
2026-08-19 20:26:06.113421 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-19 20:26:10.100148 | instance | Output suppressed because no_log was given
2026-08-19 20:26:10.112165 | 
2026-08-19 20:26:10.112254 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-19 20:26:10.304230 | instance | ok: "logs"
2026-08-19 20:26:10.304580 | instance | ok: All items complete
2026-08-19 20:26:10.304623 | 
2026-08-19 20:26:10.452599 | instance | ok: "artifacts"
2026-08-19 20:26:10.607060 | instance | ok: "docs"
2026-08-19 20:26:10.623761 | 
2026-08-19 20:26:10.623975 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-19 20:26:10.821644 | instance | changed: "logs"
2026-08-19 20:26:10.976805 | instance | changed: "artifacts"
2026-08-19 20:26:11.135457 | instance | changed: "docs"
2026-08-19 20:26:11.154696 | 
2026-08-19 20:26:11.154828 | PLAY RECAP
2026-08-19 20:26:11.154879 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-19 20:26:11.154908 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:26:11.154931 | 
2026-08-19 20:26:11.340086 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:26:11.345381 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:26:11.967541 | 
2026-08-19 20:26:11.967674 | PLAY [all]
2026-08-19 20:26:11.978837 | 
2026-08-19 20:26:11.978955 | TASK [setup-uv : Extract archive]
2026-08-19 20:26:14.153997 | instance | changed
2026-08-19 20:26:14.163218 | 
2026-08-19 20:26:14.163427 | TASK [setup-uv : Print version]
2026-08-19 20:26:14.548759 | instance | uv 0.8.13
2026-08-19 20:26:14.702417 | instance | ok: Runtime: 0:00:00.010190
2026-08-19 20:26:14.712766 | 
2026-08-19 20:26:14.712842 | TASK [Install Ansible collection siblings]
2026-08-19 20:26:23.834764 | instance | changed:
2026-08-19 20:26:23.835050 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:26:23.835085 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:26:23.835109 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:26:23.835130 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:26:23.835150 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:26:23.835176 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:26:23.835197 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:26:23.835220 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:26:23.835242 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:26:23.835262 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:26:23.835282 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:26:23.835302 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:26:23.835322 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0
2026-08-19 20:26:23.835341 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-19 20:26:23.835360 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0
2026-08-19 20:26:23.835381 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-19 20:26:23.835400 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-19 20:26:23.835419 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-19 20:26:23.835440 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-19 20:26:23.835460 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0
2026-08-19 20:26:23.835479 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0
2026-08-19 20:26:23.835499 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-19 20:26:23.835520 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:26:23.835556 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-19 20:26:23.835576 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:26:23.835596 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:26:23.835616 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-19 20:26:23.835635 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-19 20:26:23.835654 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:26:23.835674 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-19 20:26:23.835693 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-19 20:26:23.835713 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:26:23.835733 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:26:23.835752 | instance | Checked out ansible.netcommon to v8.6.2
2026-08-19 20:26:23.835772 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:26:23.835799 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.835817 | instance | Process install dependency map
2026-08-19 20:26:23.835836 | instance | Starting collection install process
2026-08-19 20:26:23.835855 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-19 20:26:23.835875 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-19 20:26:23.835894 | instance | ansible.netcommon:8.6.2 was installed successfully
2026-08-19 20:26:23.835913 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-19 20:26:23.835948 | instance | Creating virtual environment at: .venv
2026-08-19 20:26:23.835969 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:26:23.835989 | instance | Downloading pygments (1.2MiB)
2026-08-19 20:26:23.836012 | instance | Downloading ansible-core (2.1MiB)
2026-08-19 20:26:23.836032 | instance | Downloading cryptography (4.2MiB)
2026-08-19 20:26:23.836051 | instance | Downloading setuptools (1.1MiB)
2026-08-19 20:26:23.836070 | instance | Downloading kubernetes (1.9MiB)
2026-08-19 20:26:23.836090 | instance | Downloading rjsonnet (1.2MiB)
2026-08-19 20:26:23.836108 | instance | Downloading netaddr (2.2MiB)
2026-08-19 20:26:23.836128 | instance | Downloading openstacksdk (1.7MiB)
2026-08-19 20:26:23.836146 | instance |    Building pyperclip==1.9.0
2026-08-19 20:26:23.836166 | instance |  Downloading rjsonnet
2026-08-19 20:26:23.836186 | instance |  Downloading netaddr
2026-08-19 20:26:23.836205 | instance |  Downloading pygments
2026-08-19 20:26:23.836225 | instance |  Downloading cryptography
2026-08-19 20:26:23.836243 | instance |  Downloading setuptools
2026-08-19 20:26:23.836262 | instance |  Downloading kubernetes
2026-08-19 20:26:23.836280 | instance |  Downloading ansible-core
2026-08-19 20:26:23.836300 | instance |  Downloading openstacksdk
2026-08-19 20:26:23.836319 | instance |       Built pyperclip==1.9.0
2026-08-19 20:26:23.836338 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:26:23.836358 | instance | Installed 79 packages in 82ms
2026-08-19 20:26:23.836377 | instance | Checked out ansible.posix to 1.6.0
2026-08-19 20:26:23.836397 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:26:23.836416 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.836434 | instance | Process install dependency map
2026-08-19 20:26:23.836458 | instance | Starting collection install process
2026-08-19 20:26:23.836478 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-19 20:26:23.836497 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-19 20:26:23.836517 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-19 20:26:23.836536 | instance | Checked out ansible.utils to v6.1.0
2026-08-19 20:26:23.836556 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:26:23.836575 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.836594 | instance | Process install dependency map
2026-08-19 20:26:23.836613 | instance | Starting collection install process
2026-08-19 20:26:23.836631 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-19 20:26:23.836650 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-19 20:26:23.836669 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-19 20:26:23.836688 | instance | Checked out atmosphere.common to v0.6.0
2026-08-19 20:26:23.836708 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:26:23.836728 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.836747 | instance | Process install dependency map
2026-08-19 20:26:23.836766 | instance | Starting collection install process
2026-08-19 20:26:23.836786 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-19 20:26:23.836803 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-19 20:26:23.836823 | instance | atmosphere.common:0.6.0 was installed successfully
2026-08-19 20:26:23.836841 | instance | Checked out community.crypto to 2.2.3
2026-08-19 20:26:23.836861 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:26:23.836880 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.836899 | instance | Process install dependency map
2026-08-19 20:26:23.836918 | instance | Starting collection install process
2026-08-19 20:26:23.836936 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-19 20:26:23.836955 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-19 20:26:23.837075 | instance | community.crypto:2.2.3 was installed successfully
2026-08-19 20:26:23.837155 | instance | Checked out community.general to 7.3.0
2026-08-19 20:26:23.837181 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:26:23.837202 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837221 | instance | Process install dependency map
2026-08-19 20:26:23.837240 | instance | Starting collection install process
2026-08-19 20:26:23.837259 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-19 20:26:23.837279 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-19 20:26:23.837299 | instance | community.general:7.3.0 was installed successfully
2026-08-19 20:26:23.837323 | instance | Checked out community.mysql to 3.6.0
2026-08-19 20:26:23.837344 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:26:23.837363 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837382 | instance | Process install dependency map
2026-08-19 20:26:23.837401 | instance | Starting collection install process
2026-08-19 20:26:23.837420 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-19 20:26:23.837439 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-19 20:26:23.837458 | instance | community.mysql:3.6.0 was installed successfully
2026-08-19 20:26:23.837477 | instance | Checked out kubernetes.core to 2.4.0
2026-08-19 20:26:23.837497 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:26:23.837517 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837536 | instance | Process install dependency map
2026-08-19 20:26:23.837558 | instance | Starting collection install process
2026-08-19 20:26:23.837578 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-19 20:26:23.837596 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-19 20:26:23.837616 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-19 20:26:23.837636 | instance | Checked out openstack.cloud to 1.7.0
2026-08-19 20:26:23.837654 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:26:23.837673 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837692 | instance | Process install dependency map
2026-08-19 20:26:23.837710 | instance | Starting collection install process
2026-08-19 20:26:23.837728 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-19 20:26:23.837747 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-19 20:26:23.837767 | instance | openstack.cloud:1.7.0 was installed successfully
2026-08-19 20:26:23.837785 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-19 20:26:23.837804 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:26:23.837823 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837842 | instance | Process install dependency map
2026-08-19 20:26:23.837860 | instance | Starting collection install process
2026-08-19 20:26:23.837880 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-19 20:26:23.837898 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-19 20:26:23.837917 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-19 20:26:23.837936 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-19 20:26:23.837955 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:26:23.837973 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.837998 | instance | Process install dependency map
2026-08-19 20:26:23.838017 | instance | Starting collection install process
2026-08-19 20:26:23.838036 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-19 20:26:23.838055 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-19 20:26:23.838074 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-19 20:26:23.838092 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-19 20:26:23.838111 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:26:23.838129 | instance | Starting galaxy collection install process
2026-08-19 20:26:23.838148 | instance | Process install dependency map
2026-08-19 20:26:23.838167 | instance | Starting collection install process
2026-08-19 20:26:23.838185 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-19 20:26:23.838204 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-19 20:26:23.838222 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-19 20:26:23.843542 | 
2026-08-19 20:26:23.843582 | PLAY RECAP
2026-08-19 20:26:23.843626 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:26:23.843647 | 
2026-08-19 20:26:23.972713 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:26:23.977997 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:26:24.594158 | 
2026-08-19 20:26:24.594695 | PLAY [all]
2026-08-19 20:26:24.605789 | 
2026-08-19 20:26:24.605871 | TASK [Install "jq" for log collection]
2026-08-19 20:26:34.535466 | instance | changed
2026-08-19 20:26:34.538050 | 
2026-08-19 20:26:34.538133 | PLAY RECAP
2026-08-19 20:26:34.538204 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:26:34.538275 | 
2026-08-19 20:26:34.659160 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:26:34.663967 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:26:35.319106 | 
2026-08-19 20:26:35.319244 | PLAY [all]
2026-08-19 20:26:35.330408 | 
2026-08-19 20:26:35.330488 | LOOP [Check inventory directories]
2026-08-19 20:26:35.680310 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-19 20:26:35.830877 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-19 20:26:35.983500 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-19 20:26:35.993456 | 
2026-08-19 20:26:35.993673 | LOOP [Copy inventory file for Zuul]
2026-08-19 20:26:36.790277 | instance | changed:
2026-08-19 20:26:36.790473 | instance | {
2026-08-19 20:26:36.790505 | instance |   "ansible_loop_var": "item",
2026-08-19 20:26:36.790531 | instance |   "changed": false,
2026-08-19 20:26:36.790554 | instance |   "failed": false,
2026-08-19 20:26:36.790584 | instance |   "invocation": {
2026-08-19 20:26:36.790606 | instance |     "module_args": {
2026-08-19 20:26:36.790628 | instance |       "checksum_algorithm": "sha1",
2026-08-19 20:26:36.790648 | instance |       "follow": true,
2026-08-19 20:26:36.790669 | instance |       "get_attributes": true,
2026-08-19 20:26:36.790690 | instance |       "get_checksum": true,
2026-08-19 20:26:36.790711 | instance |       "get_mime": true,
2026-08-19 20:26:36.790730 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-19 20:26:36.790751 | instance |     }
2026-08-19 20:26:36.790853 | instance |   },
2026-08-19 20:26:36.790878 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:26:36.790897 | instance |   "stat": {
2026-08-19 20:26:36.790914 | instance |     "atime": 1787171176.7978542,
2026-08-19 20:26:36.790932 | instance |     "attr_flags": "e",
2026-08-19 20:26:36.790950 | instance |     "attributes": [
2026-08-19 20:26:36.790967 | instance |       "extents"
2026-08-19 20:26:36.790984 | instance |     ],
2026-08-19 20:26:36.791001 | instance |     "block_size": 4096,
2026-08-19 20:26:36.791018 | instance |     "blocks": 8,
2026-08-19 20:26:36.791035 | instance |     "charset": "unknown",
2026-08-19 20:26:36.791054 | instance |     "ctime": 1787171175.4937575,
2026-08-19 20:26:36.791072 | instance |     "dev": 64513,
2026-08-19 20:26:36.791089 | instance |     "device_type": 0,
2026-08-19 20:26:36.791106 | instance |     "executable": true,
2026-08-19 20:26:36.791124 | instance |     "exists": true,
2026-08-19 20:26:36.791141 | instance |     "gid": 1000,
2026-08-19 20:26:36.791158 | instance |     "gr_name": "zuul",
2026-08-19 20:26:36.791175 | instance |     "inode": 1047829,
2026-08-19 20:26:36.791192 | instance |     "isblk": false,
2026-08-19 20:26:36.791209 | instance |     "ischr": false,
2026-08-19 20:26:36.791226 | instance |     "isdir": true,
2026-08-19 20:26:36.791243 | instance |     "isfifo": false,
2026-08-19 20:26:36.791261 | instance |     "isgid": false,
2026-08-19 20:26:36.791277 | instance |     "islnk": false,
2026-08-19 20:26:36.791294 | instance |     "isreg": false,
2026-08-19 20:26:36.791311 | instance |     "issock": false,
2026-08-19 20:26:36.791328 | instance |     "isuid": false,
2026-08-19 20:26:36.791345 | instance |     "mimetype": "unknown",
2026-08-19 20:26:36.791361 | instance |     "mode": "0755",
2026-08-19 20:26:36.791378 | instance |     "mtime": 1787171175.4937575,
2026-08-19 20:26:36.791395 | instance |     "nlink": 21,
2026-08-19 20:26:36.791412 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:26:36.791429 | instance |     "pw_name": "zuul",
2026-08-19 20:26:36.791450 | instance |     "readable": true,
2026-08-19 20:26:36.791468 | instance |     "rgrp": true,
2026-08-19 20:26:36.791485 | instance |     "roth": true,
2026-08-19 20:26:36.791502 | instance |     "rusr": true,
2026-08-19 20:26:36.791520 | instance |     "size": 4096,
2026-08-19 20:26:36.791537 | instance |     "uid": 1000,
2026-08-19 20:26:36.791554 | instance |     "version": "932447561",
2026-08-19 20:26:36.791571 | instance |     "wgrp": false,
2026-08-19 20:26:36.791590 | instance |     "woth": false,
2026-08-19 20:26:36.791608 | instance |     "writeable": true,
2026-08-19 20:26:36.791626 | instance |     "wusr": true,
2026-08-19 20:26:36.791643 | instance |     "xgrp": true,
2026-08-19 20:26:36.791660 | instance |     "xoth": true,
2026-08-19 20:26:36.791677 | instance |     "xusr": true
2026-08-19 20:26:36.791694 | instance |   }
2026-08-19 20:26:36.791712 | instance | }
2026-08-19 20:26:36.791775 | instance | ok: All items complete
2026-08-19 20:26:36.791799 | 
2026-08-19 20:26:36.793048 | instance | skipping: Conditional result was False
2026-08-19 20:26:36.793651 | instance | skipping: Conditional result was False
2026-08-19 20:26:36.814026 | 
2026-08-19 20:26:36.814120 | LOOP [Switch "ansible_host" to private IP]
2026-08-19 20:26:37.146579 | instance | changed: 1 replacements made
2026-08-19 20:26:37.148575 | instance | skipping: Conditional result was False
2026-08-19 20:26:37.149509 | instance | skipping: Conditional result was False
2026-08-19 20:26:37.166638 | 
2026-08-19 20:26:37.166796 | TASK [Run Molecule scenario]
2026-08-19 20:26:38.087614 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-19 20:26:38.488786 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-19 20:26:38.488863 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-19 20:26:49.374498 | instance | INFO     [csi > dependency] Executing
2026-08-19 20:26:49.374659 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-19 20:26:49.374864 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-19 20:26:49.375011 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-19 20:26:49.382594 | instance | INFO     [csi > cleanup] Executing
2026-08-19 20:26:49.383327 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:26:49.390931 | instance | INFO     [csi > destroy] Executing
2026-08-19 20:26:49.391012 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-19 20:26:49.391118 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-19 20:26:49.398731 | instance | INFO     [csi > syntax] Executing
2026-08-19 20:26:50.991478 | instance |
2026-08-19 20:26:50.991859 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:26:51.051182 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-19 20:26:51.063074 | instance | INFO     [csi > create] Executing
2026-08-19 20:26:51.065046 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:26:51.072732 | instance | INFO     [csi > prepare] Executing
2026-08-19 20:26:51.833971 | instance |
2026-08-19 20:26:51.834115 | instance | PLAY [Prepare] *****************************************************************
2026-08-19 20:26:51.834269 | instance |
2026-08-19 20:26:51.834454 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:26:51.834634 | instance | Wednesday 19 August 2026  20:26:51 +0000 (0:00:00.025)       0:00:00.025 ******
2026-08-19 20:26:52.970990 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:26:52.971137 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:26:52.971316 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:26:52.971509 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:26:52.971722 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:26:52.979971 | instance | ok: [instance]
2026-08-19 20:26:52.980166 | instance |
2026-08-19 20:26:52.980361 | instance | TASK [Configure short hostname] ************************************************
2026-08-19 20:26:52.980564 | instance | Wednesday 19 August 2026  20:26:52 +0000 (0:00:01.146)       0:00:01.172 ******
2026-08-19 20:26:53.639277 | instance | changed: [instance]
2026-08-19 20:26:53.639354 | instance |
2026-08-19 20:26:53.639463 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-19 20:26:53.639584 | instance | Wednesday 19 August 2026  20:26:53 +0000 (0:00:00.658)       0:00:01.831 ******
2026-08-19 20:26:53.873558 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-19 20:26:53.873962 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-19 20:26:53.874378 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-19 20:26:53.880045 | instance | changed: [instance]
2026-08-19 20:26:53.880262 | instance |
2026-08-19 20:26:53.880460 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-19 20:26:53.880679 | instance | Wednesday 19 August 2026  20:26:53 +0000 (0:00:00.241)       0:00:02.072 ******
2026-08-19 20:26:54.690773 | instance | ok: [instance]
2026-08-19 20:26:54.691027 | instance |
2026-08-19 20:26:54.691393 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-19 20:26:54.691670 | instance |
2026-08-19 20:26:54.691941 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:26:54.692284 | instance | Wednesday 19 August 2026  20:26:54 +0000 (0:00:00.810)       0:00:02.883 ******
2026-08-19 20:26:55.368438 | instance | ok: [instance]
2026-08-19 20:26:55.368832 | instance |
2026-08-19 20:26:55.369299 | instance | TASK [Install depedencies] *****************************************************
2026-08-19 20:26:55.369747 | instance | Wednesday 19 August 2026  20:26:55 +0000 (0:00:00.677)       0:00:03.560 ******
2026-08-19 20:27:16.321689 | instance | changed: [instance]
2026-08-19 20:27:16.321765 | instance |
2026-08-19 20:27:16.321896 | instance | TASK [Start up service] ********************************************************
2026-08-19 20:27:16.322069 | instance | Wednesday 19 August 2026  20:27:16 +0000 (0:00:20.953)       0:00:24.514 ******
2026-08-19 20:27:16.856988 | instance | ok: [instance]
2026-08-19 20:27:16.857286 | instance |
2026-08-19 20:27:16.857611 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-19 20:27:16.857926 | instance | Wednesday 19 August 2026  20:27:16 +0000 (0:00:00.534)       0:00:25.049 ******
2026-08-19 20:27:17.149115 | instance | ok: [instance]
2026-08-19 20:27:17.149379 | instance |
2026-08-19 20:27:17.149672 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-19 20:27:17.149956 | instance | Wednesday 19 August 2026  20:27:17 +0000 (0:00:00.291)       0:00:25.341 ******
2026-08-19 20:27:17.784762 | instance | changed: [instance]
2026-08-19 20:27:17.784824 | instance |
2026-08-19 20:27:17.784871 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-19 20:27:17.784883 | instance | Wednesday 19 August 2026  20:27:17 +0000 (0:00:00.634)       0:00:25.976 ******
2026-08-19 20:27:17.961739 | instance | ok: [instance]
2026-08-19 20:27:17.962234 | instance |
2026-08-19 20:27:17.962257 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-19 20:27:17.962264 | instance | Wednesday 19 August 2026  20:27:17 +0000 (0:00:00.178)       0:00:26.154 ******
2026-08-19 20:27:17.982435 | instance | skipping: [instance]
2026-08-19 20:27:17.982960 | instance |
2026-08-19 20:27:17.982984 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-19 20:27:17.982992 | instance | Wednesday 19 August 2026  20:27:17 +0000 (0:00:00.020)       0:00:26.175 ******
2026-08-19 20:27:18.488833 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:27:18.489785 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:27:18.489829 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:27:18.489836 | instance |
2026-08-19 20:27:18.489843 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-19 20:27:18.489849 | instance | Wednesday 19 August 2026  20:27:18 +0000 (0:00:00.506)       0:00:26.681 ******
2026-08-19 20:27:19.091198 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:27:19.091240 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:27:19.091246 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:27:19.091252 | instance |
2026-08-19 20:27:19.091258 | instance | TASK [Start loop devices] ******************************************************
2026-08-19 20:27:19.091264 | instance | Wednesday 19 August 2026  20:27:19 +0000 (0:00:00.601)       0:00:27.283 ******
2026-08-19 20:27:19.768967 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:27:19.769421 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:27:19.769484 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:27:19.769502 | instance |
2026-08-19 20:27:19.769872 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-19 20:27:19.769914 | instance | Wednesday 19 August 2026  20:27:19 +0000 (0:00:00.678)       0:00:27.961 ******
2026-08-19 20:27:22.967733 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:27:22.967786 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:27:22.967803 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:27:22.968347 | instance |
2026-08-19 20:27:22.968391 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-19 20:27:22.968400 | instance | Wednesday 19 August 2026  20:27:22 +0000 (0:00:03.198)       0:00:31.160 ******
2026-08-19 20:27:24.846520 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-19 20:27:24.846569 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-19 20:27:24.846594 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-19 20:27:24.846604 | instance |
2026-08-19 20:27:24.846618 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:27:24.847612 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-19 20:27:24.847619 | instance |
2026-08-19 20:27:24.847623 | instance | Wednesday 19 August 2026  20:27:24 +0000 (0:00:01.878)       0:00:33.038 ******
2026-08-19 20:27:24.847628 | instance | ===============================================================================
2026-08-19 20:27:24.851545 | instance | Install depedencies ---------------------------------------------------- 20.95s
2026-08-19 20:27:24.851613 | instance | Create a volume group for each loop device ------------------------------ 3.20s
2026-08-19 20:27:24.851622 | instance | Create a logical volume for each loop device ---------------------------- 1.88s
2026-08-19 20:27:24.851629 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-08-19 20:27:24.851635 | instance | Purge "snapd" package --------------------------------------------------- 0.81s
2026-08-19 20:27:24.851641 | instance | Start loop devices ------------------------------------------------------ 0.68s
2026-08-19 20:27:24.851647 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-08-19 20:27:24.851653 | instance | Configure short hostname ------------------------------------------------ 0.66s
2026-08-19 20:27:24.851659 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.63s
2026-08-19 20:27:24.851665 | instance | Set permissions on loopback devices ------------------------------------- 0.60s
2026-08-19 20:27:24.851671 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-19 20:27:24.851677 | instance | Create devices for Ceph ------------------------------------------------- 0.51s
2026-08-19 20:27:24.851683 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-19 20:27:24.851689 | instance | Ensure hostname inside hosts file --------------------------------------- 0.24s
2026-08-19 20:27:24.851695 | instance | Get list of all loopback devices ---------------------------------------- 0.18s
2026-08-19 20:27:24.851701 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-19 20:27:24.907238 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-19 20:27:24.919239 | instance | INFO     [csi > converge] Executing
2026-08-19 20:27:26.347378 | instance |
2026-08-19 20:27:26.347692 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-19 20:27:26.347912 | instance |
2026-08-19 20:27:26.348137 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:27:26.348358 | instance | Wednesday 19 August 2026  20:27:26 +0000 (0:00:00.007)       0:00:00.007 ******
2026-08-19 20:27:27.297540 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:27:27.297941 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:27:27.298375 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:27:27.298748 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:27:27.299093 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:27:27.308317 | instance | ok: [instance]
2026-08-19 20:27:27.308656 | instance |
2026-08-19 20:27:27.308995 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-19 20:27:27.309326 | instance | Wednesday 19 August 2026  20:27:27 +0000 (0:00:00.960)       0:00:00.968 ******
2026-08-19 20:27:27.352365 | instance | ok: [instance] => {
2026-08-19 20:27:27.352751 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-19 20:27:27.353077 | instance | }
2026-08-19 20:27:27.353408 | instance |
2026-08-19 20:27:27.353738 | instance | PLAY [all] *********************************************************************
2026-08-19 20:27:27.354045 | instance |
2026-08-19 20:27:27.354367 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:27:27.354716 | instance | Wednesday 19 August 2026  20:27:27 +0000 (0:00:00.044)       0:00:01.012 ******
2026-08-19 20:27:28.228220 | instance | ok: [instance]
2026-08-19 20:27:28.228438 | instance |
2026-08-19 20:27:28.228652 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-19 20:27:28.228869 | instance | Wednesday 19 August 2026  20:27:28 +0000 (0:00:00.875)       0:00:01.888 ******
2026-08-19 20:27:28.413539 | instance | ok: [instance]
2026-08-19 20:27:28.413853 | instance |
2026-08-19 20:27:28.414088 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-19 20:27:28.414294 | instance |
2026-08-19 20:27:28.414512 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:27:28.414735 | instance | Wednesday 19 August 2026  20:27:28 +0000 (0:00:00.185)       0:00:02.074 ******
2026-08-19 20:27:29.275756 | instance | ok: [instance]
2026-08-19 20:27:29.276163 | instance |
2026-08-19 20:27:29.276528 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:27:29.276958 | instance | Wednesday 19 August 2026  20:27:29 +0000 (0:00:00.861)       0:00:02.935 ******
2026-08-19 20:27:29.542534 | instance | ok: [instance]
2026-08-19 20:27:29.542979 | instance |
2026-08-19 20:27:29.543355 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:27:29.543814 | instance | Wednesday 19 August 2026  20:27:29 +0000 (0:00:00.266)       0:00:03.202 ******
2026-08-19 20:27:29.584116 | instance | skipping: [instance]
2026-08-19 20:27:29.584199 | instance |
2026-08-19 20:27:29.584345 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-19 20:27:29.584539 | instance | Wednesday 19 August 2026  20:27:29 +0000 (0:00:00.041)       0:00:03.244 ******
2026-08-19 20:27:29.924346 | instance | changed: [instance]
2026-08-19 20:27:29.924726 | instance |
2026-08-19 20:27:29.925152 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:27:29.925509 | instance | Wednesday 19 August 2026  20:27:29 +0000 (0:00:00.338)       0:00:03.583 ******
2026-08-19 20:27:29.992129 | instance | ok: [instance] => {
2026-08-19 20:27:29.992271 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-19 20:27:29.992463 | instance | }
2026-08-19 20:27:29.992608 | instance |
2026-08-19 20:27:29.992764 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:27:29.992916 | instance | Wednesday 19 August 2026  20:27:29 +0000 (0:00:00.067)       0:00:03.650 ******
2026-08-19 20:27:30.556889 | instance | changed: [instance]
2026-08-19 20:27:30.557372 | instance |
2026-08-19 20:27:30.557391 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:27:30.557398 | instance | Wednesday 19 August 2026  20:27:30 +0000 (0:00:00.566)       0:00:04.217 ******
2026-08-19 20:27:30.603266 | instance | skipping: [instance]
2026-08-19 20:27:30.603316 | instance |
2026-08-19 20:27:30.603468 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:27:30.603598 | instance | Wednesday 19 August 2026  20:27:30 +0000 (0:00:00.046)       0:00:04.263 ******
2026-08-19 20:27:30.650195 | instance | skipping: [instance]
2026-08-19 20:27:30.650365 | instance |
2026-08-19 20:27:30.650646 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:27:30.650660 | instance | Wednesday 19 August 2026  20:27:30 +0000 (0:00:00.046)       0:00:04.310 ******
2026-08-19 20:27:30.863207 | instance | ok: [instance]
2026-08-19 20:27:30.863805 | instance |
2026-08-19 20:27:30.863880 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:27:30.863903 | instance | Wednesday 19 August 2026  20:27:30 +0000 (0:00:00.212)       0:00:04.523 ******
2026-08-19 20:27:32.080089 | instance | ok: [instance]
2026-08-19 20:27:32.080156 | instance |
2026-08-19 20:27:32.080268 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:27:32.080458 | instance | Wednesday 19 August 2026  20:27:32 +0000 (0:00:01.217)       0:00:05.740 ******
2026-08-19 20:27:32.144061 | instance | ok: [instance] => {
2026-08-19 20:27:32.144215 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-19 20:27:32.144413 | instance | }
2026-08-19 20:27:32.144560 | instance |
2026-08-19 20:27:32.144716 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:27:32.144870 | instance | Wednesday 19 August 2026  20:27:32 +0000 (0:00:00.063)       0:00:05.804 ******
2026-08-19 20:27:32.810589 | instance | changed: [instance]
2026-08-19 20:27:32.810676 | instance |
2026-08-19 20:27:32.810783 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:27:32.811039 | instance | Wednesday 19 August 2026  20:27:32 +0000 (0:00:00.666)       0:00:06.471 ******
2026-08-19 20:27:35.667555 | instance | changed: [instance]
2026-08-19 20:27:35.667613 | instance |
2026-08-19 20:27:35.667675 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-19 20:27:35.667688 | instance | Wednesday 19 August 2026  20:27:35 +0000 (0:00:02.856)       0:00:09.327 ******
2026-08-19 20:27:35.694856 | instance | skipping: [instance]
2026-08-19 20:27:35.694928 | instance |
2026-08-19 20:27:35.695193 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-19 20:27:35.695226 | instance | Wednesday 19 August 2026  20:27:35 +0000 (0:00:00.027)       0:00:09.355 ******
2026-08-19 20:27:35.728839 | instance | skipping: [instance]
2026-08-19 20:27:35.729607 | instance |
2026-08-19 20:27:35.729655 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-19 20:27:35.729664 | instance | Wednesday 19 August 2026  20:27:35 +0000 (0:00:00.033)       0:00:09.388 ******
2026-08-19 20:27:35.763493 | instance | skipping: [instance]
2026-08-19 20:27:35.763562 | instance |
2026-08-19 20:27:35.763723 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-19 20:27:35.763851 | instance | Wednesday 19 August 2026  20:27:35 +0000 (0:00:00.035)       0:00:09.423 ******
2026-08-19 20:27:41.185222 | instance | changed: [instance]
2026-08-19 20:27:41.185425 | instance |
2026-08-19 20:27:41.185484 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-19 20:27:41.185780 | instance | Wednesday 19 August 2026  20:27:41 +0000 (0:00:05.421)       0:00:14.845 ******
2026-08-19 20:27:41.763423 | instance | changed: [instance]
2026-08-19 20:27:41.763719 | instance |
2026-08-19 20:27:41.764018 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-19 20:27:41.764309 | instance | Wednesday 19 August 2026  20:27:41 +0000 (0:00:00.578)       0:00:15.423 ******
2026-08-19 20:27:42.679701 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-19 20:27:42.679765 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-19 20:27:42.679783 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-19 20:27:42.680130 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-19 20:27:42.680648 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-19 20:27:42.681068 | instance |
2026-08-19 20:27:42.681556 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-19 20:27:42.681966 | instance | Wednesday 19 August 2026  20:27:42 +0000 (0:00:00.915)       0:00:16.338 ******
2026-08-19 20:27:43.270640 | instance | changed: [instance]
2026-08-19 20:27:43.270750 | instance |
2026-08-19 20:27:43.271356 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-19 20:27:43.271404 | instance | Wednesday 19 August 2026  20:27:43 +0000 (0:00:00.575)       0:00:16.914 ******
2026-08-19 20:27:43.271410 | instance |
2026-08-19 20:27:43.271415 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:27:43.271419 | instance | Wednesday 19 August 2026  20:27:43 +0000 (0:00:00.016)       0:00:16.931 ******
2026-08-19 20:27:44.196248 | instance | ok: [instance]
2026-08-19 20:27:44.196311 | instance |
2026-08-19 20:27:44.196643 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-19 20:27:44.196681 | instance | Wednesday 19 August 2026  20:27:44 +0000 (0:00:00.925)       0:00:17.856 ******
2026-08-19 20:27:44.634016 | instance | changed: [instance]
2026-08-19 20:27:44.634119 | instance |
2026-08-19 20:27:44.634447 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-19 20:27:44.634489 | instance | Wednesday 19 August 2026  20:27:44 +0000 (0:00:00.438)       0:00:18.294 ******
2026-08-19 20:27:45.171567 | instance | changed: [instance]
2026-08-19 20:27:45.171658 | instance |
2026-08-19 20:27:45.171921 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:27:45.171937 | instance | Wednesday 19 August 2026  20:27:45 +0000 (0:00:00.537)       0:00:18.831 ******
2026-08-19 20:27:45.364267 | instance | ok: [instance]
2026-08-19 20:27:45.364336 | instance |
2026-08-19 20:27:45.364611 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:27:45.364676 | instance | Wednesday 19 August 2026  20:27:45 +0000 (0:00:00.192)       0:00:19.024 ******
2026-08-19 20:27:45.420179 | instance | ok: [instance] => {
2026-08-19 20:27:45.421032 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-19 20:27:45.421051 | instance | }
2026-08-19 20:27:45.421058 | instance |
2026-08-19 20:27:45.421065 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:27:45.421071 | instance | Wednesday 19 August 2026  20:27:45 +0000 (0:00:00.056)       0:00:19.080 ******
2026-08-19 20:27:46.280456 | instance | changed: [instance]
2026-08-19 20:27:46.280527 | instance |
2026-08-19 20:27:46.280825 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:27:46.280887 | instance | Wednesday 19 August 2026  20:27:46 +0000 (0:00:00.859)       0:00:19.940 ******
2026-08-19 20:27:50.645866 | instance | changed: [instance]
2026-08-19 20:27:50.645992 | instance |
2026-08-19 20:27:50.646267 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-19 20:27:50.646323 | instance | Wednesday 19 August 2026  20:27:50 +0000 (0:00:04.365)       0:00:24.306 ******
2026-08-19 20:27:51.978436 | instance | ok: [instance]
2026-08-19 20:27:51.978530 | instance |
2026-08-19 20:27:51.978755 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-19 20:27:51.978795 | instance | Wednesday 19 August 2026  20:27:51 +0000 (0:00:01.332)       0:00:25.638 ******
2026-08-19 20:27:52.309939 | instance | changed: [instance]
2026-08-19 20:27:52.310043 | instance |
2026-08-19 20:27:52.310314 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-19 20:27:52.310350 | instance | Wednesday 19 August 2026  20:27:52 +0000 (0:00:00.331)       0:00:25.970 ******
2026-08-19 20:27:52.781162 | instance | changed: [instance]
2026-08-19 20:27:52.781235 | instance |
2026-08-19 20:27:52.781509 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-19 20:27:52.781548 | instance | Wednesday 19 August 2026  20:27:52 +0000 (0:00:00.471)       0:00:26.441 ******
2026-08-19 20:27:53.353840 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-19 20:27:53.353907 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-19 20:27:53.354422 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-19 20:27:53.354461 | instance |
2026-08-19 20:27:53.354467 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-19 20:27:53.354472 | instance | Wednesday 19 August 2026  20:27:53 +0000 (0:00:00.572)       0:00:27.014 ******
2026-08-19 20:27:53.816696 | instance | changed: [instance]
2026-08-19 20:27:53.817050 | instance |
2026-08-19 20:27:53.817067 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-19 20:27:53.817073 | instance | Wednesday 19 August 2026  20:27:53 +0000 (0:00:00.462)       0:00:27.477 ******
2026-08-19 20:27:54.290278 | instance | changed: [instance]
2026-08-19 20:27:54.291053 | instance |
2026-08-19 20:27:54.291070 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-19 20:27:54.291075 | instance | Wednesday 19 August 2026  20:27:54 +0000 (0:00:00.456)       0:00:27.934 ******
2026-08-19 20:27:54.291080 | instance |
2026-08-19 20:27:54.291084 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:27:54.291088 | instance | Wednesday 19 August 2026  20:27:54 +0000 (0:00:00.016)       0:00:27.950 ******
2026-08-19 20:27:54.944851 | instance | ok: [instance]
2026-08-19 20:27:54.944919 | instance |
2026-08-19 20:27:54.945229 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-19 20:27:54.945438 | instance | Wednesday 19 August 2026  20:27:54 +0000 (0:00:00.654)       0:00:28.605 ******
2026-08-19 20:27:55.840050 | instance | changed: [instance]
2026-08-19 20:27:55.840546 | instance |
2026-08-19 20:27:55.840566 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-19 20:27:55.840573 | instance | Wednesday 19 August 2026  20:27:55 +0000 (0:00:00.895)       0:00:29.500 ******
2026-08-19 20:27:56.384961 | instance | changed: [instance]
2026-08-19 20:27:56.385472 | instance |
2026-08-19 20:27:56.385489 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-19 20:27:56.385497 | instance | Wednesday 19 August 2026  20:27:56 +0000 (0:00:00.544)       0:00:30.045 ******
2026-08-19 20:27:56.441608 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-19 20:27:56.441714 | instance |
2026-08-19 20:27:56.442008 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-19 20:27:56.442048 | instance | Wednesday 19 August 2026  20:27:56 +0000 (0:00:00.056)       0:00:30.101 ******
2026-08-19 20:28:01.327252 | instance | changed: [instance]
2026-08-19 20:28:01.327383 | instance |
2026-08-19 20:28:01.327721 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-19 20:28:01.327809 | instance | Wednesday 19 August 2026  20:28:01 +0000 (0:00:04.885)       0:00:34.987 ******
2026-08-19 20:28:02.001145 | instance | ok: [instance] => (item=chronyd)
2026-08-19 20:28:02.001221 | instance | ok: [instance] => (item=sshd)
2026-08-19 20:28:02.001655 | instance |
2026-08-19 20:28:02.001696 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-19 20:28:02.001702 | instance | Wednesday 19 August 2026  20:28:01 +0000 (0:00:00.673)       0:00:35.661 ******
2026-08-19 20:28:03.165585 | instance | changed: [instance]
2026-08-19 20:28:03.165666 | instance |
2026-08-19 20:28:03.165910 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-19 20:28:03.165947 | instance | Wednesday 19 August 2026  20:28:03 +0000 (0:00:01.164)       0:00:36.825 ******
2026-08-19 20:28:03.371778 | instance | ok: [instance]
2026-08-19 20:28:03.371848 | instance |
2026-08-19 20:28:03.372114 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-19 20:28:03.372156 | instance | Wednesday 19 August 2026  20:28:03 +0000 (0:00:00.206)       0:00:37.032 ******
2026-08-19 20:28:03.827972 | instance | changed: [instance]
2026-08-19 20:28:03.828049 | instance |
2026-08-19 20:28:03.828338 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-19 20:28:03.828372 | instance | Wednesday 19 August 2026  20:28:03 +0000 (0:00:00.456)       0:00:37.488 ******
2026-08-19 20:28:04.207826 | instance | changed: [instance]
2026-08-19 20:28:04.208378 | instance |
2026-08-19 20:28:04.208428 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-19 20:28:04.208436 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.379)       0:00:37.867 ******
2026-08-19 20:28:04.325469 | instance | ok: [instance]
2026-08-19 20:28:04.325545 | instance |
2026-08-19 20:28:04.325805 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-19 20:28:04.325841 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.117)       0:00:37.985 ******
2026-08-19 20:28:04.544912 | instance | ok: [instance] => (item=instance)
2026-08-19 20:28:04.545259 | instance |
2026-08-19 20:28:04.545325 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-19 20:28:04.545339 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.219)       0:00:38.205 ******
2026-08-19 20:28:04.606748 | instance | ok: [instance]
2026-08-19 20:28:04.606822 | instance |
2026-08-19 20:28:04.606941 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-19 20:28:04.607099 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.061)       0:00:38.267 ******
2026-08-19 20:28:04.678927 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-19 20:28:04.678992 | instance |
2026-08-19 20:28:04.679246 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-19 20:28:04.679285 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.071)       0:00:38.339 ******
2026-08-19 20:28:04.998898 | instance | changed: [instance]
2026-08-19 20:28:04.999324 | instance |
2026-08-19 20:28:04.999389 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-19 20:28:04.999396 | instance | Wednesday 19 August 2026  20:28:04 +0000 (0:00:00.319)       0:00:38.658 ******
2026-08-19 20:28:05.748650 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-19 20:28:05.748723 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-19 20:28:05.748729 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-19 20:28:05.748735 | instance |
2026-08-19 20:28:05.748740 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-19 20:28:05.748745 | instance | Wednesday 19 August 2026  20:28:05 +0000 (0:00:00.748)       0:00:39.407 ******
2026-08-19 20:29:46.366345 | instance | ok: [instance]
2026-08-19 20:29:46.366689 | instance |
2026-08-19 20:29:46.366705 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-19 20:29:46.366711 | instance | Wednesday 19 August 2026  20:29:46 +0000 (0:01:40.619)       0:02:20.026 ******
2026-08-19 20:29:46.613397 | instance | changed: [instance]
2026-08-19 20:29:46.613468 | instance |
2026-08-19 20:29:46.613475 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-19 20:29:46.613480 | instance | Wednesday 19 August 2026  20:29:46 +0000 (0:00:00.246)       0:02:20.272 ******
2026-08-19 20:29:46.716663 | instance | ok: [instance]
2026-08-19 20:29:46.716727 | instance |
2026-08-19 20:29:46.716734 | instance | TASK [Install Ceph host] *******************************************************
2026-08-19 20:29:46.716740 | instance | Wednesday 19 August 2026  20:29:46 +0000 (0:00:00.103)       0:02:20.376 ******
2026-08-19 20:29:46.803904 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-19 20:29:46.804020 | instance |
2026-08-19 20:29:46.804032 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-19 20:29:46.804210 | instance | Wednesday 19 August 2026  20:29:46 +0000 (0:00:00.087)       0:02:20.463 ******
2026-08-19 20:29:48.576388 | instance | ok: [instance]
2026-08-19 20:29:48.576481 | instance |
2026-08-19 20:29:48.576678 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-19 20:29:48.576818 | instance | Wednesday 19 August 2026  20:29:48 +0000 (0:00:01.772)       0:02:22.236 ******
2026-08-19 20:29:48.638804 | instance | ok: [instance] => (item=instance)
2026-08-19 20:29:48.638917 | instance |
2026-08-19 20:29:48.639104 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-19 20:29:48.639273 | instance | Wednesday 19 August 2026  20:29:48 +0000 (0:00:00.062)       0:02:22.298 ******
2026-08-19 20:29:49.072193 | instance | ok: [instance]
2026-08-19 20:29:49.072314 | instance |
2026-08-19 20:29:49.072483 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-19 20:29:49.072662 | instance | Wednesday 19 August 2026  20:29:49 +0000 (0:00:00.433)       0:02:22.732 ******
2026-08-19 20:29:51.675902 | instance | ok: [instance]
2026-08-19 20:29:51.676203 | instance |
2026-08-19 20:29:51.676568 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-19 20:29:51.676850 | instance | Wednesday 19 August 2026  20:29:51 +0000 (0:00:02.602)       0:02:25.335 ******
2026-08-19 20:30:44.475851 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-19 20:30:44.476188 | 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_k8cqx2u2/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_k8cqx2u2/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_k8cqx2u2/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_k8cqx2u2/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-19T20:30:44.303+0000 7fa9447d4640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAKEoZqm0KDDiAAzUcmwVbrKgPSCgCrOIBkrwoGLH6rnqV2YUVGNkSXWAI=: Malformed input [buffer:3]\n2026-08-19T20:30:44.303+0000 7fa9447d4640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:30:44.307+0000 7fa9447d4640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAKEoZqm0KDDiAAzUcmwVbrKgPSCgCrOIBkrwoGLH6rnqV2YUVGNkSXWAI=: Malformed input [buffer:3]\n2026-08-19T20:30:44.307+0000 7fa9447d4640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:30:44.307+0000 7fa9447d4640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAKEoZqm0KDDiAAzUcmwVbrKgPSCgCrOIBkrwoGLH6rnqV2YUVGNkSXWAI=: Malformed input [buffer:3]\n2026-08-19T20:30:44.307+0000 7fa9447d4640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:30:44.307+0000 7fa9447d4640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-19 20:30:44.479769 | instance |
2026-08-19 20:30:44.479895 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:30:44.479908 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-19 20:30:44.479916 | instance |
2026-08-19 20:30:44.479922 | instance | Wednesday 19 August 2026  20:30:44 +0000 (0:00:52.803)       0:03:18.138 ******
2026-08-19 20:30:44.479929 | instance | ===============================================================================
2026-08-19 20:30:44.479947 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 100.62s
2026-08-19 20:30:44.483737 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 52.80s
2026-08-19 20:30:44.483833 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.42s
2026-08-19 20:30:44.483844 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.89s
2026-08-19 20:30:44.483853 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.37s
2026-08-19 20:30:44.483862 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.86s
2026-08-19 20:30:44.483871 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.60s
2026-08-19 20:30:44.483879 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.77s
2026-08-19 20:30:44.483915 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s
2026-08-19 20:30:44.483924 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.33s
2026-08-19 20:30:44.483933 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.22s
2026-08-19 20:30:44.483941 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.16s
2026-08-19 20:30:44.483950 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-08-19 20:30:44.483959 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.92s
2026-08-19 20:30:44.483967 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.90s
2026-08-19 20:30:44.483976 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-19 20:30:44.483985 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-08-19 20:30:44.484006 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.86s
2026-08-19 20:30:44.484017 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.75s
2026-08-19 20:30:44.484275 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.67s
2026-08-19 20:30:44.557492 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:30:44.557773 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-19 20:30:44.557957 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:30:45.108089 | instance | ERROR
2026-08-19 20:30:45.108338 | instance | {
2026-08-19 20:30:45.108381 | instance |   "delta": "0:04:07.097540",
2026-08-19 20:30:45.108411 | instance |   "end": "2026-08-19 20:30:44.605848",
2026-08-19 20:30:45.108439 | instance |   "msg": "non-zero return code",
2026-08-19 20:30:45.108464 | instance |   "rc": 2,
2026-08-19 20:30:45.108490 | instance |   "start": "2026-08-19 20:26:37.508308"
2026-08-19 20:30:45.108516 | instance | }
failure
2026-08-19 20:30:45.116506 | 
2026-08-19 20:30:45.116583 | PLAY RECAP
2026-08-19 20:30:45.116638 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:30:45.116661 | 
2026-08-19 20:30:45.306739 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:30:45.310998 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:30:46.411188 | 
2026-08-19 20:30:46.411386 | PLAY [all]
2026-08-19 20:30:46.426860 | 
2026-08-19 20:30:46.426978 | TASK [gather-host-logs : creating directory for system status]
2026-08-19 20:30:46.856127 | instance | changed
2026-08-19 20:30:46.866267 | 
2026-08-19 20:30:46.866351 | TASK [gather-host-logs : Get logs for each host]
2026-08-19 20:30:47.209551 | instance | + systemd-cgls --full --all --no-pager
2026-08-19 20:30:47.223503 | instance | + ip addr
2026-08-19 20:30:47.226160 | instance | + ip route
2026-08-19 20:30:47.227261 | instance | + lsblk
2026-08-19 20:30:47.232941 | instance | + mount
2026-08-19 20:30:47.235606 | instance | + docker images
2026-08-19 20:30:47.254228 | instance | + brctl show
2026-08-19 20:30:47.254613 | instance | /bin/bash: line 8: brctl: command not found
2026-08-19 20:30:47.254799 | instance | + ps aux --sort=-%mem
2026-08-19 20:30:47.273126 | instance | + dpkg -l
2026-08-19 20:30:47.283865 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-19 20:30:47.284262 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-19 20:30:47.301261 | instance | + '[' '!' -z '' ']'
2026-08-19 20:30:47.402665 | instance | ok: Runtime: 0:00:00.095977
2026-08-19 20:30:47.412328 | 
2026-08-19 20:30:47.412439 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-19 20:30:48.227124 | instance | changed:
2026-08-19 20:30:48.227407 | instance | created directory /var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/logs/instance
2026-08-19 20:30:48.227450 | instance | cd+++++++++ system/
2026-08-19 20:30:48.227482 | instance | >f+++++++++ system/brctl-show.txt
2026-08-19 20:30:48.227512 | instance | >f+++++++++ system/docker-images.txt
2026-08-19 20:30:48.227540 | instance | >f+++++++++ system/ip-addr.txt
2026-08-19 20:30:48.227573 | instance | >f+++++++++ system/ip-route.txt
2026-08-19 20:30:48.227604 | instance | >f+++++++++ system/lsblk.txt
2026-08-19 20:30:48.227633 | instance | >f+++++++++ system/mount.txt
2026-08-19 20:30:48.227663 | instance | >f+++++++++ system/packages.txt
2026-08-19 20:30:48.227691 | instance | >f+++++++++ system/ps.txt
2026-08-19 20:30:48.227722 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-19 20:30:48.237972 | 
2026-08-19 20:30:48.238043 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-19 20:30:48.443396 | instance | changed: "values"
2026-08-19 20:30:48.603117 | instance | changed: "releases"
2026-08-19 20:30:48.614156 | 
2026-08-19 20:30:48.614352 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-19 20:30:48.844070 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-19 20:30:49.154815 | instance | ok: Runtime: 0:00:00.017471
2026-08-19 20:30:49.161481 | 
2026-08-19 20:30:49.161574 | TASK [helm-release-status : Downloads logs to executor]
2026-08-19 20:30:49.670108 | instance | changed:
2026-08-19 20:30:49.670300 | instance | cd+++++++++ helm/
2026-08-19 20:30:49.670339 | instance | cd+++++++++ helm/releases/
2026-08-19 20:30:49.670369 | instance | cd+++++++++ helm/values/
2026-08-19 20:30:49.685741 | 
2026-08-19 20:30:49.685871 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-19 20:30:49.891849 | instance | changed
2026-08-19 20:30:49.900464 | 
2026-08-19 20:30:49.900572 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-19 20:30:50.168494 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:30:50.168946 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:30:50.173749 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:30:50.175138 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:30:50.176783 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:30:50.178701 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:30:50.179074 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:30:50.180917 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:30:50.181149 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:30:50.182430 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:30:50.184566 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:30:50.185759 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:30:50.437209 | instance | ok: Runtime: 0:00:00.027034
2026-08-19 20:30:50.442319 | 
2026-08-19 20:30:50.442389 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-19 20:30:50.637821 | instance | changed
2026-08-19 20:30:50.645089 | 
2026-08-19 20:30:50.645268 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-19 20:30:50.851270 | instance | environment: line 5: kubectl: command not found
2026-08-19 20:30:50.852666 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:30:50.852833 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:30:50.852962 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:30:51.184120 | instance | ok: Runtime: 0:00:00.010139
2026-08-19 20:30:51.191484 | 
2026-08-19 20:30:51.191569 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-19 20:30:51.894766 | instance | changed:
2026-08-19 20:30:51.894981 | instance | cd+++++++++ objects/
2026-08-19 20:30:51.895021 | instance | cd+++++++++ objects/cluster/
2026-08-19 20:30:51.895051 | instance | cd+++++++++ objects/namespaced/
2026-08-19 20:30:51.907172 | 
2026-08-19 20:30:51.907242 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-19 20:30:52.119570 | instance | changed
2026-08-19 20:30:52.130012 | 
2026-08-19 20:30:52.130098 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-19 20:30:52.330702 | instance | changed
2026-08-19 20:30:52.336172 | 
2026-08-19 20:30:52.336256 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-19 20:30:52.542364 | instance | environment: line 3: kubectl: command not found
2026-08-19 20:30:52.873862 | instance | ok: Runtime: 0:00:00.009004
2026-08-19 20:30:52.881063 | 
2026-08-19 20:30:52.881158 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-19 20:30:53.373162 | instance | changed:
2026-08-19 20:30:53.373379 | instance | cd+++++++++ pod-logs/
2026-08-19 20:30:53.373417 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-19 20:30:53.386718 | 
2026-08-19 20:30:53.386805 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-19 20:30:53.616257 | instance | changed
2026-08-19 20:30:53.623628 | 
2026-08-19 20:30:53.623702 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-19 20:30:53.834298 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:30:54.159798 | instance | ok: Runtime: 0:00:00.040025
2026-08-19 20:30:54.164881 | 
2026-08-19 20:30:54.164977 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-19 20:30:54.373570 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:30:54.405937 | instance | ceph-mgr endpoints:
2026-08-19 20:30:54.703217 | instance | ok: Runtime: 0:00:00.039093
2026-08-19 20:30:54.708985 | 
2026-08-19 20:30:54.709097 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-19 20:30:54.929201 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-19 20:30:55.246076 | instance | ok: Runtime: 0:00:00.036537
2026-08-19 20:30:55.253591 | 
2026-08-19 20:30:55.253654 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-19 20:30:55.764034 | instance | changed: cd+++++++++ prometheus/
2026-08-19 20:30:55.775729 | 
2026-08-19 20:30:55.775793 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-19 20:30:55.988457 | instance | changed
2026-08-19 20:30:55.994586 | 
2026-08-19 20:30:55.994652 | TASK [gather-selenium-data : Get selenium data]
2026-08-19 20:30:56.257198 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-19 20:30:56.258746 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-19 20:30:56.530918 | instance | ERROR
2026-08-19 20:30:56.531170 | instance | {
2026-08-19 20:30:56.531215 | instance |   "delta": "0:00:00.007926",
2026-08-19 20:30:56.531245 | instance |   "end": "2026-08-19 20:30:56.259186",
2026-08-19 20:30:56.531275 | instance |   "msg": "non-zero return code",
2026-08-19 20:30:56.531304 | instance |   "rc": 1,
2026-08-19 20:30:56.531329 | instance |   "start": "2026-08-19 20:30:56.251260"
2026-08-19 20:30:56.531353 | instance | }
2026-08-19 20:30:56.531387 | instance | ERROR: Ignoring Errors
2026-08-19 20:30:56.537961 | 
2026-08-19 20:30:56.538035 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-19 20:30:57.027041 | instance | changed: cd+++++++++ selenium/
2026-08-19 20:30:57.033377 | 
2026-08-19 20:30:57.033433 | PLAY RECAP
2026-08-19 20:30:57.033486 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-19 20:30:57.033508 | 
2026-08-19 20:30:57.184060 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:30:57.205245 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:30:57.829189 | 
2026-08-19 20:30:57.829351 | PLAY [all]
2026-08-19 20:30:57.842310 | 
2026-08-19 20:30:57.842465 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-19 20:30:57.888613 | instance | skipping: Conditional result was False
2026-08-19 20:30:57.899072 | 
2026-08-19 20:30:57.899183 | TASK [fetch-output : Set log path for single node]
2026-08-19 20:30:57.943115 | instance | ok
2026-08-19 20:30:57.949101 | 
2026-08-19 20:30:57.949174 | LOOP [fetch-output : Ensure local output dirs]
2026-08-19 20:30:58.456038 | instance -> localhost | ok: "/var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/logs"
2026-08-19 20:30:58.669142 | instance -> localhost | changed: "/var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/artifacts"
2026-08-19 20:30:58.871048 | instance -> localhost | changed: "/var/lib/zuul/builds/1007d630e9094e208bcb951fa7753daf/work/docs"
2026-08-19 20:30:58.888813 | 
2026-08-19 20:30:58.888952 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-19 20:30:59.586364 | instance | changed: .d..t...... ./
2026-08-19 20:30:59.586644 | instance | changed: All items complete
2026-08-19 20:30:59.586680 | 
2026-08-19 20:31:00.080887 | instance | changed: .d..t...... ./
2026-08-19 20:31:00.544481 | instance | changed: .d..t...... ./
2026-08-19 20:31:00.563198 | 
2026-08-19 20:31:00.563389 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-19 20:31:01.010702 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009530
2026-08-19 20:31:01.269513 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008142
2026-08-19 20:31:01.285636 | 
2026-08-19 20:31:01.285775 | PLAY [all]
2026-08-19 20:31:01.291918 | 
2026-08-19 20:31:01.291986 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-19 20:31:01.715412 | instance | changed
2026-08-19 20:31:01.722305 | 
2026-08-19 20:31:01.722623 | PLAY RECAP
2026-08-19 20:31:01.723377 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-19 20:31:01.723480 | 
2026-08-19 20:31:01.891714 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:31:01.895713 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-19 20:31:02.507506 | 
2026-08-19 20:31:02.507655 | PLAY [localhost]
2026-08-19 20:31:02.518796 | 
2026-08-19 20:31:02.520349 | TASK [Generate Zuul manifest]
2026-08-19 20:31:02.542705 | localhost | ok
2026-08-19 20:31:02.568295 | 
2026-08-19 20:31:02.569198 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-19 20:31:02.948213 | localhost | changed
2026-08-19 20:31:02.959894 | 
2026-08-19 20:31:02.959974 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-19 20:31:02.987283 | localhost | ok
2026-08-19 20:31:02.994389 | 
2026-08-19 20:31:02.994588 | TASK [Upload logs]
2026-08-19 20:31:03.019189 | localhost | ok
2026-08-19 20:31:03.079381 | 
2026-08-19 20:31:03.079577 | TASK [Set zuul-log-path fact]
2026-08-19 20:31:03.102477 | localhost | ok
2026-08-19 20:31:03.114711 | 
2026-08-19 20:31:03.133356 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:31:03.167524 | localhost | ok
2026-08-19 20:31:03.177347 | 
2026-08-19 20:31:03.177419 | TASK [upload-logs : Create log directories]
2026-08-19 20:31:03.598459 | localhost | changed
2026-08-19 20:31:03.604915 | 
2026-08-19 20:31:03.605073 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-19 20:31:04.087283 | localhost -> localhost | ok: Runtime: 0:00:00.006754
2026-08-19 20:31:04.092519 | 
2026-08-19 20:31:04.092590 | TASK [upload-logs : Upload logs to log server]
2026-08-19 20:31:04.597306 | localhost | Output suppressed because no_log was given
2026-08-19 20:31:04.643802 | 
2026-08-19 20:31:04.643950 | LOOP [upload-logs : Compress console log and json output]
2026-08-19 20:31:04.691036 | localhost | skipping: Conditional result was False
2026-08-19 20:31:04.698972 | localhost | skipping: Conditional result was False
2026-08-19 20:31:04.714488 | 
2026-08-19 20:31:04.714783 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-19 20:31:04.755882 | localhost | skipping: Conditional result was False
2026-08-19 20:31:04.756209 | 
2026-08-19 20:31:04.760277 | localhost | skipping: Conditional result was False
2026-08-19 20:31:04.769213 | 
2026-08-19 20:31:04.769429 | LOOP [upload-logs : Upload console log and json output]