2026-08-21 02:17:54.533193 | Job console starting
2026-08-21 02:17:54.545587 | Updating git repos
2026-08-21 02:18:08.719152 | Cloning repos into workspace
2026-08-21 02:18:35.076144 | Restoring repo states
2026-08-21 02:18:39.304121 | Merging changes
2026-08-21 02:18:40.685375 | Checking out repos
2026-08-21 02:18:49.890838 | Preparing playbooks
2026-08-21 02:18:53.424210 | Running Ansible setup
2026-08-21 02:18:58.345001 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-21 02:18:59.021309 | 
2026-08-21 02:18:59.021471 | PLAY [localhost]
2026-08-21 02:18:59.030473 | 
2026-08-21 02:18:59.030579 | TASK [Gathering Facts]
2026-08-21 02:19:00.618167 | localhost | ok
2026-08-21 02:19:00.629383 | 
2026-08-21 02:19:00.629539 | TASK [Setup log path fact]
2026-08-21 02:19:00.649250 | localhost | ok
2026-08-21 02:19:00.672519 | 
2026-08-21 02:19:00.672658 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-21 02:19:00.704721 | localhost | ok
2026-08-21 02:19:00.711751 | 
2026-08-21 02:19:00.711868 | TASK [emit-job-header : Print job information]
2026-08-21 02:19:00.760347 | # Job Information
2026-08-21 02:19:00.760520 | Ansible Version: 2.16.18
2026-08-21 02:19:00.760566 | Job: atmosphere-molecule-csi-rbd
2026-08-21 02:19:00.760598 | Pipeline: check
2026-08-21 02:19:00.760629 | Executor: 2d72f0692154
2026-08-21 02:19:00.760658 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4089
2026-08-21 02:19:00.760690 | Event ID: eb26c560-9d05-11f1-920d-b899a3fd39c9
2026-08-21 02:19:00.765244 | 
2026-08-21 02:19:00.765355 | LOOP [emit-job-header : Print node information]
2026-08-21 02:19:00.972169 | localhost | ok:
2026-08-21 02:19:00.992765 | localhost | # Node Information
2026-08-21 02:19:00.992895 | localhost | Inventory Hostname: instance
2026-08-21 02:19:00.992932 | localhost | Hostname: np0000190341
2026-08-21 02:19:00.992982 | localhost | Username: zuul
2026-08-21 02:19:00.993018 | localhost | Distro: Ubuntu 22.04
2026-08-21 02:19:00.993048 | localhost | Provider: yul1
2026-08-21 02:19:00.993076 | localhost | Region: ca-ymq-1
2026-08-21 02:19:00.993102 | localhost | Label: ubuntu-jammy
2026-08-21 02:19:00.993128 | localhost | Product Name: OpenStack Nova
2026-08-21 02:19:00.993154 | localhost | Interface IP: 199.19.213.48
2026-08-21 02:19:01.005320 | 
2026-08-21 02:19:01.005571 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-21 02:19:01.554081 | localhost -> localhost | changed
2026-08-21 02:19:01.559889 | 
2026-08-21 02:19:01.560034 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-21 02:19:02.788926 | localhost -> localhost | changed
2026-08-21 02:19:02.800513 | 
2026-08-21 02:19:02.800618 | PLAY [all]
2026-08-21 02:19:02.818864 | 
2026-08-21 02:19:02.819299 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-21 02:19:03.195003 | instance -> localhost | ok
2026-08-21 02:19:03.204581 | 
2026-08-21 02:19:03.204700 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-21 02:19:03.233560 | instance | ok
2026-08-21 02:19:03.249633 | instance | included: /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-21 02:19:03.255699 | 
2026-08-21 02:19:03.255766 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-21 02:19:04.567400 | instance -> localhost | Generating public/private rsa key pair.
2026-08-21 02:19:04.567572 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/a5f7923e94d64406af5472ac3878f94b_id_rsa
2026-08-21 02:19:04.567612 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/a5f7923e94d64406af5472ac3878f94b_id_rsa.pub
2026-08-21 02:19:04.567637 | instance -> localhost | The key fingerprint is:
2026-08-21 02:19:04.567659 | instance -> localhost | SHA256:aF2XggCgKrcCkZJssxNkR4pO99ikpnlszLTlAX5/odE zuul-build-sshkey
2026-08-21 02:19:04.567692 | instance -> localhost | The key's randomart image is:
2026-08-21 02:19:04.567714 | instance -> localhost | +---[RSA 3072]----+
2026-08-21 02:19:04.567742 | instance -> localhost | | oo+...          |
2026-08-21 02:19:04.567765 | instance -> localhost | |=+o    . .   .   |
2026-08-21 02:19:04.567786 | instance -> localhost | |BB o .  . o o    |
2026-08-21 02:19:04.567806 | instance -> localhost | |*.* B  o.. o     |
2026-08-21 02:19:04.567827 | instance -> localhost | |++.* *o.SE       |
2026-08-21 02:19:04.567846 | instance -> localhost | |o.X.=.o o .      |
2026-08-21 02:19:04.567866 | instance -> localhost | |.o.B . o .       |
2026-08-21 02:19:04.567887 | instance -> localhost | | .o     .        |
2026-08-21 02:19:04.567909 | instance -> localhost | |                 |
2026-08-21 02:19:04.567930 | instance -> localhost | +----[SHA256]-----+
2026-08-21 02:19:04.567975 | instance -> localhost | ok: Runtime: 0:00:00.812895
2026-08-21 02:19:04.574250 | 
2026-08-21 02:19:04.574356 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-21 02:19:04.609224 | instance | ok
2026-08-21 02:19:04.622219 | instance | included: /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-21 02:19:04.632640 | 
2026-08-21 02:19:04.632739 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-21 02:19:04.656915 | instance | skipping: Conditional result was False
2026-08-21 02:19:04.668764 | 
2026-08-21 02:19:04.668949 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-21 02:19:05.110010 | instance | changed
2026-08-21 02:19:05.118974 | 
2026-08-21 02:19:05.119113 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-21 02:19:05.294163 | instance | ok
2026-08-21 02:19:05.303395 | 
2026-08-21 02:19:05.303473 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-21 02:19:05.762033 | instance | changed
2026-08-21 02:19:05.769320 | 
2026-08-21 02:19:05.769389 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-21 02:19:06.237599 | instance | changed
2026-08-21 02:19:06.244242 | 
2026-08-21 02:19:06.244309 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-21 02:19:06.268355 | instance | skipping: Conditional result was False
2026-08-21 02:19:06.276222 | 
2026-08-21 02:19:06.276314 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-21 02:19:07.002148 | instance -> localhost | changed
2026-08-21 02:19:07.018540 | 
2026-08-21 02:19:07.018697 | TASK [add-build-sshkey : Add back temp key]
2026-08-21 02:19:07.333891 | instance -> localhost | Identity added: /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/a5f7923e94d64406af5472ac3878f94b_id_rsa (zuul-build-sshkey)
2026-08-21 02:19:07.334130 | instance -> localhost | ok: Runtime: 0:00:00.014655
2026-08-21 02:19:07.341607 | 
2026-08-21 02:19:07.341700 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-21 02:19:07.652484 | instance | ok
2026-08-21 02:19:07.658738 | 
2026-08-21 02:19:07.658832 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-21 02:19:07.686137 | instance | skipping: Conditional result was False
2026-08-21 02:19:07.701453 | 
2026-08-21 02:19:07.701555 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-21 02:19:08.006022 | instance | ok
2026-08-21 02:19:08.013705 | 
2026-08-21 02:19:08.013770 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-21 02:19:14.900922 | instance | Output suppressed because no_log was given
2026-08-21 02:19:14.909908 | 
2026-08-21 02:19:14.910002 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-21 02:19:15.121043 | instance | ok: "logs"
2026-08-21 02:19:15.121951 | instance | ok: All items complete
2026-08-21 02:19:15.122033 | 
2026-08-21 02:19:15.278303 | instance | ok: "artifacts"
2026-08-21 02:19:15.464853 | instance | ok: "docs"
2026-08-21 02:19:15.476041 | 
2026-08-21 02:19:15.476279 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-21 02:19:15.667670 | instance | changed: "logs"
2026-08-21 02:19:15.825765 | instance | changed: "artifacts"
2026-08-21 02:19:15.989895 | instance | changed: "docs"
2026-08-21 02:19:16.000191 | 
2026-08-21 02:19:16.136796 | PLAY RECAP
2026-08-21 02:19:16.137096 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-21 02:19:16.137237 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-21 02:19:16.137324 | 
2026-08-21 02:19:16.308705 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-21 02:19:16.313073 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-21 02:19:17.059827 | 
2026-08-21 02:19:17.060092 | PLAY [all]
2026-08-21 02:19:17.076000 | 
2026-08-21 02:19:17.076268 | TASK [setup-uv : Extract archive]
2026-08-21 02:19:19.476305 | instance | changed
2026-08-21 02:19:19.483150 | 
2026-08-21 02:19:19.483264 | TASK [setup-uv : Print version]
2026-08-21 02:19:19.931965 | instance | uv 0.8.13
2026-08-21 02:19:20.031789 | instance | ok: Runtime: 0:00:00.018477
2026-08-21 02:19:20.049134 | 
2026-08-21 02:19:20.049256 | TASK [Install Ansible collection siblings]
2026-08-21 02:19:29.108676 | instance | changed:
2026-08-21 02:19:30.085765 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-21 02:19:30.085952 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-21 02:19:30.086016 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-21 02:19:30.086071 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-21 02:19:30.086192 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-21 02:19:30.086271 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-21 02:19:30.086329 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-21 02:19:30.086387 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-21 02:19:30.086436 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-21 02:19:30.086486 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-21 02:19:30.086535 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-21 02:19:30.086582 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-21 02:19:30.086628 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0
2026-08-21 02:19:30.086675 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-21 02:19:30.086722 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0
2026-08-21 02:19:30.086772 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-21 02:19:30.086820 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-21 02:19:30.086868 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-21 02:19:30.086912 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-21 02:19:30.086958 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0
2026-08-21 02:19:30.087004 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0
2026-08-21 02:19:30.087111 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-21 02:19:30.087204 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-21 02:19:30.087290 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-21 02:19:30.087343 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-21 02:19:30.087390 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-21 02:19:30.087437 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-21 02:19:30.087483 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-08-21 02:19:30.087527 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-21 02:19:30.087572 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-21 02:19:30.087618 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-21 02:19:30.087665 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-21 02:19:30.087712 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-21 02:19:30.087757 | instance | Checked out ansible.netcommon to v8.6.2
2026-08-21 02:19:30.087805 | 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-21 02:19:30.087869 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.087917 | instance | Process install dependency map
2026-08-21 02:19:30.087964 | instance | Starting collection install process
2026-08-21 02:19:30.088010 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-21 02:19:30.088055 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-21 02:19:30.088099 | instance | ansible.netcommon:8.6.2 was installed successfully
2026-08-21 02:19:30.088146 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-21 02:19:30.088277 | instance | Creating virtual environment at: .venv
2026-08-21 02:19:30.088329 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-21 02:19:30.088373 | instance | Downloading pygments (1.2MiB)
2026-08-21 02:19:30.088427 | instance | Downloading kubernetes (1.9MiB)
2026-08-21 02:19:30.088473 | instance | Downloading netaddr (2.2MiB)
2026-08-21 02:19:30.088519 | instance | Downloading setuptools (1.1MiB)
2026-08-21 02:19:30.088565 | instance | Downloading openstacksdk (1.7MiB)
2026-08-21 02:19:30.088613 | instance | Downloading cryptography (4.2MiB)
2026-08-21 02:19:30.088662 | instance | Downloading ansible-core (2.1MiB)
2026-08-21 02:19:30.088716 | instance | Downloading rjsonnet (1.2MiB)
2026-08-21 02:19:30.088769 | instance |    Building pyperclip==1.9.0
2026-08-21 02:19:30.088805 | instance |  Downloading rjsonnet
2026-08-21 02:19:30.088840 | instance |  Downloading pygments
2026-08-21 02:19:30.088872 | instance |  Downloading netaddr
2026-08-21 02:19:30.088899 | instance |  Downloading cryptography
2026-08-21 02:19:30.088927 | instance |  Downloading setuptools
2026-08-21 02:19:30.088954 | instance |  Downloading kubernetes
2026-08-21 02:19:30.089017 | instance |  Downloading ansible-core
2026-08-21 02:19:30.089047 | instance |  Downloading openstacksdk
2026-08-21 02:19:30.089076 | instance |       Built pyperclip==1.9.0
2026-08-21 02:19:30.089104 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-21 02:19:30.089133 | instance | Installed 79 packages in 35ms
2026-08-21 02:19:30.089161 | instance | Checked out ansible.posix to 1.6.0
2026-08-21 02:19:30.089188 | 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-21 02:19:30.089222 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.089290 | instance | Process install dependency map
2026-08-21 02:19:30.089338 | instance | Starting collection install process
2026-08-21 02:19:30.089369 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-21 02:19:30.089398 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-21 02:19:30.089425 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-21 02:19:30.089452 | instance | Checked out ansible.utils to v6.1.0
2026-08-21 02:19:30.089479 | 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-21 02:19:30.089506 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.089532 | instance | Process install dependency map
2026-08-21 02:19:30.089592 | instance | Starting collection install process
2026-08-21 02:19:30.089640 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-21 02:19:30.089671 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-21 02:19:30.089700 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-21 02:19:30.089728 | instance | Checked out atmosphere.common to v0.6.0
2026-08-21 02:19:30.089756 | 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-21 02:19:30.089783 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.089811 | instance | Process install dependency map
2026-08-21 02:19:30.089838 | instance | Starting collection install process
2026-08-21 02:19:30.089864 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-21 02:19:30.089889 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-21 02:19:30.089915 | instance | atmosphere.common:0.6.0 was installed successfully
2026-08-21 02:19:30.089941 | instance | Checked out community.crypto to 2.2.3
2026-08-21 02:19:30.089967 | 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-21 02:19:30.089994 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.090020 | instance | Process install dependency map
2026-08-21 02:19:30.090047 | instance | Starting collection install process
2026-08-21 02:19:30.090074 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-21 02:19:30.090100 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-21 02:19:30.090128 | instance | community.crypto:2.2.3 was installed successfully
2026-08-21 02:19:30.090155 | instance | Checked out community.general to 7.3.0
2026-08-21 02:19:30.090182 | 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-21 02:19:30.090209 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.090237 | instance | Process install dependency map
2026-08-21 02:19:30.090263 | instance | Starting collection install process
2026-08-21 02:19:30.090291 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-21 02:19:30.090317 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-21 02:19:30.090344 | instance | community.general:7.3.0 was installed successfully
2026-08-21 02:19:30.090410 | instance | Checked out community.mysql to 3.6.0
2026-08-21 02:19:30.090459 | 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-21 02:19:30.090491 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.090519 | instance | Process install dependency map
2026-08-21 02:19:30.090548 | instance | Starting collection install process
2026-08-21 02:19:30.090578 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-21 02:19:30.090605 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-21 02:19:30.090633 | instance | community.mysql:3.6.0 was installed successfully
2026-08-21 02:19:30.090660 | instance | Checked out kubernetes.core to 2.4.0
2026-08-21 02:19:30.090686 | 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-21 02:19:30.090714 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.090740 | instance | Process install dependency map
2026-08-21 02:19:30.090770 | instance | Starting collection install process
2026-08-21 02:19:30.090798 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-21 02:19:30.090825 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-21 02:19:30.090852 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-21 02:19:30.090877 | instance | Checked out openstack.cloud to 1.7.0
2026-08-21 02:19:30.090904 | 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-21 02:19:30.090931 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.090958 | instance | Process install dependency map
2026-08-21 02:19:30.090984 | instance | Starting collection install process
2026-08-21 02:19:30.091011 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-21 02:19:30.091048 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-21 02:19:30.091082 | instance | openstack.cloud:1.7.0 was installed successfully
2026-08-21 02:19:30.091109 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-21 02:19:30.091136 | 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-21 02:19:30.091163 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.091190 | instance | Process install dependency map
2026-08-21 02:19:30.091216 | instance | Starting collection install process
2026-08-21 02:19:30.091242 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-21 02:19:30.091267 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-21 02:19:30.091293 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-21 02:19:30.091319 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-21 02:19:30.091345 | 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-21 02:19:30.091372 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.091406 | instance | Process install dependency map
2026-08-21 02:19:30.091433 | instance | Starting collection install process
2026-08-21 02:19:30.091458 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-21 02:19:30.091483 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-21 02:19:30.091508 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-21 02:19:30.091534 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-21 02:19:30.091560 | 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-21 02:19:30.091587 | instance | Starting galaxy collection install process
2026-08-21 02:19:30.091613 | instance | Process install dependency map
2026-08-21 02:19:30.091640 | instance | Starting collection install process
2026-08-21 02:19:30.091667 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-21 02:19:30.091696 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-21 02:19:30.091726 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-21 02:19:30.101875 | 
2026-08-21 02:19:30.101989 | PLAY RECAP
2026-08-21 02:19:30.102040 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-21 02:19:30.102063 | 
2026-08-21 02:19:30.212877 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-21 02:19:31.454448 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-21 02:19:32.103618 | 
2026-08-21 02:19:32.103753 | PLAY [all]
2026-08-21 02:19:32.115322 | 
2026-08-21 02:19:32.115401 | TASK [Install "jq" for log collection]
2026-08-21 02:19:41.350428 | instance | changed
2026-08-21 02:19:41.353706 | 
2026-08-21 02:19:41.353781 | PLAY RECAP
2026-08-21 02:19:41.353840 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-21 02:19:41.353894 | 
2026-08-21 02:19:41.608954 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-21 02:19:41.612530 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-21 02:19:42.388252 | 
2026-08-21 02:19:42.388481 | PLAY [all]
2026-08-21 02:19:42.402962 | 
2026-08-21 02:19:42.403122 | LOOP [Check inventory directories]
2026-08-21 02:19:42.838321 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-21 02:19:43.105986 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-21 02:19:43.135376 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-21 02:19:43.155241 | 
2026-08-21 02:19:43.155427 | LOOP [Copy inventory file for Zuul]
2026-08-21 02:19:43.917138 | instance | changed:
2026-08-21 02:19:43.917400 | instance | {
2026-08-21 02:19:43.917442 | instance |   "ansible_loop_var": "item",
2026-08-21 02:19:43.917475 | instance |   "changed": false,
2026-08-21 02:19:43.917506 | instance |   "failed": false,
2026-08-21 02:19:43.917569 | instance |   "invocation": {
2026-08-21 02:19:43.917617 | instance |     "module_args": {
2026-08-21 02:19:43.917649 | instance |       "checksum_algorithm": "sha1",
2026-08-21 02:19:43.917676 | instance |       "follow": true,
2026-08-21 02:19:43.917704 | instance |       "get_attributes": true,
2026-08-21 02:19:43.917734 | instance |       "get_checksum": true,
2026-08-21 02:19:43.917761 | instance |       "get_mime": true,
2026-08-21 02:19:43.917787 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-21 02:19:43.917813 | instance |     }
2026-08-21 02:19:43.917855 | instance |   },
2026-08-21 02:19:43.917883 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-21 02:19:43.917909 | instance |   "stat": {
2026-08-21 02:19:43.917935 | instance |     "atime": 1787278761.9468353,
2026-08-21 02:19:43.917961 | instance |     "attr_flags": "e",
2026-08-21 02:19:43.917987 | instance |     "attributes": [
2026-08-21 02:19:43.918012 | instance |       "extents"
2026-08-21 02:19:43.918038 | instance |     ],
2026-08-21 02:19:43.918063 | instance |     "block_size": 4096,
2026-08-21 02:19:43.918088 | instance |     "blocks": 8,
2026-08-21 02:19:43.918117 | instance |     "charset": "unknown",
2026-08-21 02:19:43.918145 | instance |     "ctime": 1787278760.8828075,
2026-08-21 02:19:43.918172 | instance |     "dev": 64513,
2026-08-21 02:19:43.918198 | instance |     "device_type": 0,
2026-08-21 02:19:43.918223 | instance |     "executable": true,
2026-08-21 02:19:43.918248 | instance |     "exists": true,
2026-08-21 02:19:43.918274 | instance |     "gid": 1000,
2026-08-21 02:19:43.918299 | instance |     "gr_name": "zuul",
2026-08-21 02:19:43.918325 | instance |     "inode": 1048894,
2026-08-21 02:19:43.918350 | instance |     "isblk": false,
2026-08-21 02:19:43.918376 | instance |     "ischr": false,
2026-08-21 02:19:43.918401 | instance |     "isdir": true,
2026-08-21 02:19:43.918426 | instance |     "isfifo": false,
2026-08-21 02:19:43.918451 | instance |     "isgid": false,
2026-08-21 02:19:43.918476 | instance |     "islnk": false,
2026-08-21 02:19:43.918501 | instance |     "isreg": false,
2026-08-21 02:19:43.918525 | instance |     "issock": false,
2026-08-21 02:19:43.918550 | instance |     "isuid": false,
2026-08-21 02:19:43.918575 | instance |     "mimetype": "unknown",
2026-08-21 02:19:43.918601 | instance |     "mode": "0755",
2026-08-21 02:19:43.918627 | instance |     "mtime": 1787278760.8828075,
2026-08-21 02:19:43.918652 | instance |     "nlink": 22,
2026-08-21 02:19:43.918678 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-21 02:19:43.918704 | instance |     "pw_name": "zuul",
2026-08-21 02:19:43.918734 | instance |     "readable": true,
2026-08-21 02:19:43.918760 | instance |     "rgrp": true,
2026-08-21 02:19:43.918786 | instance |     "roth": true,
2026-08-21 02:19:43.918812 | instance |     "rusr": true,
2026-08-21 02:19:43.918838 | instance |     "size": 4096,
2026-08-21 02:19:43.918864 | instance |     "uid": 1000,
2026-08-21 02:19:43.918923 | instance |     "version": "3506331450",
2026-08-21 02:19:43.918961 | instance |     "wgrp": false,
2026-08-21 02:19:43.918994 | instance |     "woth": false,
2026-08-21 02:19:43.919021 | instance |     "writeable": true,
2026-08-21 02:19:43.919047 | instance |     "wusr": true,
2026-08-21 02:19:43.919072 | instance |     "xgrp": true,
2026-08-21 02:19:43.919098 | instance |     "xoth": true,
2026-08-21 02:19:43.919128 | instance |     "xusr": true
2026-08-21 02:19:43.919153 | instance |   }
2026-08-21 02:19:43.919180 | instance | }
2026-08-21 02:19:43.919233 | instance | ok: All items complete
2026-08-21 02:19:43.919263 | 
2026-08-21 02:19:43.921097 | instance | skipping: Conditional result was False
2026-08-21 02:19:43.921922 | instance | skipping: Conditional result was False
2026-08-21 02:19:43.937675 | 
2026-08-21 02:19:43.937789 | LOOP [Switch "ansible_host" to private IP]
2026-08-21 02:19:44.347920 | instance | changed: 1 replacements made
2026-08-21 02:19:44.350356 | instance | skipping: Conditional result was False
2026-08-21 02:19:44.356216 | instance | skipping: Conditional result was False
2026-08-21 02:19:44.374488 | 
2026-08-21 02:19:44.374654 | TASK [Run Molecule scenario]
2026-08-21 02:19:45.372642 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-21 02:19:45.782104 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-21 02:19:45.782198 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-21 02:19:56.969757 | instance | INFO     [csi > dependency] Executing
2026-08-21 02:19:56.970034 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-21 02:19:56.970280 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-21 02:19:56.970415 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-21 02:19:56.978685 | instance | INFO     [csi > cleanup] Executing
2026-08-21 02:19:56.979129 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-21 02:19:56.987128 | instance | INFO     [csi > destroy] Executing
2026-08-21 02:19:56.987182 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-21 02:19:56.987256 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-21 02:19:56.994765 | instance | INFO     [csi > syntax] Executing
2026-08-21 02:19:58.650278 | instance |
2026-08-21 02:19:58.650598 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-21 02:19:58.717035 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-21 02:19:58.731575 | instance | INFO     [csi > create] Executing
2026-08-21 02:19:58.734290 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-21 02:19:58.742590 | instance | INFO     [csi > prepare] Executing
2026-08-21 02:19:59.653106 | instance |
2026-08-21 02:19:59.653483 | instance | PLAY [Prepare] *****************************************************************
2026-08-21 02:19:59.653773 | instance |
2026-08-21 02:19:59.654131 | instance | TASK [Gathering Facts] *********************************************************
2026-08-21 02:19:59.654579 | instance | Friday 21 August 2026  02:19:59 +0000 (0:00:00.038)       0:00:00.038 *********
2026-08-21 02:20:00.888284 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-21 02:20:00.888554 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-21 02:20:00.888836 | instance | interpreter could change the meaning of that path. See
2026-08-21 02:20:00.889205 | instance | https://docs.ansible.com/ansible-
2026-08-21 02:20:00.889630 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-21 02:20:00.897336 | instance | ok: [instance]
2026-08-21 02:20:00.897534 | instance |
2026-08-21 02:20:00.897744 | instance | TASK [Configure short hostname] ************************************************
2026-08-21 02:20:00.897942 | instance | Friday 21 August 2026  02:20:00 +0000 (0:00:01.244)       0:00:01.283 *********
2026-08-21 02:20:01.574434 | instance | changed: [instance]
2026-08-21 02:20:01.574602 | instance |
2026-08-21 02:20:01.574781 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-21 02:20:01.574994 | instance | Friday 21 August 2026  02:20:01 +0000 (0:00:00.676)       0:00:01.960 *********
2026-08-21 02:20:01.836453 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-21 02:20:01.836833 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-21 02:20:01.837183 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-21 02:20:01.843320 | instance | changed: [instance]
2026-08-21 02:20:01.843452 | instance |
2026-08-21 02:20:01.843682 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-21 02:20:01.843846 | instance | Friday 21 August 2026  02:20:01 +0000 (0:00:00.269)       0:00:02.229 *********
2026-08-21 02:20:02.656699 | instance | ok: [instance]
2026-08-21 02:20:02.656945 | instance |
2026-08-21 02:20:02.657232 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-21 02:20:02.657520 | instance |
2026-08-21 02:20:02.657791 | instance | TASK [Gathering Facts] *********************************************************
2026-08-21 02:20:02.658066 | instance | Friday 21 August 2026  02:20:02 +0000 (0:00:00.813)       0:00:03.043 *********
2026-08-21 02:20:03.332782 | instance | ok: [instance]
2026-08-21 02:20:03.333107 | instance |
2026-08-21 02:20:03.333530 | instance | TASK [Install depedencies] *****************************************************
2026-08-21 02:20:03.333937 | instance | Friday 21 August 2026  02:20:03 +0000 (0:00:00.675)       0:00:03.718 *********
2026-08-21 02:20:23.536576 | instance | changed: [instance]
2026-08-21 02:20:23.536706 | instance |
2026-08-21 02:20:23.537062 | instance | TASK [Start up service] ********************************************************
2026-08-21 02:20:23.537229 | instance | Friday 21 August 2026  02:20:23 +0000 (0:00:20.204)       0:00:23.922 *********
2026-08-21 02:20:24.111077 | instance | ok: [instance]
2026-08-21 02:20:24.111331 | instance |
2026-08-21 02:20:24.111616 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-21 02:20:24.111898 | instance | Friday 21 August 2026  02:20:24 +0000 (0:00:00.574)       0:00:24.497 *********
2026-08-21 02:20:24.422411 | instance | ok: [instance]
2026-08-21 02:20:24.422690 | instance |
2026-08-21 02:20:24.422968 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-21 02:20:24.423245 | instance | Friday 21 August 2026  02:20:24 +0000 (0:00:00.311)       0:00:24.808 *********
2026-08-21 02:20:25.107436 | instance | changed: [instance]
2026-08-21 02:20:25.107480 | instance |
2026-08-21 02:20:25.107487 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-21 02:20:25.107496 | instance | Friday 21 August 2026  02:20:25 +0000 (0:00:00.683)       0:00:25.492 *********
2026-08-21 02:20:25.297805 | instance | ok: [instance]
2026-08-21 02:20:25.297842 | instance |
2026-08-21 02:20:25.297848 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-21 02:20:25.297853 | instance | Friday 21 August 2026  02:20:25 +0000 (0:00:00.191)       0:00:25.683 *********
2026-08-21 02:20:25.324690 | instance | skipping: [instance]
2026-08-21 02:20:25.324728 | instance |
2026-08-21 02:20:25.324735 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-21 02:20:25.324742 | instance | Friday 21 August 2026  02:20:25 +0000 (0:00:00.026)       0:00:25.710 *********
2026-08-21 02:20:25.859518 | instance | changed: [instance] => (item=osd0)
2026-08-21 02:20:25.859604 | instance | changed: [instance] => (item=osd1)
2026-08-21 02:20:25.860126 | instance | changed: [instance] => (item=osd2)
2026-08-21 02:20:25.860270 | instance |
2026-08-21 02:20:25.860277 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-21 02:20:25.860283 | instance | Friday 21 August 2026  02:20:25 +0000 (0:00:00.535)       0:00:26.245 *********
2026-08-21 02:20:26.476321 | instance | changed: [instance] => (item=osd0)
2026-08-21 02:20:26.476424 | instance | changed: [instance] => (item=osd1)
2026-08-21 02:20:26.477031 | instance | changed: [instance] => (item=osd2)
2026-08-21 02:20:26.477073 | instance |
2026-08-21 02:20:26.477079 | instance | TASK [Start loop devices] ******************************************************
2026-08-21 02:20:26.477085 | instance | Friday 21 August 2026  02:20:26 +0000 (0:00:00.616)       0:00:26.862 *********
2026-08-21 02:20:27.208154 | instance | changed: [instance] => (item=osd0)
2026-08-21 02:20:27.208285 | instance | changed: [instance] => (item=osd1)
2026-08-21 02:20:27.208460 | instance | changed: [instance] => (item=osd2)
2026-08-21 02:20:27.208671 | instance |
2026-08-21 02:20:27.208857 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-21 02:20:27.208994 | instance | Friday 21 August 2026  02:20:27 +0000 (0:00:00.731)       0:00:27.594 *********
2026-08-21 02:20:30.745328 | instance | changed: [instance] => (item=osd0)
2026-08-21 02:20:30.746195 | instance | changed: [instance] => (item=osd1)
2026-08-21 02:20:30.746242 | instance | changed: [instance] => (item=osd2)
2026-08-21 02:20:30.746250 | instance |
2026-08-21 02:20:30.746257 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-21 02:20:30.746264 | instance | Friday 21 August 2026  02:20:30 +0000 (0:00:03.537)       0:00:31.131 *********
2026-08-21 02:20:32.635070 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-21 02:20:32.635354 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-21 02:20:32.637302 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-21 02:20:32.637316 | instance |
2026-08-21 02:20:32.637325 | instance | PLAY RECAP *********************************************************************
2026-08-21 02:20:32.637332 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-21 02:20:32.637338 | instance |
2026-08-21 02:20:32.637344 | instance | Friday 21 August 2026  02:20:32 +0000 (0:00:01.890)       0:00:33.021 *********
2026-08-21 02:20:32.637352 | instance | ===============================================================================
2026-08-21 02:20:32.637360 | instance | Install depedencies ---------------------------------------------------- 20.20s
2026-08-21 02:20:32.637367 | instance | Create a volume group for each loop device ------------------------------ 3.54s
2026-08-21 02:20:32.637375 | instance | Create a logical volume for each loop device ---------------------------- 1.89s
2026-08-21 02:20:32.637383 | instance | Gathering Facts --------------------------------------------------------- 1.24s
2026-08-21 02:20:32.639607 | instance | Purge "snapd" package --------------------------------------------------- 0.81s
2026-08-21 02:20:32.639663 | instance | Start loop devices ------------------------------------------------------ 0.73s
2026-08-21 02:20:32.639671 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.68s
2026-08-21 02:20:32.639691 | instance | Configure short hostname ------------------------------------------------ 0.68s
2026-08-21 02:20:32.639697 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-08-21 02:20:32.639703 | instance | Set permissions on loopback devices ------------------------------------- 0.62s
2026-08-21 02:20:32.639709 | instance | Start up service -------------------------------------------------------- 0.57s
2026-08-21 02:20:32.639715 | instance | Create devices for Ceph ------------------------------------------------- 0.54s
2026-08-21 02:20:32.639721 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-08-21 02:20:32.639727 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s
2026-08-21 02:20:32.639733 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-21 02:20:32.639738 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-21 02:20:32.723407 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-21 02:20:32.731433 | instance | INFO     [csi > converge] Executing
2026-08-21 02:20:34.320119 | instance |
2026-08-21 02:20:34.320473 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-21 02:20:34.320776 | instance |
2026-08-21 02:20:34.321173 | instance | TASK [Gathering Facts] *********************************************************
2026-08-21 02:20:34.321542 | instance | Friday 21 August 2026  02:20:34 +0000 (0:00:00.008)       0:00:00.008 *********
2026-08-21 02:20:35.302471 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-21 02:20:35.302855 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-21 02:20:35.303232 | instance | interpreter could change the meaning of that path. See
2026-08-21 02:20:35.303525 | instance | https://docs.ansible.com/ansible-
2026-08-21 02:20:35.303882 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-21 02:20:35.314418 | instance | ok: [instance]
2026-08-21 02:20:35.314706 | instance |
2026-08-21 02:20:35.314993 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-21 02:20:35.315279 | instance | Friday 21 August 2026  02:20:35 +0000 (0:00:00.994)       0:00:01.002 *********
2026-08-21 02:20:35.363934 | instance | ok: [instance] => {
2026-08-21 02:20:35.364122 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-21 02:20:35.364527 | instance | }
2026-08-21 02:20:35.364765 | instance |
2026-08-21 02:20:35.365014 | instance | PLAY [all] *********************************************************************
2026-08-21 02:20:35.365297 | instance |
2026-08-21 02:20:35.365475 | instance | TASK [Gathering Facts] *********************************************************
2026-08-21 02:20:35.365648 | instance | Friday 21 August 2026  02:20:35 +0000 (0:00:00.049)       0:00:01.052 *********
2026-08-21 02:20:36.271960 | instance | ok: [instance]
2026-08-21 02:20:36.272256 | instance |
2026-08-21 02:20:36.272590 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-21 02:20:36.272915 | instance | Friday 21 August 2026  02:20:36 +0000 (0:00:00.907)       0:00:01.959 *********
2026-08-21 02:20:36.460423 | instance | ok: [instance]
2026-08-21 02:20:36.460989 | instance |
2026-08-21 02:20:36.461548 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-21 02:20:36.461988 | instance |
2026-08-21 02:20:36.462447 | instance | TASK [Gathering Facts] *********************************************************
2026-08-21 02:20:36.462897 | instance | Friday 21 August 2026  02:20:36 +0000 (0:00:00.188)       0:00:02.148 *********
2026-08-21 02:20:37.357957 | instance | ok: [instance]
2026-08-21 02:20:37.358039 | instance |
2026-08-21 02:20:37.358271 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-21 02:20:37.358559 | instance | Friday 21 August 2026  02:20:37 +0000 (0:00:00.894)       0:00:03.042 *********
2026-08-21 02:20:37.645412 | instance | ok: [instance]
2026-08-21 02:20:37.645674 | instance |
2026-08-21 02:20:37.645868 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-21 02:20:37.646067 | instance | Friday 21 August 2026  02:20:37 +0000 (0:00:00.287)       0:00:03.330 *********
2026-08-21 02:20:37.690480 | instance | skipping: [instance]
2026-08-21 02:20:37.690917 | instance |
2026-08-21 02:20:37.691289 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-21 02:20:37.691630 | instance | Friday 21 August 2026  02:20:37 +0000 (0:00:00.047)       0:00:03.378 *********
2026-08-21 02:20:38.054900 | instance | changed: [instance]
2026-08-21 02:20:38.055269 | instance |
2026-08-21 02:20:38.055607 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-21 02:20:38.055982 | instance | Friday 21 August 2026  02:20:38 +0000 (0:00:00.364)       0:00:03.742 *********
2026-08-21 02:20:38.126921 | instance | ok: [instance] => {
2026-08-21 02:20:38.127381 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-21 02:20:38.127728 | instance | }
2026-08-21 02:20:38.128153 | instance |
2026-08-21 02:20:38.128558 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-21 02:20:38.128946 | instance | Friday 21 August 2026  02:20:38 +0000 (0:00:00.072)       0:00:03.815 *********
2026-08-21 02:20:38.889498 | instance | changed: [instance]
2026-08-21 02:20:38.890055 | instance |
2026-08-21 02:20:38.890522 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-21 02:20:38.891083 | instance | Friday 21 August 2026  02:20:38 +0000 (0:00:00.762)       0:00:04.577 *********
2026-08-21 02:20:38.952949 | instance | skipping: [instance]
2026-08-21 02:20:38.953556 | instance |
2026-08-21 02:20:38.954126 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-21 02:20:38.954760 | instance | Friday 21 August 2026  02:20:38 +0000 (0:00:00.062)       0:00:04.640 *********
2026-08-21 02:20:39.013387 | instance | skipping: [instance]
2026-08-21 02:20:39.013792 | instance |
2026-08-21 02:20:39.014231 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-21 02:20:39.014588 | instance | Friday 21 August 2026  02:20:39 +0000 (0:00:00.060)       0:00:04.700 *********
2026-08-21 02:20:39.233937 | instance | ok: [instance]
2026-08-21 02:20:39.234367 | instance |
2026-08-21 02:20:39.234778 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-21 02:20:39.235155 | instance | Friday 21 August 2026  02:20:39 +0000 (0:00:00.220)       0:00:04.921 *********
2026-08-21 02:20:40.590701 | instance | ok: [instance]
2026-08-21 02:20:40.590743 | instance |
2026-08-21 02:20:40.590749 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-21 02:20:40.590754 | instance | Friday 21 August 2026  02:20:40 +0000 (0:00:01.356)       0:00:06.278 *********
2026-08-21 02:20:40.670499 | instance | ok: [instance] => {
2026-08-21 02:20:40.670541 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-21 02:20:40.670556 | instance | }
2026-08-21 02:20:40.670561 | instance |
2026-08-21 02:20:40.670566 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-21 02:20:40.670570 | instance | Friday 21 August 2026  02:20:40 +0000 (0:00:00.079)       0:00:06.357 *********
2026-08-21 02:20:41.503032 | instance | changed: [instance]
2026-08-21 02:20:41.503109 | instance |
2026-08-21 02:20:41.503401 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-21 02:20:41.503443 | instance | Friday 21 August 2026  02:20:41 +0000 (0:00:00.832)       0:00:07.190 *********
2026-08-21 02:20:44.380428 | instance | changed: [instance]
2026-08-21 02:20:44.380559 | instance |
2026-08-21 02:20:44.380566 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-21 02:20:44.380572 | instance | Friday 21 August 2026  02:20:44 +0000 (0:00:02.877)       0:00:10.068 *********
2026-08-21 02:20:44.416452 | instance | skipping: [instance]
2026-08-21 02:20:44.416490 | instance |
2026-08-21 02:20:44.416498 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-21 02:20:44.416505 | instance | Friday 21 August 2026  02:20:44 +0000 (0:00:00.035)       0:00:10.104 *********
2026-08-21 02:20:44.447780 | instance | skipping: [instance]
2026-08-21 02:20:44.448415 | instance |
2026-08-21 02:20:44.448461 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-21 02:20:44.448467 | instance | Friday 21 August 2026  02:20:44 +0000 (0:00:00.031)       0:00:10.135 *********
2026-08-21 02:20:44.483328 | instance | skipping: [instance]
2026-08-21 02:20:44.483459 | instance |
2026-08-21 02:20:44.483828 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-21 02:20:44.483855 | instance | Friday 21 August 2026  02:20:44 +0000 (0:00:00.035)       0:00:10.171 *********
2026-08-21 02:20:50.092422 | instance | changed: [instance]
2026-08-21 02:20:50.092503 | instance |
2026-08-21 02:20:50.092852 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-21 02:20:50.092898 | instance | Friday 21 August 2026  02:20:50 +0000 (0:00:05.609)       0:00:15.780 *********
2026-08-21 02:20:50.719253 | instance | changed: [instance]
2026-08-21 02:20:50.719330 | instance |
2026-08-21 02:20:50.719583 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-21 02:20:50.719625 | instance | Friday 21 August 2026  02:20:50 +0000 (0:00:00.626)       0:00:16.407 *********
2026-08-21 02:20:51.641047 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-21 02:20:51.641119 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-21 02:20:51.641325 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-21 02:20:51.642034 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-21 02:20:51.642049 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-21 02:20:51.642055 | instance |
2026-08-21 02:20:51.642065 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-21 02:20:51.642069 | instance | Friday 21 August 2026  02:20:51 +0000 (0:00:00.921)       0:00:17.329 *********
2026-08-21 02:20:52.261186 | instance | changed: [instance]
2026-08-21 02:20:52.261287 | instance |
2026-08-21 02:20:52.261966 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-21 02:20:52.261983 | instance | Friday 21 August 2026  02:20:52 +0000 (0:00:00.602)       0:00:17.931 *********
2026-08-21 02:20:52.261988 | instance |
2026-08-21 02:20:52.261993 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-21 02:20:52.261997 | instance | Friday 21 August 2026  02:20:52 +0000 (0:00:00.017)       0:00:17.949 *********
2026-08-21 02:20:53.214838 | instance | ok: [instance]
2026-08-21 02:20:53.214924 | instance |
2026-08-21 02:20:53.215185 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-21 02:20:53.215222 | instance | Friday 21 August 2026  02:20:53 +0000 (0:00:00.953)       0:00:18.903 *********
2026-08-21 02:20:53.669052 | instance | changed: [instance]
2026-08-21 02:20:53.669176 | instance |
2026-08-21 02:20:53.669334 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-21 02:20:53.669453 | instance | Friday 21 August 2026  02:20:53 +0000 (0:00:00.454)       0:00:19.357 *********
2026-08-21 02:20:54.229432 | instance | changed: [instance]
2026-08-21 02:20:54.229514 | instance |
2026-08-21 02:20:54.230302 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-21 02:20:54.230318 | instance | Friday 21 August 2026  02:20:54 +0000 (0:00:00.560)       0:00:19.917 *********
2026-08-21 02:20:54.457880 | instance | ok: [instance]
2026-08-21 02:20:54.457951 | instance |
2026-08-21 02:20:54.458245 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-21 02:20:54.458288 | instance | Friday 21 August 2026  02:20:54 +0000 (0:00:00.228)       0:00:20.146 *********
2026-08-21 02:20:54.533076 | instance | ok: [instance] => {
2026-08-21 02:20:54.533159 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-21 02:20:54.533352 | instance | }
2026-08-21 02:20:54.533747 | instance |
2026-08-21 02:20:54.533789 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-21 02:20:54.533795 | instance | Friday 21 August 2026  02:20:54 +0000 (0:00:00.075)       0:00:20.221 *********
2026-08-21 02:20:55.503944 | instance | changed: [instance]
2026-08-21 02:20:55.504010 | instance |
2026-08-21 02:20:55.504313 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-21 02:20:55.504367 | instance | Friday 21 August 2026  02:20:55 +0000 (0:00:00.970)       0:00:21.191 *********
2026-08-21 02:20:59.935938 | instance | changed: [instance]
2026-08-21 02:20:59.936015 | instance |
2026-08-21 02:20:59.936275 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-21 02:20:59.936318 | instance | Friday 21 August 2026  02:20:59 +0000 (0:00:04.432)       0:00:25.624 *********
2026-08-21 02:21:00.989943 | instance | ok: [instance]
2026-08-21 02:21:00.990038 | instance |
2026-08-21 02:21:00.990291 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-21 02:21:00.990328 | instance | Friday 21 August 2026  02:21:00 +0000 (0:00:01.053)       0:00:26.678 *********
2026-08-21 02:21:01.334891 | instance | changed: [instance]
2026-08-21 02:21:01.335428 | instance |
2026-08-21 02:21:01.335475 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-21 02:21:01.335483 | instance | Friday 21 August 2026  02:21:01 +0000 (0:00:00.344)       0:00:27.022 *********
2026-08-21 02:21:01.790957 | instance | changed: [instance]
2026-08-21 02:21:01.791026 | instance |
2026-08-21 02:21:01.791308 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-21 02:21:01.791349 | instance | Friday 21 August 2026  02:21:01 +0000 (0:00:00.456)       0:00:27.479 *********
2026-08-21 02:21:02.372089 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-21 02:21:02.372167 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-21 02:21:02.372720 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-21 02:21:02.372762 | instance |
2026-08-21 02:21:02.372768 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-21 02:21:02.372773 | instance | Friday 21 August 2026  02:21:02 +0000 (0:00:00.581)       0:00:28.060 *********
2026-08-21 02:21:02.832258 | instance | changed: [instance]
2026-08-21 02:21:02.832323 | instance |
2026-08-21 02:21:02.832615 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-21 02:21:02.832655 | instance | Friday 21 August 2026  02:21:02 +0000 (0:00:00.459)       0:00:28.520 *********
2026-08-21 02:21:03.338305 | instance | changed: [instance]
2026-08-21 02:21:03.338374 | instance |
2026-08-21 02:21:03.339346 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-21 02:21:03.339693 | instance | Friday 21 August 2026  02:21:03 +0000 (0:00:00.482)       0:00:29.002 *********
2026-08-21 02:21:03.339707 | instance |
2026-08-21 02:21:03.339714 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-21 02:21:03.339720 | instance | Friday 21 August 2026  02:21:03 +0000 (0:00:00.023)       0:00:29.025 *********
2026-08-21 02:21:04.044621 | instance | ok: [instance]
2026-08-21 02:21:04.044754 | instance |
2026-08-21 02:21:04.045143 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-21 02:21:04.045192 | instance | Friday 21 August 2026  02:21:04 +0000 (0:00:00.706)       0:00:29.732 *********
2026-08-21 02:21:04.944803 | instance | changed: [instance]
2026-08-21 02:21:04.944884 | instance |
2026-08-21 02:21:04.945136 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-21 02:21:04.945173 | instance | Friday 21 August 2026  02:21:04 +0000 (0:00:00.900)       0:00:30.633 *********
2026-08-21 02:21:05.488152 | instance | changed: [instance]
2026-08-21 02:21:05.488234 | instance |
2026-08-21 02:21:05.488602 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-21 02:21:05.488642 | instance | Friday 21 August 2026  02:21:05 +0000 (0:00:00.543)       0:00:31.176 *********
2026-08-21 02:21:05.542690 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-21 02:21:05.542765 | instance |
2026-08-21 02:21:05.542997 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-21 02:21:05.543034 | instance | Friday 21 August 2026  02:21:05 +0000 (0:00:00.054)       0:00:31.230 *********
2026-08-21 02:21:10.715696 | instance | changed: [instance]
2026-08-21 02:21:10.715776 | instance |
2026-08-21 02:21:10.716057 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-21 02:21:10.716101 | instance | Friday 21 August 2026  02:21:10 +0000 (0:00:05.173)       0:00:36.404 *********
2026-08-21 02:21:11.369814 | instance | ok: [instance] => (item=chronyd)
2026-08-21 02:21:11.369925 | instance | ok: [instance] => (item=sshd)
2026-08-21 02:21:11.370336 | instance |
2026-08-21 02:21:11.370551 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-21 02:21:11.370560 | instance | Friday 21 August 2026  02:21:11 +0000 (0:00:00.654)       0:00:37.058 *********
2026-08-21 02:21:13.058013 | instance | changed: [instance]
2026-08-21 02:21:13.058137 | instance |
2026-08-21 02:21:13.058333 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-21 02:21:13.058517 | instance | Friday 21 August 2026  02:21:13 +0000 (0:00:01.687)       0:00:38.745 *********
2026-08-21 02:21:13.260118 | instance | ok: [instance]
2026-08-21 02:21:13.260470 | instance |
2026-08-21 02:21:13.260875 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-21 02:21:13.261251 | instance | Friday 21 August 2026  02:21:13 +0000 (0:00:00.202)       0:00:38.948 *********
2026-08-21 02:21:13.703535 | instance | changed: [instance]
2026-08-21 02:21:13.703761 | instance |
2026-08-21 02:21:13.704059 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-21 02:21:13.704493 | instance | Friday 21 August 2026  02:21:13 +0000 (0:00:00.443)       0:00:39.391 *********
2026-08-21 02:21:14.051976 | instance | changed: [instance]
2026-08-21 02:21:14.052371 | instance |
2026-08-21 02:21:14.052684 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-21 02:21:14.053009 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.348)       0:00:39.739 *********
2026-08-21 02:21:14.162704 | instance | ok: [instance]
2026-08-21 02:21:14.162959 | instance |
2026-08-21 02:21:14.163344 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-21 02:21:14.163623 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.110)       0:00:39.850 *********
2026-08-21 02:21:14.394803 | instance | ok: [instance] => (item=instance)
2026-08-21 02:21:14.395061 | instance |
2026-08-21 02:21:14.395362 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-21 02:21:14.395659 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.232)       0:00:40.082 *********
2026-08-21 02:21:14.448705 | instance | ok: [instance]
2026-08-21 02:21:14.448968 | instance |
2026-08-21 02:21:14.449237 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-21 02:21:14.449831 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.054)       0:00:40.136 *********
2026-08-21 02:21:14.525302 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-21 02:21:14.525655 | instance |
2026-08-21 02:21:14.526112 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-21 02:21:14.526539 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.076)       0:00:40.212 *********
2026-08-21 02:21:14.844644 | instance | changed: [instance]
2026-08-21 02:21:14.844864 | instance |
2026-08-21 02:21:14.845156 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-21 02:21:14.845516 | instance | Friday 21 August 2026  02:21:14 +0000 (0:00:00.319)       0:00:40.532 *********
2026-08-21 02:21:15.601559 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-21 02:21:15.601830 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-21 02:21:15.602224 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-21 02:21:15.602602 | instance |
2026-08-21 02:21:15.602981 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-21 02:21:15.603405 | instance | Friday 21 August 2026  02:21:15 +0000 (0:00:00.756)       0:00:41.288 *********
2026-08-21 02:22:41.360492 | instance | ok: [instance]
2026-08-21 02:22:41.360805 | instance |
2026-08-21 02:22:41.361300 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-21 02:22:41.362196 | instance | Friday 21 August 2026  02:22:41 +0000 (0:01:25.759)       0:02:07.048 *********
2026-08-21 02:22:41.611890 | instance | changed: [instance]
2026-08-21 02:22:41.611968 | instance |
2026-08-21 02:22:41.612102 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-21 02:22:41.612218 | instance | Friday 21 August 2026  02:22:41 +0000 (0:00:00.252)       0:02:07.300 *********
2026-08-21 02:22:41.691236 | instance | ok: [instance]
2026-08-21 02:22:41.691306 | instance |
2026-08-21 02:22:41.691398 | instance | TASK [Install Ceph host] *******************************************************
2026-08-21 02:22:41.691528 | instance | Friday 21 August 2026  02:22:41 +0000 (0:00:00.079)       0:02:07.379 *********
2026-08-21 02:22:41.778058 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-21 02:22:41.778217 | instance |
2026-08-21 02:22:41.778425 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-21 02:22:41.778608 | instance | Friday 21 August 2026  02:22:41 +0000 (0:00:00.086)       0:02:07.466 *********
2026-08-21 02:22:43.453023 | instance | ok: [instance]
2026-08-21 02:22:43.453087 | instance |
2026-08-21 02:22:43.453098 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-21 02:22:43.453109 | instance | Friday 21 August 2026  02:22:43 +0000 (0:00:01.673)       0:02:09.140 *********
2026-08-21 02:22:43.514180 | instance | ok: [instance] => (item=instance)
2026-08-21 02:22:43.514311 | instance |
2026-08-21 02:22:43.514517 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-21 02:22:43.514684 | instance | Friday 21 August 2026  02:22:43 +0000 (0:00:00.062)       0:02:09.202 *********
2026-08-21 02:22:43.863565 | instance | ok: [instance]
2026-08-21 02:22:43.863778 | instance |
2026-08-21 02:22:43.864032 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-21 02:22:43.864294 | instance | Friday 21 August 2026  02:22:43 +0000 (0:00:00.349)       0:02:09.551 *********
2026-08-21 02:22:46.198820 | instance | ok: [instance]
2026-08-21 02:22:46.198907 | instance |
2026-08-21 02:22:46.199161 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-21 02:22:46.199177 | instance | Friday 21 August 2026  02:22:46 +0000 (0:00:02.335)       0:02:11.887 *********
2026-08-21 02:23:30.899658 | 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-21 02:23:30.900782 | 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_4jr1w1p0/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_4jr1w1p0/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_4jr1w1p0/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_4jr1w1p0/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-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBHtodqhnLPHiAAtj5Wt4OOJ0BLFRYAwvt4TSEeDgqL8kaH91yPQbsj0AE=: Malformed input [buffer:3]\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBHtodqhnLPHiAAtj5Wt4OOJ0BLFRYAwvt4TSEeDgqL8kaH91yPQbsj0AE=: Malformed input [buffer:3]\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBHtodqhnLPHiAAtj5Wt4OOJ0BLFRYAwvt4TSEeDgqL8kaH91yPQbsj0AE=: Malformed input [buffer:3]\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-21T02:23:30.747+0000 7fbae3ec0640 -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-21 02:23:30.905387 | instance |
2026-08-21 02:23:30.905451 | instance | PLAY RECAP *********************************************************************
2026-08-21 02:23:30.905464 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-21 02:23:30.905474 | instance |
2026-08-21 02:23:30.905484 | instance | Friday 21 August 2026  02:23:30 +0000 (0:00:44.705)       0:02:56.592 *********
2026-08-21 02:23:30.905501 | instance | ===============================================================================
2026-08-21 02:23:30.909350 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 85.76s
2026-08-21 02:23:30.909391 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 44.71s
2026-08-21 02:23:30.909402 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.61s
2026-08-21 02:23:30.909412 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.17s
2026-08-21 02:23:30.909422 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.43s
2026-08-21 02:23:30.909431 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.88s
2026-08-21 02:23:30.909441 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.34s
2026-08-21 02:23:30.909450 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.69s
2026-08-21 02:23:30.909473 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.67s
2026-08-21 02:23:30.909483 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.66s
2026-08-21 02:23:30.909492 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.36s
2026-08-21 02:23:30.909502 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.05s
2026-08-21 02:23:30.909511 | instance | Gathering Facts --------------------------------------------------------- 0.99s
2026-08-21 02:23:30.909520 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.97s
2026-08-21 02:23:30.909530 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.92s
2026-08-21 02:23:30.909539 | instance | Gathering Facts --------------------------------------------------------- 0.91s
2026-08-21 02:23:30.909553 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.90s
2026-08-21 02:23:30.909669 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-21 02:23:30.909901 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-08-21 02:23:30.910113 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-21 02:23:31.007060 | 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-21 02:23:31.007359 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-21 02:23:31.007559 | 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-21 02:23:31.218305 | instance | ERROR
2026-08-21 02:23:31.219037 | instance | {
2026-08-21 02:23:31.219092 | instance |   "delta": "0:03:46.260843",
2026-08-21 02:23:31.219124 | instance |   "end": "2026-08-21 02:23:31.058297",
2026-08-21 02:23:31.219151 | instance |   "msg": "non-zero return code",
2026-08-21 02:23:31.219197 | instance |   "rc": 2,
2026-08-21 02:23:31.219241 | instance |   "start": "2026-08-21 02:19:44.797454"
2026-08-21 02:23:31.219271 | instance | }
failure
2026-08-21 02:23:31.226497 | 
2026-08-21 02:23:31.226551 | PLAY RECAP
2026-08-21 02:23:31.226602 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-21 02:23:31.226627 | 
2026-08-21 02:23:31.443390 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-21 02:23:31.451733 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-21 02:23:32.317726 | 
2026-08-21 02:23:32.317951 | PLAY [all]
2026-08-21 02:23:32.336774 | 
2026-08-21 02:23:32.337067 | TASK [gather-host-logs : creating directory for system status]
2026-08-21 02:23:32.738871 | instance | changed
2026-08-21 02:23:32.746804 | 
2026-08-21 02:23:32.746953 | TASK [gather-host-logs : Get logs for each host]
2026-08-21 02:23:33.132048 | instance | + systemd-cgls --full --all --no-pager
2026-08-21 02:23:33.145538 | instance | + ip addr
2026-08-21 02:23:33.148283 | instance | + ip route
2026-08-21 02:23:33.151165 | instance | + lsblk
2026-08-21 02:23:33.156585 | instance | + mount
2026-08-21 02:23:33.158442 | instance | + docker images
2026-08-21 02:23:33.178178 | instance | + brctl show
2026-08-21 02:23:33.178699 | instance | /bin/bash: line 8: brctl: command not found
2026-08-21 02:23:33.179024 | instance | + ps aux --sort=-%mem
2026-08-21 02:23:33.192822 | instance | + dpkg -l
2026-08-21 02:23:33.205975 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-21 02:23:33.206468 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-21 02:23:33.221696 | instance | + '[' '!' -z '' ']'
2026-08-21 02:23:33.298903 | instance | ok: Runtime: 0:00:00.095721
2026-08-21 02:23:33.305820 | 
2026-08-21 02:23:33.305927 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-21 02:23:33.986296 | instance | changed:
2026-08-21 02:23:33.986590 | instance | created directory /var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/logs/instance
2026-08-21 02:23:33.986645 | instance | cd+++++++++ system/
2026-08-21 02:23:33.986680 | instance | >f+++++++++ system/brctl-show.txt
2026-08-21 02:23:33.986711 | instance | >f+++++++++ system/docker-images.txt
2026-08-21 02:23:33.986740 | instance | >f+++++++++ system/ip-addr.txt
2026-08-21 02:23:33.986772 | instance | >f+++++++++ system/ip-route.txt
2026-08-21 02:23:33.986805 | instance | >f+++++++++ system/lsblk.txt
2026-08-21 02:23:33.986834 | instance | >f+++++++++ system/mount.txt
2026-08-21 02:23:33.986862 | instance | >f+++++++++ system/packages.txt
2026-08-21 02:23:33.986890 | instance | >f+++++++++ system/ps.txt
2026-08-21 02:23:33.986920 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-21 02:23:33.999839 | 
2026-08-21 02:23:33.999956 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-21 02:23:34.206132 | instance | changed: "values"
2026-08-21 02:23:34.375469 | instance | changed: "releases"
2026-08-21 02:23:34.387178 | 
2026-08-21 02:23:34.387377 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-21 02:23:34.625647 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-21 02:23:34.927337 | instance | ok: Runtime: 0:00:00.004876
2026-08-21 02:23:34.934308 | 
2026-08-21 02:23:34.934389 | TASK [helm-release-status : Downloads logs to executor]
2026-08-21 02:23:35.480114 | instance | changed:
2026-08-21 02:23:35.480412 | instance | cd+++++++++ helm/
2026-08-21 02:23:35.480471 | instance | cd+++++++++ helm/releases/
2026-08-21 02:23:35.480505 | instance | cd+++++++++ helm/values/
2026-08-21 02:23:35.491989 | 
2026-08-21 02:23:35.492182 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-21 02:23:35.711133 | instance | changed
2026-08-21 02:23:35.718352 | 
2026-08-21 02:23:35.718579 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-21 02:23:35.990380 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-21 02:23:35.991201 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-21 02:23:35.994997 | instance | environment: line 1: kubectl: command not found
2026-08-21 02:23:35.996033 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-21 02:23:35.996061 | instance | environment: line 1: kubectl: command not found
2026-08-21 02:23:35.997566 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-21 02:23:35.998410 | instance | environment: line 1: kubectl: command not found
2026-08-21 02:23:35.999848 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-21 02:23:35.999920 | instance | environment: line 1: kubectl: command not found
2026-08-21 02:23:36.000757 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-21 02:23:36.002073 | instance | environment: line 1: kubectl: command not found
2026-08-21 02:23:36.003586 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-21 02:23:36.258381 | instance | ok: Runtime: 0:00:00.019434
2026-08-21 02:23:36.267176 | 
2026-08-21 02:23:36.267362 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-21 02:23:36.500641 | instance | changed
2026-08-21 02:23:36.750081 | 
2026-08-21 02:23:36.750322 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-21 02:23:36.981902 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-21 02:23:36.981991 | instance | environment: line 5: kubectl: command not found
2026-08-21 02:23:36.982579 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-21 02:23:36.982594 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-21 02:23:37.291868 | instance | ok: Runtime: 0:00:00.006673
2026-08-21 02:23:37.298243 | 
2026-08-21 02:23:37.298383 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-21 02:23:37.801751 | instance | changed:
2026-08-21 02:23:37.802049 | instance | cd+++++++++ objects/
2026-08-21 02:23:37.802108 | instance | cd+++++++++ objects/cluster/
2026-08-21 02:23:37.802160 | instance | cd+++++++++ objects/namespaced/
2026-08-21 02:23:37.816450 | 
2026-08-21 02:23:37.816622 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-21 02:23:38.015284 | instance | changed
2026-08-21 02:23:38.021048 | 
2026-08-21 02:23:38.021168 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-21 02:23:38.230902 | instance | changed
2026-08-21 02:23:38.490452 | 
2026-08-21 02:23:38.490597 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-21 02:23:38.708147 | instance | environment: line 3: kubectl: command not found
2026-08-21 02:23:39.048081 | instance | ok: Runtime: 0:00:00.006970
2026-08-21 02:23:39.054681 | 
2026-08-21 02:23:39.054780 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-21 02:23:39.557523 | instance | changed:
2026-08-21 02:23:39.557698 | instance | cd+++++++++ pod-logs/
2026-08-21 02:23:39.557728 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-21 02:23:39.576599 | 
2026-08-21 02:23:39.577089 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-21 02:23:39.796545 | instance | changed
2026-08-21 02:23:39.803957 | 
2026-08-21 02:23:39.804057 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-21 02:23:40.020801 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-21 02:23:40.344945 | instance | ok: Runtime: 0:00:00.034811
2026-08-21 02:23:40.351522 | 
2026-08-21 02:23:40.351605 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-21 02:23:40.597925 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-21 02:23:40.628585 | instance | ceph-mgr endpoints:
2026-08-21 02:23:40.896788 | instance | ok: Runtime: 0:00:00.038421
2026-08-21 02:23:40.904602 | 
2026-08-21 02:23:40.904725 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-21 02:23:41.138501 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-21 02:23:41.536905 | instance | ok: Runtime: 0:00:00.041356
2026-08-21 02:23:41.543405 | 
2026-08-21 02:23:41.543574 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-21 02:23:42.059407 | instance | changed: cd+++++++++ prometheus/
2026-08-21 02:23:42.070451 | 
2026-08-21 02:23:42.070598 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-21 02:23:42.285945 | instance | changed
2026-08-21 02:23:42.295139 | 
2026-08-21 02:23:42.295337 | TASK [gather-selenium-data : Get selenium data]
2026-08-21 02:23:42.585146 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-21 02:23:42.585989 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-21 02:23:42.836816 | instance | ERROR
2026-08-21 02:23:42.837124 | instance | {
2026-08-21 02:23:42.837171 | instance |   "delta": "0:00:00.005326",
2026-08-21 02:23:42.837203 | instance |   "end": "2026-08-21 02:23:42.586264",
2026-08-21 02:23:42.837235 | instance |   "msg": "non-zero return code",
2026-08-21 02:23:42.837265 | instance |   "rc": 1,
2026-08-21 02:23:42.837292 | instance |   "start": "2026-08-21 02:23:42.580938"
2026-08-21 02:23:42.837319 | instance | }
2026-08-21 02:23:42.837354 | instance | ERROR: Ignoring Errors
2026-08-21 02:23:42.844907 | 
2026-08-21 02:23:42.845064 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-21 02:23:43.370401 | instance | changed: cd+++++++++ selenium/
2026-08-21 02:23:43.378113 | 
2026-08-21 02:23:43.378234 | PLAY RECAP
2026-08-21 02:23:43.378296 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-21 02:23:43.378327 | 
2026-08-21 02:23:43.661729 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-21 02:23:43.665152 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-21 02:23:44.579326 | 
2026-08-21 02:23:44.579886 | PLAY [all]
2026-08-21 02:23:44.594315 | 
2026-08-21 02:23:44.594499 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-21 02:23:44.641998 | instance | skipping: Conditional result was False
2026-08-21 02:23:44.653399 | 
2026-08-21 02:23:44.653642 | TASK [fetch-output : Set log path for single node]
2026-08-21 02:23:44.697200 | instance | ok
2026-08-21 02:23:44.704220 | 
2026-08-21 02:23:44.704337 | LOOP [fetch-output : Ensure local output dirs]
2026-08-21 02:23:45.669186 | instance -> localhost | ok: "/var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/logs"
2026-08-21 02:23:45.924649 | instance -> localhost | changed: "/var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/artifacts"
2026-08-21 02:23:46.163585 | instance -> localhost | changed: "/var/lib/zuul/builds/a5f7923e94d64406af5472ac3878f94b/work/docs"
2026-08-21 02:23:46.187515 | 
2026-08-21 02:23:46.187748 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-21 02:23:46.983344 | instance | changed: .d..t...... ./
2026-08-21 02:23:46.983657 | instance | changed: All items complete
2026-08-21 02:23:46.983711 | 
2026-08-21 02:23:47.477357 | instance | changed: .d..t...... ./
2026-08-21 02:23:47.999003 | instance | changed: .d..t...... ./
2026-08-21 02:23:48.022393 | 
2026-08-21 02:23:48.022571 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-21 02:23:48.557702 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.010222
2026-08-21 02:23:48.852254 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009849
2026-08-21 02:23:48.868237 | 
2026-08-21 02:23:48.868414 | PLAY [all]
2026-08-21 02:23:48.877497 | 
2026-08-21 02:23:48.877652 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-21 02:23:49.342906 | instance | changed
2026-08-21 02:23:49.352005 | 
2026-08-21 02:23:49.352170 | PLAY RECAP
2026-08-21 02:23:49.352265 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-21 02:23:49.352312 | 
2026-08-21 02:23:50.095588 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-21 02:23:50.284759 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-21 02:23:51.019425 | 
2026-08-21 02:23:51.019676 | PLAY [localhost]
2026-08-21 02:23:51.036448 | 
2026-08-21 02:23:51.036674 | TASK [Generate Zuul manifest]
2026-08-21 02:23:51.062450 | localhost | ok
2026-08-21 02:23:51.087118 | 
2026-08-21 02:23:51.087523 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-21 02:23:51.559386 | localhost | changed
2026-08-21 02:23:51.572594 | 
2026-08-21 02:23:51.572709 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-21 02:23:51.605795 | localhost | ok
2026-08-21 02:23:51.614062 | 
2026-08-21 02:23:51.614167 | TASK [Upload logs]
2026-08-21 02:23:51.633284 | localhost | ok
2026-08-21 02:23:51.705648 | 
2026-08-21 02:23:51.705921 | TASK [Set zuul-log-path fact]
2026-08-21 02:23:51.729320 | localhost | ok
2026-08-21 02:23:51.747416 | 
2026-08-21 02:23:51.747576 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-21 02:23:51.792030 | localhost | ok
2026-08-21 02:23:51.803400 | 
2026-08-21 02:23:51.803536 | TASK [upload-logs : Create log directories]
2026-08-21 02:23:52.278430 | localhost | changed
2026-08-21 02:23:52.285424 | 
2026-08-21 02:23:52.285552 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-21 02:23:52.763762 | localhost -> localhost | ok: Runtime: 0:00:00.006163
2026-08-21 02:23:52.769536 | 
2026-08-21 02:23:52.769616 | TASK [upload-logs : Upload logs to log server]
2026-08-21 02:23:53.330942 | localhost | Output suppressed because no_log was given
2026-08-21 02:23:53.401286 | 
2026-08-21 02:23:53.401475 | LOOP [upload-logs : Compress console log and json output]
2026-08-21 02:23:53.457288 | localhost | skipping: Conditional result was False
2026-08-21 02:23:53.472083 | localhost | skipping: Conditional result was False
2026-08-21 02:23:53.510223 | 
2026-08-21 02:23:53.510422 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-21 02:23:53.562795 | localhost | skipping: Conditional result was False
2026-08-21 02:23:53.563320 | 
2026-08-21 02:23:53.568728 | localhost | skipping: Conditional result was False
2026-08-21 02:23:53.602230 | 
2026-08-21 02:23:53.602454 | LOOP [upload-logs : Upload console log and json output]