2026-09-08 15:34:37.495127 | Job console starting
2026-09-08 15:34:37.520822 | Updating git repos
2026-09-08 15:34:44.333791 | Cloning repos into workspace
2026-09-08 15:35:00.532317 | Restoring repo states
2026-09-08 15:35:08.856292 | Merging changes
2026-09-08 15:35:10.180396 | Checking out repos
2026-09-08 15:35:11.608976 | Preparing playbooks
2026-09-08 15:35:13.572327 | Running Ansible setup
2026-09-08 15:35:17.099296 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-08 15:35:17.783615 | 
2026-09-08 15:35:17.783767 | PLAY [localhost]
2026-09-08 15:35:17.791823 | 
2026-09-08 15:35:17.791938 | TASK [Gathering Facts]
2026-09-08 15:35:18.765332 | localhost | ok
2026-09-08 15:35:18.778627 | 
2026-09-08 15:35:18.778842 | TASK [Setup log path fact]
2026-09-08 15:35:18.798306 | localhost | ok
2026-09-08 15:35:18.812718 | 
2026-09-08 15:35:18.812844 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-08 15:35:18.853306 | localhost | ok
2026-09-08 15:35:18.863035 | 
2026-09-08 15:35:18.863178 | TASK [emit-job-header : Print job information]
2026-09-08 15:35:18.904744 | # Job Information
2026-09-08 15:35:18.904993 | Ansible Version: 2.16.18
2026-09-08 15:35:18.905059 | Job: atmosphere-molecule-csi-rbd
2026-09-08 15:35:18.905103 | Pipeline: check
2026-09-08 15:35:18.905142 | Executor: 2d72f0692154
2026-09-08 15:35:18.905180 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4089
2026-09-08 15:35:18.905226 | Event ID: 3ea21940-ab9a-11f1-9982-0b84f5ce4655
2026-09-08 15:35:18.911743 | 
2026-09-08 15:35:18.911869 | LOOP [emit-job-header : Print node information]
2026-09-08 15:35:19.040810 | localhost | ok:
2026-09-08 15:35:19.041116 | localhost | # Node Information
2026-09-08 15:35:19.041180 | localhost | Inventory Hostname: instance
2026-09-08 15:35:19.041225 | localhost | Hostname: np0000192218
2026-09-08 15:35:19.041265 | localhost | Username: zuul
2026-09-08 15:35:19.041313 | localhost | Distro: Ubuntu 22.04
2026-09-08 15:35:19.041398 | localhost | Provider: yul1
2026-09-08 15:35:19.042804 | localhost | Region: ca-ymq-1
2026-09-08 15:35:19.043142 | localhost | Label: ubuntu-jammy
2026-09-08 15:35:19.043318 | localhost | Product Name: OpenStack Nova
2026-09-08 15:35:19.043399 | localhost | Interface IP: 162.253.55.149
2026-09-08 15:35:19.058999 | 
2026-09-08 15:35:19.059129 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-08 15:35:19.491240 | localhost -> localhost | changed
2026-09-08 15:35:19.499517 | 
2026-09-08 15:35:19.499610 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-08 15:35:20.428208 | localhost -> localhost | changed
2026-09-08 15:35:20.437784 | 
2026-09-08 15:35:20.437938 | PLAY [all]
2026-09-08 15:35:20.452659 | 
2026-09-08 15:35:20.452781 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-08 15:35:20.674156 | instance -> localhost | ok
2026-09-08 15:35:20.680465 | 
2026-09-08 15:35:20.680652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-08 15:35:20.700907 | instance | ok
2026-09-08 15:35:20.720207 | instance | included: /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-08 15:35:20.730442 | 
2026-09-08 15:35:20.730570 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-08 15:35:24.894362 | instance -> localhost | Generating public/private rsa key pair.
2026-09-08 15:35:24.894728 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/132f44367fa1434a89caa1e1e3969fc7_id_rsa
2026-09-08 15:35:24.894802 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/132f44367fa1434a89caa1e1e3969fc7_id_rsa.pub
2026-09-08 15:35:24.894848 | instance -> localhost | The key fingerprint is:
2026-09-08 15:35:24.894889 | instance -> localhost | SHA256:5LIMSdikDR6ALOKUQ6MnsrklfaL7MzyV0IngzPpSEPI zuul-build-sshkey
2026-09-08 15:35:24.894945 | instance -> localhost | The key's randomart image is:
2026-09-08 15:35:24.894988 | instance -> localhost | +---[RSA 3072]----+
2026-09-08 15:35:24.895034 | instance -> localhost | |=++ .            |
2026-09-08 15:35:24.895074 | instance -> localhost | |O*.O             |
2026-09-08 15:35:24.895112 | instance -> localhost | |&+*o+.  .        |
2026-09-08 15:35:24.895326 | instance -> localhost | |o@E.o. o         |
2026-09-08 15:35:24.895421 | instance -> localhost | |=.+.+.. S        |
2026-09-08 15:35:24.895481 | instance -> localhost | |.=.ooo o         |
2026-09-08 15:35:24.895701 | instance -> localhost | |o+ .  o          |
2026-09-08 15:35:24.895808 | instance -> localhost | |..*              |
2026-09-08 15:35:24.895862 | instance -> localhost | |.o.+             |
2026-09-08 15:35:24.895902 | instance -> localhost | +----[SHA256]-----+
2026-09-08 15:35:24.895996 | instance -> localhost | ok: Runtime: 0:00:03.733372
2026-09-08 15:35:24.908081 | 
2026-09-08 15:35:24.908235 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-08 15:35:24.943405 | instance | ok
2026-09-08 15:35:24.961883 | instance | included: /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-08 15:35:24.980537 | 
2026-09-08 15:35:24.980672 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-08 15:35:25.004650 | instance | skipping: Conditional result was False
2026-09-08 15:35:25.018924 | 
2026-09-08 15:35:25.019126 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-08 15:35:25.533436 | instance | changed
2026-09-08 15:35:25.545351 | 
2026-09-08 15:35:25.545504 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-08 15:35:25.762529 | instance | ok
2026-09-08 15:35:25.772777 | 
2026-09-08 15:35:25.772942 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-08 15:35:26.273277 | instance | changed
2026-09-08 15:35:26.282023 | 
2026-09-08 15:35:26.282147 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-08 15:35:26.771892 | instance | changed
2026-09-08 15:35:26.778425 | 
2026-09-08 15:35:26.778506 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-08 15:35:26.802799 | instance | skipping: Conditional result was False
2026-09-08 15:35:26.808451 | 
2026-09-08 15:35:26.808553 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-08 15:35:27.228649 | instance -> localhost | changed
2026-09-08 15:35:27.248903 | 
2026-09-08 15:35:27.249083 | TASK [add-build-sshkey : Add back temp key]
2026-09-08 15:35:27.578964 | instance -> localhost | Identity added: /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/132f44367fa1434a89caa1e1e3969fc7_id_rsa (zuul-build-sshkey)
2026-09-08 15:35:27.579214 | instance -> localhost | ok: Runtime: 0:00:00.016050
2026-09-08 15:35:27.585589 | 
2026-09-08 15:35:27.585674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-08 15:35:27.915847 | instance | ok
2026-09-08 15:35:27.924464 | 
2026-09-08 15:35:27.924616 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-08 15:35:27.960921 | instance | skipping: Conditional result was False
2026-09-08 15:35:27.977580 | 
2026-09-08 15:35:27.977752 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-08 15:35:28.380911 | instance | ok
2026-09-08 15:35:28.396191 | 
2026-09-08 15:35:28.396474 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-08 15:35:31.923288 | instance | Output suppressed because no_log was given
2026-09-08 15:35:32.093153 | 
2026-09-08 15:35:32.093308 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-08 15:35:32.324937 | instance | ok: "logs"
2026-09-08 15:35:32.325147 | instance | ok: All items complete
2026-09-08 15:35:32.325174 | 
2026-09-08 15:35:32.498359 | instance | ok: "artifacts"
2026-09-08 15:35:32.651766 | instance | ok: "docs"
2026-09-08 15:35:32.670584 | 
2026-09-08 15:35:32.670786 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-08 15:35:32.858579 | instance | changed: "logs"
2026-09-08 15:35:33.003505 | instance | changed: "artifacts"
2026-09-08 15:35:33.183070 | instance | changed: "docs"
2026-09-08 15:35:33.208542 | 
2026-09-08 15:35:33.208689 | PLAY RECAP
2026-09-08 15:35:33.208774 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-08 15:35:33.208829 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:35:33.208872 | 
2026-09-08 15:35:33.338752 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-08 15:35:33.342327 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-08 15:35:34.015060 | 
2026-09-08 15:35:34.015217 | PLAY [all]
2026-09-08 15:35:34.027257 | 
2026-09-08 15:35:34.027390 | TASK [setup-uv : Extract archive]
2026-09-08 15:35:36.315744 | instance | changed
2026-09-08 15:35:36.320848 | 
2026-09-08 15:35:36.320935 | TASK [setup-uv : Print version]
2026-09-08 15:35:36.665543 | instance | uv 0.8.13
2026-09-08 15:35:36.863653 | instance | ok: Runtime: 0:00:00.012691
2026-09-08 15:35:36.882557 | 
2026-09-08 15:35:36.882690 | TASK [Install Ansible collection siblings]
2026-09-08 15:35:46.606089 | instance | changed:
2026-09-08 15:35:46.606255 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-08 15:35:46.606290 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-08 15:35:46.606320 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-08 15:35:46.606351 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-08 15:35:46.606379 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-08 15:35:46.606430 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-08 15:35:46.606460 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-08 15:35:46.606486 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-08 15:35:46.606510 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-08 15:35:46.606533 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-08 15:35:46.606555 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-08 15:35:46.606577 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-08 15:35:46.606599 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0
2026-09-08 15:35:46.606622 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-08 15:35:46.606644 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0
2026-09-08 15:35:46.606667 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-08 15:35:46.606688 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-08 15:35:46.606710 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-08 15:35:46.606733 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-08 15:35:46.606760 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0
2026-09-08 15:35:46.606785 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0
2026-09-08 15:35:46.606808 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-08 15:35:46.606831 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-08 15:35:46.606862 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-09-08 15:35:46.606884 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-08 15:35:46.606908 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-08 15:35:46.606930 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-08 15:35:46.606951 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0
2026-09-08 15:35:46.606972 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-08 15:35:46.606994 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-08 15:35:46.607015 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-08 15:35:46.607039 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-08 15:35:46.607066 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-08 15:35:46.607089 | instance | Checked out ansible.netcommon to v8.6.2
2026-09-08 15:35:46.607111 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-08 15:35:46.607139 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.607161 | instance | Process install dependency map
2026-09-08 15:35:46.607183 | instance | Starting collection install process
2026-09-08 15:35:46.607206 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-08 15:35:46.607228 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-08 15:35:46.607250 | instance | ansible.netcommon:8.6.2 was installed successfully
2026-09-08 15:35:46.607270 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-08 15:35:46.607292 | instance | Creating virtual environment at: .venv
2026-09-08 15:35:46.607313 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-08 15:35:46.607336 | instance | Downloading kubernetes (1.9MiB)
2026-09-08 15:35:46.607363 | instance | Downloading netaddr (2.2MiB)
2026-09-08 15:35:46.607388 | instance | Downloading setuptools (1.1MiB)
2026-09-08 15:35:46.607429 | instance | Downloading openstacksdk (1.7MiB)
2026-09-08 15:35:46.607451 | instance | Downloading cryptography (4.2MiB)
2026-09-08 15:35:46.607473 | instance | Downloading ansible-core (2.1MiB)
2026-09-08 15:35:46.607494 | instance | Downloading rjsonnet (1.2MiB)
2026-09-08 15:35:46.607516 | instance | Downloading pygments (1.2MiB)
2026-09-08 15:35:46.607538 | instance |    Building pyperclip==1.9.0
2026-09-08 15:35:46.607561 | instance |  Downloading rjsonnet
2026-09-08 15:35:46.607583 | instance |  Downloading netaddr
2026-09-08 15:35:46.607605 | instance |  Downloading pygments
2026-09-08 15:35:46.607626 | instance |  Downloading cryptography
2026-09-08 15:35:46.607648 | instance |  Downloading setuptools
2026-09-08 15:35:46.607674 | instance |  Downloading kubernetes
2026-09-08 15:35:46.607698 | instance |  Downloading ansible-core
2026-09-08 15:35:46.607719 | instance |  Downloading openstacksdk
2026-09-08 15:35:46.607740 | instance |       Built pyperclip==1.9.0
2026-09-08 15:35:46.607761 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-08 15:35:46.607782 | instance | Installed 79 packages in 60ms
2026-09-08 15:35:46.607803 | instance | Checked out ansible.posix to 1.6.0
2026-09-08 15:35:46.607825 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-08 15:35:46.607849 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.607872 | instance | Process install dependency map
2026-09-08 15:35:46.607903 | instance | Starting collection install process
2026-09-08 15:35:46.607925 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-08 15:35:46.607946 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-08 15:35:46.607970 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-08 15:35:46.608018 | instance | Checked out ansible.utils to v6.1.0
2026-09-08 15:35:46.608056 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-08 15:35:46.608081 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.608102 | instance | Process install dependency map
2026-09-08 15:35:46.608123 | instance | Starting collection install process
2026-09-08 15:35:46.608145 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-08 15:35:46.608166 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-08 15:35:46.608188 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-08 15:35:46.608210 | instance | Checked out atmosphere.common to v0.6.0
2026-09-08 15:35:46.608232 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-08 15:35:46.608253 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.608275 | instance | Process install dependency map
2026-09-08 15:35:46.608295 | instance | Starting collection install process
2026-09-08 15:35:46.608319 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-08 15:35:46.608344 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-08 15:35:46.608367 | instance | atmosphere.common:0.6.0 was installed successfully
2026-09-08 15:35:46.608388 | instance | Checked out community.crypto to 2.2.3
2026-09-08 15:35:46.608429 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-08 15:35:46.608451 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.608472 | instance | Process install dependency map
2026-09-08 15:35:46.608507 | instance | Starting collection install process
2026-09-08 15:35:46.608533 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-08 15:35:46.608555 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-08 15:35:46.608576 | instance | community.crypto:2.2.3 was installed successfully
2026-09-08 15:35:46.608596 | instance | Checked out community.general to 7.3.0
2026-09-08 15:35:46.608621 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-08 15:35:46.608643 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.608820 | instance | Process install dependency map
2026-09-08 15:35:46.608851 | instance | Starting collection install process
2026-09-08 15:35:46.608873 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-08 15:35:46.608895 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-08 15:35:46.608920 | instance | community.general:7.3.0 was installed successfully
2026-09-08 15:35:46.608953 | instance | Checked out community.mysql to 3.6.0
2026-09-08 15:35:46.608977 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-08 15:35:46.608998 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609019 | instance | Process install dependency map
2026-09-08 15:35:46.609040 | instance | Starting collection install process
2026-09-08 15:35:46.609061 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-08 15:35:46.609083 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-08 15:35:46.609104 | instance | community.mysql:3.6.0 was installed successfully
2026-09-08 15:35:46.609125 | instance | Checked out kubernetes.core to 2.4.0
2026-09-08 15:35:46.609146 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-08 15:35:46.609168 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609189 | instance | Process install dependency map
2026-09-08 15:35:46.609213 | instance | Starting collection install process
2026-09-08 15:35:46.609239 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-08 15:35:46.609264 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-08 15:35:46.609286 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-08 15:35:46.609307 | instance | Checked out openstack.cloud to 1.7.0
2026-09-08 15:35:46.609328 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-08 15:35:46.609349 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609370 | instance | Process install dependency map
2026-09-08 15:35:46.609408 | instance | Starting collection install process
2026-09-08 15:35:46.609433 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-08 15:35:46.609455 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-08 15:35:46.609476 | instance | openstack.cloud:1.7.0 was installed successfully
2026-09-08 15:35:46.609497 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-08 15:35:46.609519 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-08 15:35:46.609542 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609565 | instance | Process install dependency map
2026-09-08 15:35:46.609589 | instance | Starting collection install process
2026-09-08 15:35:46.609612 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-08 15:35:46.609634 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-08 15:35:46.609655 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-08 15:35:46.609676 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-08 15:35:46.609697 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-08 15:35:46.609719 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609747 | instance | Process install dependency map
2026-09-08 15:35:46.609769 | instance | Starting collection install process
2026-09-08 15:35:46.609790 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-08 15:35:46.609810 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-08 15:35:46.609831 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-08 15:35:46.609853 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-08 15:35:46.609877 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-08 15:35:46.609899 | instance | Starting galaxy collection install process
2026-09-08 15:35:46.609922 | instance | Process install dependency map
2026-09-08 15:35:46.609943 | instance | Starting collection install process
2026-09-08 15:35:46.609964 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-08 15:35:46.609984 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-08 15:35:46.610005 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-08 15:35:46.618033 | 
2026-09-08 15:35:46.618121 | PLAY RECAP
2026-09-08 15:35:46.618198 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:35:46.618223 | 
2026-09-08 15:35:46.729854 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-08 15:35:46.732844 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-08 15:35:47.936802 | 
2026-09-08 15:35:47.937028 | PLAY [all]
2026-09-08 15:35:47.951425 | 
2026-09-08 15:35:47.951615 | TASK [Install "jq" for log collection]
2026-09-08 15:35:57.079378 | instance | changed
2026-09-08 15:35:57.082706 | 
2026-09-08 15:35:57.082819 | PLAY RECAP
2026-09-08 15:35:57.082949 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:35:57.083108 | 
2026-09-08 15:35:57.260611 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-08 15:35:57.265073 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-08 15:35:57.810948 | 
2026-09-08 15:35:57.811065 | PLAY [all]
2026-09-08 15:35:57.822453 | 
2026-09-08 15:35:57.822593 | LOOP [Check inventory directories]
2026-09-08 15:35:58.174426 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-08 15:35:58.351415 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-08 15:35:58.514215 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-08 15:35:58.521853 | 
2026-09-08 15:35:58.522042 | LOOP [Copy inventory file for Zuul]
2026-09-08 15:35:59.374309 | instance | changed:
2026-09-08 15:35:59.374595 | instance | {
2026-09-08 15:35:59.374768 | instance |   "ansible_loop_var": "item",
2026-09-08 15:35:59.374795 | instance |   "changed": false,
2026-09-08 15:35:59.374814 | instance |   "failed": false,
2026-09-08 15:35:59.374834 | instance |   "invocation": {
2026-09-08 15:35:59.374850 | instance |     "module_args": {
2026-09-08 15:35:59.374867 | instance |       "checksum_algorithm": "sha1",
2026-09-08 15:35:59.374882 | instance |       "follow": true,
2026-09-08 15:35:59.374898 | instance |       "get_attributes": true,
2026-09-08 15:35:59.374915 | instance |       "get_checksum": true,
2026-09-08 15:35:59.374931 | instance |       "get_mime": true,
2026-09-08 15:35:59.374946 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-08 15:35:59.374976 | instance |     }
2026-09-08 15:35:59.374991 | instance |   },
2026-09-08 15:35:59.375006 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-08 15:35:59.375021 | instance |   "stat": {
2026-09-08 15:35:59.375036 | instance |     "atime": 1788881739.3804,
2026-09-08 15:35:59.375051 | instance |     "attr_flags": "e",
2026-09-08 15:35:59.375066 | instance |     "attributes": [
2026-09-08 15:35:59.375080 | instance |       "extents"
2026-09-08 15:35:59.375095 | instance |     ],
2026-09-08 15:35:59.375109 | instance |     "block_size": 4096,
2026-09-08 15:35:59.375123 | instance |     "blocks": 8,
2026-09-08 15:35:59.375137 | instance |     "charset": "unknown",
2026-09-08 15:35:59.375153 | instance |     "ctime": 1788881737.7523556,
2026-09-08 15:35:59.375167 | instance |     "dev": 64513,
2026-09-08 15:35:59.375182 | instance |     "device_type": 0,
2026-09-08 15:35:59.375196 | instance |     "executable": true,
2026-09-08 15:35:59.375210 | instance |     "exists": true,
2026-09-08 15:35:59.375224 | instance |     "gid": 1000,
2026-09-08 15:35:59.375238 | instance |     "gr_name": "zuul",
2026-09-08 15:35:59.375252 | instance |     "inode": 1049392,
2026-09-08 15:35:59.375266 | instance |     "isblk": false,
2026-09-08 15:35:59.375280 | instance |     "ischr": false,
2026-09-08 15:35:59.375294 | instance |     "isdir": true,
2026-09-08 15:35:59.375309 | instance |     "isfifo": false,
2026-09-08 15:35:59.375323 | instance |     "isgid": false,
2026-09-08 15:35:59.375337 | instance |     "islnk": false,
2026-09-08 15:35:59.375352 | instance |     "isreg": false,
2026-09-08 15:35:59.375366 | instance |     "issock": false,
2026-09-08 15:35:59.375381 | instance |     "isuid": false,
2026-09-08 15:35:59.375395 | instance |     "mimetype": "unknown",
2026-09-08 15:35:59.375423 | instance |     "mode": "0755",
2026-09-08 15:35:59.375438 | instance |     "mtime": 1788881737.7523556,
2026-09-08 15:35:59.375452 | instance |     "nlink": 22,
2026-09-08 15:35:59.375466 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-08 15:35:59.375480 | instance |     "pw_name": "zuul",
2026-09-08 15:35:59.375600 | instance |     "readable": true,
2026-09-08 15:35:59.375640 | instance |     "rgrp": true,
2026-09-08 15:35:59.375659 | instance |     "roth": true,
2026-09-08 15:35:59.375674 | instance |     "rusr": true,
2026-09-08 15:35:59.375689 | instance |     "size": 4096,
2026-09-08 15:35:59.375704 | instance |     "uid": 1000,
2026-09-08 15:35:59.375718 | instance |     "version": "3345027761",
2026-09-08 15:35:59.375733 | instance |     "wgrp": false,
2026-09-08 15:35:59.375749 | instance |     "woth": false,
2026-09-08 15:35:59.375867 | instance |     "writeable": true,
2026-09-08 15:35:59.375916 | instance |     "wusr": true,
2026-09-08 15:35:59.375936 | instance |     "xgrp": true,
2026-09-08 15:35:59.375951 | instance |     "xoth": true,
2026-09-08 15:35:59.375967 | instance |     "xusr": true
2026-09-08 15:35:59.375982 | instance |   }
2026-09-08 15:35:59.375996 | instance | }
2026-09-08 15:35:59.376032 | instance | ok: All items complete
2026-09-08 15:35:59.376054 | 
2026-09-08 15:35:59.377425 | instance | skipping: Conditional result was False
2026-09-08 15:35:59.385129 | instance | skipping: Conditional result was False
2026-09-08 15:35:59.401169 | 
2026-09-08 15:35:59.401323 | LOOP [Switch "ansible_host" to private IP]
2026-09-08 15:35:59.758194 | instance | changed: 1 replacements made
2026-09-08 15:35:59.765212 | instance | skipping: Conditional result was False
2026-09-08 15:35:59.769146 | instance | skipping: Conditional result was False
2026-09-08 15:35:59.779184 | 
2026-09-08 15:35:59.779318 | TASK [Run Molecule scenario]
2026-09-08 15:36:00.696190 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-08 15:36:01.077633 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-08 15:36:01.077737 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-08 15:36:11.999795 | instance | INFO     [csi > dependency] Executing
2026-09-08 15:36:12.000183 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-08 15:36:12.000665 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-08 15:36:12.000953 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-08 15:36:12.017714 | instance | INFO     [csi > cleanup] Executing
2026-09-08 15:36:12.018369 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-08 15:36:12.031974 | instance | INFO     [csi > destroy] Executing
2026-09-08 15:36:12.032071 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-08 15:36:12.032085 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-08 15:36:12.042840 | instance | INFO     [csi > syntax] Executing
2026-09-08 15:36:13.625469 | instance |
2026-09-08 15:36:13.625615 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:36:13.709035 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-08 15:36:13.724063 | instance | INFO     [csi > create] Executing
2026-09-08 15:36:13.735887 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-08 15:36:13.751194 | instance | INFO     [csi > prepare] Executing
2026-09-08 15:36:14.569637 | instance |
2026-09-08 15:36:14.569783 | instance | PLAY [Prepare] *****************************************************************
2026-09-08 15:36:14.570021 | instance |
2026-09-08 15:36:14.570280 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:36:14.570581 | instance | Tuesday 08 September 2026  15:36:14 +0000 (0:00:00.025)       0:00:00.025 *****
2026-09-08 15:36:15.870765 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-08 15:36:15.871021 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-08 15:36:15.871323 | instance | interpreter could change the meaning of that path. See
2026-09-08 15:36:15.871591 | instance | https://docs.ansible.com/ansible-
2026-09-08 15:36:15.871888 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-08 15:36:15.876709 | instance | ok: [instance]
2026-09-08 15:36:15.876994 | instance |
2026-09-08 15:36:15.877287 | instance | TASK [Configure short hostname] ************************************************
2026-09-08 15:36:15.877570 | instance | Tuesday 08 September 2026  15:36:15 +0000 (0:00:01.308)       0:00:01.334 *****
2026-09-08 15:36:16.626673 | instance | changed: [instance]
2026-09-08 15:36:16.626932 | instance |
2026-09-08 15:36:16.627253 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-08 15:36:16.627520 | instance | Tuesday 08 September 2026  15:36:16 +0000 (0:00:00.748)       0:00:02.083 *****
2026-09-08 15:36:16.913594 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-08 15:36:16.913724 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-08 15:36:16.913877 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-08 15:36:16.924797 | instance | changed: [instance]
2026-09-08 15:36:16.924928 | instance |
2026-09-08 15:36:16.925072 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-08 15:36:16.925210 | instance | Tuesday 08 September 2026  15:36:16 +0000 (0:00:00.298)       0:00:02.381 *****
2026-09-08 15:36:17.716866 | instance | ok: [instance]
2026-09-08 15:36:17.716974 | instance |
2026-09-08 15:36:17.717208 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-08 15:36:17.717316 | instance |
2026-09-08 15:36:17.717456 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:36:17.717584 | instance | Tuesday 08 September 2026  15:36:17 +0000 (0:00:00.792)       0:00:03.173 *****
2026-09-08 15:36:18.464702 | instance | ok: [instance]
2026-09-08 15:36:18.464947 | instance |
2026-09-08 15:36:18.465213 | instance | TASK [Install depedencies] *****************************************************
2026-09-08 15:36:18.465476 | instance | Tuesday 08 September 2026  15:36:18 +0000 (0:00:00.747)       0:00:03.921 *****
2026-09-08 15:36:42.525631 | instance | changed: [instance]
2026-09-08 15:36:42.525705 | instance |
2026-09-08 15:36:42.525717 | instance | TASK [Start up service] ********************************************************
2026-09-08 15:36:42.525728 | instance | Tuesday 08 September 2026  15:36:42 +0000 (0:00:24.060)       0:00:27.981 *****
2026-09-08 15:36:43.092576 | instance | ok: [instance]
2026-09-08 15:36:43.092810 | instance |
2026-09-08 15:36:43.093156 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-08 15:36:43.093430 | instance | Tuesday 08 September 2026  15:36:43 +0000 (0:00:00.567)       0:00:28.549 *****
2026-09-08 15:36:43.414906 | instance | ok: [instance]
2026-09-08 15:36:43.415194 | instance |
2026-09-08 15:36:43.415538 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-08 15:36:43.415985 | instance | Tuesday 08 September 2026  15:36:43 +0000 (0:00:00.321)       0:00:28.870 *****
2026-09-08 15:36:44.175509 | instance | changed: [instance]
2026-09-08 15:36:44.175704 | instance |
2026-09-08 15:36:44.175975 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-08 15:36:44.176225 | instance | Tuesday 08 September 2026  15:36:44 +0000 (0:00:00.760)       0:00:29.631 *****
2026-09-08 15:36:44.375012 | instance | ok: [instance]
2026-09-08 15:36:44.375120 | instance |
2026-09-08 15:36:44.375137 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-08 15:36:44.375208 | instance | Tuesday 08 September 2026  15:36:44 +0000 (0:00:00.200)       0:00:29.832 *****
2026-09-08 15:36:44.400674 | instance | skipping: [instance]
2026-09-08 15:36:44.400896 | instance |
2026-09-08 15:36:44.401144 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-08 15:36:44.401393 | instance | Tuesday 08 September 2026  15:36:44 +0000 (0:00:00.024)       0:00:29.856 *****
2026-09-08 15:36:44.990629 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:36:44.990909 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:36:44.991140 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:36:44.991372 | instance |
2026-09-08 15:36:44.991580 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-08 15:36:44.991829 | instance | Tuesday 08 September 2026  15:36:44 +0000 (0:00:00.590)       0:00:30.447 *****
2026-09-08 15:36:45.677273 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:36:45.677666 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:36:45.677976 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:36:45.678260 | instance |
2026-09-08 15:36:45.678557 | instance | TASK [Start loop devices] ******************************************************
2026-09-08 15:36:45.678876 | instance | Tuesday 08 September 2026  15:36:45 +0000 (0:00:00.686)       0:00:31.133 *****
2026-09-08 15:36:46.356246 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:36:46.356306 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:36:46.356743 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:36:46.356804 | instance |
2026-09-08 15:36:46.356824 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-08 15:36:46.356837 | instance | Tuesday 08 September 2026  15:36:46 +0000 (0:00:00.678)       0:00:31.812 *****
2026-09-08 15:36:49.618607 | instance | changed: [instance] => (item=osd0)
2026-09-08 15:36:49.619926 | instance | changed: [instance] => (item=osd1)
2026-09-08 15:36:49.619977 | instance | changed: [instance] => (item=osd2)
2026-09-08 15:36:49.619989 | instance |
2026-09-08 15:36:49.619999 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-08 15:36:49.620009 | instance | Tuesday 08 September 2026  15:36:49 +0000 (0:00:03.262)       0:00:35.075 *****
2026-09-08 15:36:51.616724 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-08 15:36:51.616810 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-08 15:36:51.616844 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-08 15:36:51.616862 | instance |
2026-09-08 15:36:51.620799 | instance | PLAY RECAP *********************************************************************
2026-09-08 15:36:51.620901 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-08 15:36:51.620914 | instance |
2026-09-08 15:36:51.620924 | instance | Tuesday 08 September 2026  15:36:51 +0000 (0:00:01.997)       0:00:37.073 *****
2026-09-08 15:36:51.620934 | instance | ===============================================================================
2026-09-08 15:36:51.620942 | instance | Install depedencies ---------------------------------------------------- 24.06s
2026-09-08 15:36:51.620951 | instance | Create a volume group for each loop device ------------------------------ 3.26s
2026-09-08 15:36:51.620960 | instance | Create a logical volume for each loop device ---------------------------- 2.00s
2026-09-08 15:36:51.620971 | instance | Gathering Facts --------------------------------------------------------- 1.31s
2026-09-08 15:36:51.620980 | instance | Purge "snapd" package --------------------------------------------------- 0.79s
2026-09-08 15:36:51.620989 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.76s
2026-09-08 15:36:51.620998 | instance | Configure short hostname ------------------------------------------------ 0.75s
2026-09-08 15:36:51.621006 | instance | Gathering Facts --------------------------------------------------------- 0.75s
2026-09-08 15:36:51.621025 | instance | Set permissions on loopback devices ------------------------------------- 0.69s
2026-09-08 15:36:51.621213 | instance | Start loop devices ------------------------------------------------------ 0.68s
2026-09-08 15:36:51.621619 | instance | Create devices for Ceph ------------------------------------------------- 0.59s
2026-09-08 15:36:51.621991 | instance | Start up service -------------------------------------------------------- 0.57s
2026-09-08 15:36:51.622339 | instance | Generate lvm.conf ------------------------------------------------------- 0.32s
2026-09-08 15:36:51.622714 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-08 15:36:51.623059 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-09-08 15:36:51.623401 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-09-08 15:36:51.712440 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-08 15:36:51.723857 | instance | INFO     [csi > converge] Executing
2026-09-08 15:36:53.169216 | instance |
2026-09-08 15:36:53.169718 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-08 15:36:53.170090 | instance |
2026-09-08 15:36:53.170518 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:36:53.170899 | instance | Tuesday 08 September 2026  15:36:53 +0000 (0:00:00.007)       0:00:00.007 *****
2026-09-08 15:36:54.164986 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-08 15:36:54.165305 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-08 15:36:54.165543 | instance | interpreter could change the meaning of that path. See
2026-09-08 15:36:54.165782 | instance | https://docs.ansible.com/ansible-
2026-09-08 15:36:54.166131 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-08 15:36:54.182553 | instance | ok: [instance]
2026-09-08 15:36:54.182588 | instance |
2026-09-08 15:36:54.182600 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-08 15:36:54.182610 | instance | Tuesday 08 September 2026  15:36:54 +0000 (0:00:01.012)       0:00:01.020 *****
2026-09-08 15:36:54.241143 | instance | ok: [instance] => {
2026-09-08 15:36:54.241198 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-08 15:36:54.241210 | instance | }
2026-09-08 15:36:54.241220 | instance |
2026-09-08 15:36:54.241229 | instance | PLAY [all] *********************************************************************
2026-09-08 15:36:54.241239 | instance |
2026-09-08 15:36:54.241248 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:36:54.241274 | instance | Tuesday 08 September 2026  15:36:54 +0000 (0:00:00.057)       0:00:01.077 *****
2026-09-08 15:36:55.183002 | instance | ok: [instance]
2026-09-08 15:36:55.183086 | instance |
2026-09-08 15:36:55.183095 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-08 15:36:55.183103 | instance | Tuesday 08 September 2026  15:36:55 +0000 (0:00:00.943)       0:00:02.020 *****
2026-09-08 15:36:55.380453 | instance | ok: [instance]
2026-09-08 15:36:55.380928 | instance |
2026-09-08 15:36:55.381295 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-08 15:36:55.381658 | instance |
2026-09-08 15:36:55.381998 | instance | TASK [Gathering Facts] *********************************************************
2026-09-08 15:36:55.382318 | instance | Tuesday 08 September 2026  15:36:55 +0000 (0:00:00.198)       0:00:02.218 *****
2026-09-08 15:36:56.409385 | instance | ok: [instance]
2026-09-08 15:36:56.409798 | instance |
2026-09-08 15:36:56.410144 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:36:56.410474 | instance | Tuesday 08 September 2026  15:36:56 +0000 (0:00:01.028)       0:00:03.247 *****
2026-09-08 15:36:56.739426 | instance | ok: [instance]
2026-09-08 15:36:56.739756 | instance |
2026-09-08 15:36:56.740004 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:36:56.740262 | instance | Tuesday 08 September 2026  15:36:56 +0000 (0:00:00.330)       0:00:03.577 *****
2026-09-08 15:36:56.785946 | instance | skipping: [instance]
2026-09-08 15:36:56.786329 | instance |
2026-09-08 15:36:56.786690 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-08 15:36:56.787014 | instance | Tuesday 08 September 2026  15:36:56 +0000 (0:00:00.046)       0:00:03.624 *****
2026-09-08 15:36:57.207321 | instance | changed: [instance]
2026-09-08 15:36:57.207389 | instance |
2026-09-08 15:36:57.207398 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:36:57.207406 | instance | Tuesday 08 September 2026  15:36:57 +0000 (0:00:00.420)       0:00:04.045 *****
2026-09-08 15:36:57.304235 | instance | ok: [instance] => {
2026-09-08 15:36:57.304316 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-08 15:36:57.304329 | instance | }
2026-09-08 15:36:57.304340 | instance |
2026-09-08 15:36:57.304350 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:36:57.304361 | instance | Tuesday 08 September 2026  15:36:57 +0000 (0:00:00.095)       0:00:04.141 *****
2026-09-08 15:36:58.136700 | instance | changed: [instance]
2026-09-08 15:36:58.136981 | instance |
2026-09-08 15:36:58.137533 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:36:58.138015 | instance | Tuesday 08 September 2026  15:36:58 +0000 (0:00:00.833)       0:00:04.974 *****
2026-09-08 15:36:58.199837 | instance | skipping: [instance]
2026-09-08 15:36:58.199983 | instance |
2026-09-08 15:36:58.200246 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:36:58.200442 | instance | Tuesday 08 September 2026  15:36:58 +0000 (0:00:00.063)       0:00:05.038 *****
2026-09-08 15:36:58.269093 | instance | skipping: [instance]
2026-09-08 15:36:58.269199 | instance |
2026-09-08 15:36:58.269292 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:36:58.269515 | instance | Tuesday 08 September 2026  15:36:58 +0000 (0:00:00.069)       0:00:05.107 *****
2026-09-08 15:36:58.533420 | instance | ok: [instance]
2026-09-08 15:36:58.533482 | instance |
2026-09-08 15:36:58.533492 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-08 15:36:58.533502 | instance | Tuesday 08 September 2026  15:36:58 +0000 (0:00:00.263)       0:00:05.371 *****
2026-09-08 15:37:00.208743 | instance | ok: [instance]
2026-09-08 15:37:00.208846 | instance |
2026-09-08 15:37:00.208858 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:37:00.209025 | instance | Tuesday 08 September 2026  15:37:00 +0000 (0:00:01.675)       0:00:07.047 *****
2026-09-08 15:37:00.301833 | instance | ok: [instance] => {
2026-09-08 15:37:00.302144 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-08 15:37:00.302435 | instance | }
2026-09-08 15:37:00.302697 | instance |
2026-09-08 15:37:00.303020 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:37:00.303325 | instance | Tuesday 08 September 2026  15:37:00 +0000 (0:00:00.092)       0:00:07.139 *****
2026-09-08 15:37:01.235745 | instance | changed: [instance]
2026-09-08 15:37:01.235960 | instance |
2026-09-08 15:37:01.236214 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:37:01.236450 | instance | Tuesday 08 September 2026  15:37:01 +0000 (0:00:00.933)       0:00:08.072 *****
2026-09-08 15:37:04.174615 | instance | changed: [instance]
2026-09-08 15:37:04.174902 | instance |
2026-09-08 15:37:04.175087 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-08 15:37:04.175350 | instance | Tuesday 08 September 2026  15:37:04 +0000 (0:00:02.940)       0:00:11.013 *****
2026-09-08 15:37:04.210894 | instance | skipping: [instance]
2026-09-08 15:37:04.211299 | instance |
2026-09-08 15:37:04.211679 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-08 15:37:04.211999 | instance | Tuesday 08 September 2026  15:37:04 +0000 (0:00:00.035)       0:00:11.048 *****
2026-09-08 15:37:04.241276 | instance | skipping: [instance]
2026-09-08 15:37:04.241590 | instance |
2026-09-08 15:37:04.241861 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-08 15:37:04.242059 | instance | Tuesday 08 September 2026  15:37:04 +0000 (0:00:00.029)       0:00:11.078 *****
2026-09-08 15:37:04.269339 | instance | skipping: [instance]
2026-09-08 15:37:04.269671 | instance |
2026-09-08 15:37:04.269840 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-08 15:37:04.270016 | instance | Tuesday 08 September 2026  15:37:04 +0000 (0:00:00.026)       0:00:11.104 *****
2026-09-08 15:37:10.036656 | instance | changed: [instance]
2026-09-08 15:37:10.036897 | instance |
2026-09-08 15:37:10.037143 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-08 15:37:10.037370 | instance | Tuesday 08 September 2026  15:37:10 +0000 (0:00:05.770)       0:00:16.874 *****
2026-09-08 15:37:10.669147 | instance | changed: [instance]
2026-09-08 15:37:10.669254 | instance |
2026-09-08 15:37:10.669404 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-08 15:37:10.669549 | instance | Tuesday 08 September 2026  15:37:10 +0000 (0:00:00.632)       0:00:17.507 *****
2026-09-08 15:37:11.635862 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-08 15:37:11.635910 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-08 15:37:11.635920 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-08 15:37:11.635926 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-08 15:37:11.635934 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-08 15:37:11.635942 | instance |
2026-09-08 15:37:11.635953 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-08 15:37:11.635964 | instance | Tuesday 08 September 2026  15:37:11 +0000 (0:00:00.966)       0:00:18.473 *****
2026-09-08 15:37:12.219930 | instance | changed: [instance]
2026-09-08 15:37:12.220665 | instance |
2026-09-08 15:37:12.220706 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-08 15:37:12.220720 | instance | Tuesday 08 September 2026  15:37:12 +0000 (0:00:00.557)       0:00:19.031 *****
2026-09-08 15:37:12.221196 | instance |
2026-09-08 15:37:12.221220 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-08 15:37:12.221229 | instance | Tuesday 08 September 2026  15:37:12 +0000 (0:00:00.027)       0:00:19.058 *****
2026-09-08 15:37:13.167040 | instance | ok: [instance]
2026-09-08 15:37:13.168011 | instance |
2026-09-08 15:37:13.168046 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-08 15:37:13.168060 | instance | Tuesday 08 September 2026  15:37:13 +0000 (0:00:00.946)       0:00:20.005 *****
2026-09-08 15:37:13.620914 | instance | changed: [instance]
2026-09-08 15:37:13.621801 | instance |
2026-09-08 15:37:13.621832 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-08 15:37:13.621845 | instance | Tuesday 08 September 2026  15:37:13 +0000 (0:00:00.453)       0:00:20.458 *****
2026-09-08 15:37:14.199414 | instance | changed: [instance]
2026-09-08 15:37:14.200197 | instance |
2026-09-08 15:37:14.200256 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-08 15:37:14.200268 | instance | Tuesday 08 September 2026  15:37:14 +0000 (0:00:00.578)       0:00:21.037 *****
2026-09-08 15:37:14.444223 | instance | ok: [instance]
2026-09-08 15:37:14.444302 | instance |
2026-09-08 15:37:14.444684 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-08 15:37:14.444853 | instance | Tuesday 08 September 2026  15:37:14 +0000 (0:00:00.244)       0:00:21.282 *****
2026-09-08 15:37:14.515423 | instance | ok: [instance] => {
2026-09-08 15:37:14.515597 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-08 15:37:14.515620 | instance | }
2026-09-08 15:37:14.515659 | instance |
2026-09-08 15:37:14.515752 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-08 15:37:14.515893 | instance | Tuesday 08 September 2026  15:37:14 +0000 (0:00:00.071)       0:00:21.354 *****
2026-09-08 15:37:15.354606 | instance | changed: [instance]
2026-09-08 15:37:15.355303 | instance |
2026-09-08 15:37:15.355334 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-08 15:37:15.355347 | instance | Tuesday 08 September 2026  15:37:15 +0000 (0:00:00.838)       0:00:22.193 *****
2026-09-08 15:37:19.663349 | instance | changed: [instance]
2026-09-08 15:37:19.663409 | instance |
2026-09-08 15:37:19.663422 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-08 15:37:19.663434 | instance | Tuesday 08 September 2026  15:37:19 +0000 (0:00:04.307)       0:00:26.501 *****
2026-09-08 15:37:20.780699 | instance | ok: [instance]
2026-09-08 15:37:20.780769 | instance |
2026-09-08 15:37:20.780781 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-08 15:37:20.780799 | instance | Tuesday 08 September 2026  15:37:20 +0000 (0:00:01.117)       0:00:27.618 *****
2026-09-08 15:37:21.147683 | instance | changed: [instance]
2026-09-08 15:37:21.147752 | instance |
2026-09-08 15:37:21.148009 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-08 15:37:21.148077 | instance | Tuesday 08 September 2026  15:37:21 +0000 (0:00:00.367)       0:00:27.986 *****
2026-09-08 15:37:21.675340 | instance | changed: [instance]
2026-09-08 15:37:21.676096 | instance |
2026-09-08 15:37:21.676165 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-08 15:37:21.676179 | instance | Tuesday 08 September 2026  15:37:21 +0000 (0:00:00.527)       0:00:28.513 *****
2026-09-08 15:37:22.264793 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-08 15:37:22.265096 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-08 15:37:22.265369 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-08 15:37:22.265627 | instance |
2026-09-08 15:37:22.265878 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-08 15:37:22.266160 | instance | Tuesday 08 September 2026  15:37:22 +0000 (0:00:00.588)       0:00:29.102 *****
2026-09-08 15:37:22.724206 | instance | changed: [instance]
2026-09-08 15:37:22.724413 | instance |
2026-09-08 15:37:22.724763 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-08 15:37:22.725025 | instance | Tuesday 08 September 2026  15:37:22 +0000 (0:00:00.460)       0:00:29.562 *****
2026-09-08 15:37:23.209475 | instance | changed: [instance]
2026-09-08 15:37:23.209587 | instance |
2026-09-08 15:37:23.209747 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-08 15:37:23.209891 | instance | Tuesday 08 September 2026  15:37:23 +0000 (0:00:00.468)       0:00:30.031 *****
2026-09-08 15:37:23.210030 | instance |
2026-09-08 15:37:23.210165 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-08 15:37:23.210306 | instance | Tuesday 08 September 2026  15:37:23 +0000 (0:00:00.016)       0:00:30.048 *****
2026-09-08 15:37:23.959013 | instance | ok: [instance]
2026-09-08 15:37:23.959269 | instance |
2026-09-08 15:37:23.959595 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-08 15:37:23.959859 | instance | Tuesday 08 September 2026  15:37:23 +0000 (0:00:00.747)       0:00:30.795 *****
2026-09-08 15:37:25.018046 | instance | changed: [instance]
2026-09-08 15:37:25.018120 | instance |
2026-09-08 15:37:25.018452 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-08 15:37:25.018492 | instance | Tuesday 08 September 2026  15:37:25 +0000 (0:00:01.061)       0:00:31.856 *****
2026-09-08 15:37:25.591254 | instance | changed: [instance]
2026-09-08 15:37:25.591335 | instance |
2026-09-08 15:37:25.591733 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-08 15:37:25.591772 | instance | Tuesday 08 September 2026  15:37:25 +0000 (0:00:00.573)       0:00:32.430 *****
2026-09-08 15:37:25.671832 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-08 15:37:25.672686 | instance |
2026-09-08 15:37:25.672745 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-08 15:37:25.672871 | instance | Tuesday 08 September 2026  15:37:25 +0000 (0:00:00.079)       0:00:32.510 *****
2026-09-08 15:37:31.026861 | instance | changed: [instance]
2026-09-08 15:37:31.027020 | instance |
2026-09-08 15:37:31.027028 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-08 15:37:31.027034 | instance | Tuesday 08 September 2026  15:37:31 +0000 (0:00:05.355)       0:00:37.865 *****
2026-09-08 15:37:31.683556 | instance | ok: [instance] => (item=chronyd)
2026-09-08 15:37:31.683611 | instance | ok: [instance] => (item=sshd)
2026-09-08 15:37:31.683623 | instance |
2026-09-08 15:37:31.683632 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-08 15:37:31.683642 | instance | Tuesday 08 September 2026  15:37:31 +0000 (0:00:00.655)       0:00:38.520 *****
2026-09-08 15:37:39.030358 | instance | changed: [instance]
2026-09-08 15:37:39.030434 | instance |
2026-09-08 15:37:39.030441 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-08 15:37:39.030449 | instance | Tuesday 08 September 2026  15:37:39 +0000 (0:00:07.347)       0:00:45.868 *****
2026-09-08 15:37:39.287226 | instance | ok: [instance]
2026-09-08 15:37:39.287306 | instance |
2026-09-08 15:37:39.287319 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-08 15:37:39.287329 | instance | Tuesday 08 September 2026  15:37:39 +0000 (0:00:00.255)       0:00:46.123 *****
2026-09-08 15:37:40.048263 | instance | changed: [instance]
2026-09-08 15:37:40.048648 | instance |
2026-09-08 15:37:40.049091 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-08 15:37:40.049411 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.762)       0:00:46.886 *****
2026-09-08 15:37:40.443266 | instance | changed: [instance]
2026-09-08 15:37:40.443398 | instance |
2026-09-08 15:37:40.443645 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-08 15:37:40.443733 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.395)       0:00:47.281 *****
2026-09-08 15:37:40.582624 | instance | ok: [instance]
2026-09-08 15:37:40.583429 | instance |
2026-09-08 15:37:40.583535 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-08 15:37:40.583547 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.138)       0:00:47.420 *****
2026-09-08 15:37:40.840053 | instance | ok: [instance] => (item=instance)
2026-09-08 15:37:40.840121 | instance |
2026-09-08 15:37:40.840133 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-08 15:37:40.840143 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.257)       0:00:47.677 *****
2026-09-08 15:37:40.891131 | instance | ok: [instance]
2026-09-08 15:37:40.891163 | instance |
2026-09-08 15:37:40.891170 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-08 15:37:40.891176 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.051)       0:00:47.729 *****
2026-09-08 15:37:40.971671 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-08 15:37:40.971714 | instance |
2026-09-08 15:37:40.971955 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-08 15:37:40.971970 | instance | Tuesday 08 September 2026  15:37:40 +0000 (0:00:00.081)       0:00:47.810 *****
2026-09-08 15:37:41.318896 | instance | changed: [instance]
2026-09-08 15:37:41.319686 | instance |
2026-09-08 15:37:41.319716 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-08 15:37:41.319727 | instance | Tuesday 08 September 2026  15:37:41 +0000 (0:00:00.346)       0:00:48.157 *****
2026-09-08 15:37:42.036388 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-08 15:37:42.037772 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-08 15:37:42.037838 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-08 15:37:42.037854 | instance |
2026-09-08 15:37:42.037868 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-08 15:37:42.037881 | instance | Tuesday 08 September 2026  15:37:42 +0000 (0:00:00.717)       0:00:48.874 *****
2026-09-08 15:39:13.274456 | instance | ok: [instance]
2026-09-08 15:39:13.274594 | instance |
2026-09-08 15:39:13.274758 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-08 15:39:13.274932 | instance | Tuesday 08 September 2026  15:39:13 +0000 (0:01:31.237)       0:02:20.111 *****
2026-09-08 15:39:13.518606 | instance | changed: [instance]
2026-09-08 15:39:13.518677 | instance |
2026-09-08 15:39:13.518804 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-08 15:39:13.518912 | instance | Tuesday 08 September 2026  15:39:13 +0000 (0:00:00.245)       0:02:20.357 *****
2026-09-08 15:39:13.600624 | instance | ok: [instance]
2026-09-08 15:39:13.600865 | instance |
2026-09-08 15:39:13.601094 | instance | TASK [Install Ceph host] *******************************************************
2026-09-08 15:39:13.601345 | instance | Tuesday 08 September 2026  15:39:13 +0000 (0:00:00.082)       0:02:20.439 *****
2026-09-08 15:39:13.664720 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-08 15:39:13.664936 | instance |
2026-09-08 15:39:13.665186 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-08 15:39:13.665416 | instance | Tuesday 08 September 2026  15:39:13 +0000 (0:00:00.064)       0:02:20.503 *****
2026-09-08 15:39:15.297853 | instance | ok: [instance]
2026-09-08 15:39:15.297956 | instance |
2026-09-08 15:39:15.298038 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-08 15:39:15.298147 | instance | Tuesday 08 September 2026  15:39:15 +0000 (0:00:01.632)       0:02:22.136 *****
2026-09-08 15:39:15.346467 | instance | ok: [instance] => (item=instance)
2026-09-08 15:39:15.346550 | instance |
2026-09-08 15:39:15.346664 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-08 15:39:15.346786 | instance | Tuesday 08 September 2026  15:39:15 +0000 (0:00:00.048)       0:02:22.185 *****
2026-09-08 15:39:15.747180 | instance | ok: [instance]
2026-09-08 15:39:15.747320 | instance |
2026-09-08 15:39:15.747472 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-08 15:39:15.747622 | instance | Tuesday 08 September 2026  15:39:15 +0000 (0:00:00.400)       0:02:22.585 *****
2026-09-08 15:39:17.873041 | instance | ok: [instance]
2026-09-08 15:39:17.873095 | instance |
2026-09-08 15:39:17.873107 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-08 15:39:17.873117 | instance | Tuesday 08 September 2026  15:39:17 +0000 (0:00:02.125)       0:02:24.710 *****
2026-09-08 15:40:02.362811 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-08 15:40:02.363674 | 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_ots0htub/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_ots0htub/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_ots0htub/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_ots0htub/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-08T15:40:02.216+0000 7feb2447b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3K6Bq09l9BiAAyie/G7sVMU2ql62FCFjz4n9xt20oXiKV9w1OYoHZytQ=: Malformed input [buffer:3]\n2026-09-08T15:40:02.216+0000 7feb2447b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:40:02.220+0000 7feb2447b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3K6Bq09l9BiAAyie/G7sVMU2ql62FCFjz4n9xt20oXiKV9w1OYoHZytQ=: Malformed input [buffer:3]\n2026-09-08T15:40:02.220+0000 7feb2447b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:40:02.220+0000 7feb2447b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3K6Bq09l9BiAAyie/G7sVMU2ql62FCFjz4n9xt20oXiKV9w1OYoHZytQ=: Malformed input [buffer:3]\n2026-09-08T15:40:02.220+0000 7feb2447b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-08T15:40:02.220+0000 7feb2447b640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-08 15:40:02.365475 | instance |
2026-09-08 15:40:02.365645 | instance | PLAY RECAP *********************************************************************
2026-09-08 15:40:02.368679 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-08 15:40:02.368730 | instance |
2026-09-08 15:40:02.368736 | instance | Tuesday 08 September 2026  15:40:02 +0000 (0:00:44.494)       0:03:09.204 *****
2026-09-08 15:40:02.368742 | instance | ===============================================================================
2026-09-08 15:40:02.368747 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 91.24s
2026-09-08 15:40:02.368752 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 44.49s
2026-09-08 15:40:02.368756 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 7.35s
2026-09-08 15:40:02.368760 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.77s
2026-09-08 15:40:02.368765 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.36s
2026-09-08 15:40:02.368769 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.31s
2026-09-08 15:40:02.368775 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.94s
2026-09-08 15:40:02.368779 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.13s
2026-09-08 15:40:02.368796 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.69s
2026-09-08 15:40:02.368800 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.68s
2026-09-08 15:40:02.368804 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.63s
2026-09-08 15:40:02.368808 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.12s
2026-09-08 15:40:02.368812 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.06s
2026-09-08 15:40:02.368817 | instance | Gathering Facts --------------------------------------------------------- 1.03s
2026-09-08 15:40:02.368820 | instance | Gathering Facts --------------------------------------------------------- 1.01s
2026-09-08 15:40:02.368825 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.97s
2026-09-08 15:40:02.368833 | instance | Gathering Facts --------------------------------------------------------- 0.94s
2026-09-08 15:40:02.368969 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.93s
2026-09-08 15:40:02.369118 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.84s
2026-09-08 15:40:02.369261 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-09-08 15:40:02.480948 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:40:02.481112 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-08 15:40:02.481253 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-08 15:40:02.655842 | instance | ERROR
2026-09-08 15:40:02.656105 | instance | {
2026-09-08 15:40:02.656164 | instance |   "delta": "0:04:02.375987",
2026-09-08 15:40:02.656205 | instance |   "end": "2026-09-08 15:40:02.543771",
2026-09-08 15:40:02.656240 | instance |   "msg": "non-zero return code",
2026-09-08 15:40:02.656274 | instance |   "rc": 2,
2026-09-08 15:40:02.656308 | instance |   "start": "2026-09-08 15:36:00.167784"
2026-09-08 15:40:02.656342 | instance | }
failure
2026-09-08 15:40:02.664758 | 
2026-09-08 15:40:02.664850 | PLAY RECAP
2026-09-08 15:40:02.664927 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-08 15:40:02.664969 | 
2026-09-08 15:40:02.780264 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-08 15:40:02.783505 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-08 15:40:03.359679 | 
2026-09-08 15:40:03.359783 | PLAY [all]
2026-09-08 15:40:03.372800 | 
2026-09-08 15:40:03.372881 | TASK [gather-host-logs : creating directory for system status]
2026-09-08 15:40:03.730070 | instance | changed
2026-09-08 15:40:03.740554 | 
2026-09-08 15:40:03.740718 | TASK [gather-host-logs : Get logs for each host]
2026-09-08 15:40:04.121646 | instance | + systemd-cgls --full --all --no-pager
2026-09-08 15:40:04.136477 | instance | + ip addr
2026-09-08 15:40:04.138462 | instance | + ip route
2026-09-08 15:40:04.140579 | instance | + lsblk
2026-09-08 15:40:04.143578 | instance | + mount
2026-09-08 15:40:04.146590 | instance | + docker images
2026-09-08 15:40:04.163577 | instance | + brctl show
2026-09-08 15:40:04.164179 | instance | /bin/bash: line 8: brctl: command not found
2026-09-08 15:40:04.164492 | instance | + ps aux --sort=-%mem
2026-09-08 15:40:04.183777 | instance | + dpkg -l
2026-09-08 15:40:04.195684 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-08 15:40:04.196144 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-08 15:40:04.212312 | instance | + '[' '!' -z '' ']'
2026-09-08 15:40:04.291385 | instance | ok: Runtime: 0:00:00.095780
2026-09-08 15:40:04.303991 | 
2026-09-08 15:40:04.304166 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-08 15:40:04.943895 | instance | changed:
2026-09-08 15:40:04.944083 | instance | created directory /var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/logs/instance
2026-09-08 15:40:04.944130 | instance | cd+++++++++ system/
2026-09-08 15:40:04.944160 | instance | >f+++++++++ system/brctl-show.txt
2026-09-08 15:40:04.944189 | instance | >f+++++++++ system/docker-images.txt
2026-09-08 15:40:04.944216 | instance | >f+++++++++ system/ip-addr.txt
2026-09-08 15:40:04.944245 | instance | >f+++++++++ system/ip-route.txt
2026-09-08 15:40:04.944284 | instance | >f+++++++++ system/lsblk.txt
2026-09-08 15:40:04.944317 | instance | >f+++++++++ system/mount.txt
2026-09-08 15:40:04.944345 | instance | >f+++++++++ system/packages.txt
2026-09-08 15:40:04.944370 | instance | >f+++++++++ system/ps.txt
2026-09-08 15:40:04.944399 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-08 15:40:04.956198 | 
2026-09-08 15:40:04.956294 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-08 15:40:05.151620 | instance | changed: "values"
2026-09-08 15:40:05.338220 | instance | changed: "releases"
2026-09-08 15:40:05.351620 | 
2026-09-08 15:40:05.352928 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-08 15:40:05.596416 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-08 15:40:05.906487 | instance | ok: Runtime: 0:00:00.005028
2026-09-08 15:40:05.913588 | 
2026-09-08 15:40:05.913692 | TASK [helm-release-status : Downloads logs to executor]
2026-09-08 15:40:06.436241 | instance | changed:
2026-09-08 15:40:06.436577 | instance | cd+++++++++ helm/
2026-09-08 15:40:06.436758 | instance | cd+++++++++ helm/releases/
2026-09-08 15:40:06.437149 | instance | cd+++++++++ helm/values/
2026-09-08 15:40:06.456197 | 
2026-09-08 15:40:06.456363 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-08 15:40:06.693639 | instance | changed
2026-09-08 15:40:06.713745 | 
2026-09-08 15:40:06.713854 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-08 15:40:06.962255 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:40:06.962762 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:40:06.967590 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:40:06.969045 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:40:06.969329 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:40:06.969992 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:40:06.972305 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:40:06.972460 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:40:06.973865 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:40:06.974077 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:40:06.976583 | instance | environment: line 1: kubectl: command not found
2026-09-08 15:40:06.977437 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-08 15:40:07.253539 | instance | ok: Runtime: 0:00:00.021477
2026-09-08 15:40:07.269830 | 
2026-09-08 15:40:07.270321 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-08 15:40:07.468664 | instance | changed
2026-09-08 15:40:07.479077 | 
2026-09-08 15:40:07.479241 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-08 15:40:07.724979 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:40:07.725053 | instance | environment: line 5: kubectl: command not found
2026-09-08 15:40:07.725069 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:40:07.725661 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-08 15:40:08.027616 | instance | ok: Runtime: 0:00:00.005504
2026-09-08 15:40:08.038705 | 
2026-09-08 15:40:08.038844 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-08 15:40:08.570077 | instance | changed:
2026-09-08 15:40:08.574517 | instance | cd+++++++++ objects/
2026-09-08 15:40:08.574624 | instance | cd+++++++++ objects/cluster/
2026-09-08 15:40:08.574685 | instance | cd+++++++++ objects/namespaced/
2026-09-08 15:40:08.592532 | 
2026-09-08 15:40:08.592692 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-08 15:40:08.818642 | instance | changed
2026-09-08 15:40:08.827851 | 
2026-09-08 15:40:08.827978 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-08 15:40:09.047132 | instance | changed
2026-09-08 15:40:09.057367 | 
2026-09-08 15:40:09.057549 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-08 15:40:09.306846 | instance | environment: line 3: kubectl: command not found
2026-09-08 15:40:09.606398 | instance | ok: Runtime: 0:00:00.007775
2026-09-08 15:40:09.616880 | 
2026-09-08 15:40:09.617031 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-08 15:40:10.107493 | instance | changed:
2026-09-08 15:40:10.107785 | instance | cd+++++++++ pod-logs/
2026-09-08 15:40:10.107841 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-08 15:40:10.126211 | 
2026-09-08 15:40:10.126351 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-08 15:40:10.324649 | instance | changed
2026-09-08 15:40:10.335895 | 
2026-09-08 15:40:10.336091 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-08 15:40:10.566886 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-08 15:40:10.883971 | instance | ok: Runtime: 0:00:00.052406
2026-09-08 15:40:10.893460 | 
2026-09-08 15:40:10.893604 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-08 15:40:11.121792 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-08 15:40:11.155374 | instance | ceph-mgr endpoints:
2026-09-08 15:40:11.441576 | instance | ok: Runtime: 0:00:00.037898
2026-09-08 15:40:11.449923 | 
2026-09-08 15:40:11.450055 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-08 15:40:11.663160 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-08 15:40:11.985395 | instance | ok: Runtime: 0:00:00.047298
2026-09-08 15:40:11.995467 | 
2026-09-08 15:40:11.995614 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-08 15:40:12.536323 | instance | changed: cd+++++++++ prometheus/
2026-09-08 15:40:12.550168 | 
2026-09-08 15:40:12.550288 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-08 15:40:12.763794 | instance | changed
2026-09-08 15:40:12.771484 | 
2026-09-08 15:40:12.771593 | TASK [gather-selenium-data : Get selenium data]
2026-09-08 15:40:13.063727 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-08 15:40:13.064565 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-08 15:40:13.304723 | instance | ERROR
2026-09-08 15:40:13.305118 | instance | {
2026-09-08 15:40:13.305169 | instance |   "delta": "0:00:00.003585",
2026-09-08 15:40:13.305198 | instance |   "end": "2026-09-08 15:40:13.064796",
2026-09-08 15:40:13.305226 | instance |   "msg": "non-zero return code",
2026-09-08 15:40:13.305249 | instance |   "rc": 1,
2026-09-08 15:40:13.305273 | instance |   "start": "2026-09-08 15:40:13.061211"
2026-09-08 15:40:13.305391 | instance | }
2026-09-08 15:40:13.305558 | instance | ERROR: Ignoring Errors
2026-09-08 15:40:13.315283 | 
2026-09-08 15:40:13.315470 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-08 15:40:13.817820 | instance | changed: cd+++++++++ selenium/
2026-09-08 15:40:13.824860 | 
2026-09-08 15:40:13.824921 | PLAY RECAP
2026-09-08 15:40:13.824982 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-08 15:40:13.825018 | 
2026-09-08 15:40:13.987019 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-08 15:40:14.081690 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-08 15:40:14.680880 | 
2026-09-08 15:40:14.680989 | PLAY [all]
2026-09-08 15:40:14.691298 | 
2026-09-08 15:40:14.691380 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-08 15:40:14.745729 | instance | skipping: Conditional result was False
2026-09-08 15:40:14.752036 | 
2026-09-08 15:40:14.756286 | TASK [fetch-output : Set log path for single node]
2026-09-08 15:40:14.798032 | instance | ok
2026-09-08 15:40:14.843066 | 
2026-09-08 15:40:14.843224 | LOOP [fetch-output : Ensure local output dirs]
2026-09-08 15:40:15.273111 | instance -> localhost | ok: "/var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/logs"
2026-09-08 15:40:15.499173 | instance -> localhost | changed: "/var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/artifacts"
2026-09-08 15:40:15.777176 | instance -> localhost | changed: "/var/lib/zuul/builds/132f44367fa1434a89caa1e1e3969fc7/work/docs"
2026-09-08 15:40:15.794236 | 
2026-09-08 15:40:15.804091 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-08 15:40:16.436420 | instance | changed: .d..t...... ./
2026-09-08 15:40:16.436699 | instance | changed: All items complete
2026-09-08 15:40:16.436739 | 
2026-09-08 15:40:16.894921 | instance | changed: .d..t...... ./
2026-09-08 15:40:17.414082 | instance | changed: .d..t...... ./
2026-09-08 15:40:17.466588 | 
2026-09-08 15:40:17.466693 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-08 15:40:17.877893 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.004337
2026-09-08 15:40:18.180891 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006906
2026-09-08 15:40:18.198278 | 
2026-09-08 15:40:18.199693 | PLAY [all]
2026-09-08 15:40:18.206390 | 
2026-09-08 15:40:18.206483 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-08 15:40:18.656278 | instance | changed
2026-09-08 15:40:18.663248 | 
2026-09-08 15:40:18.663342 | PLAY RECAP
2026-09-08 15:40:18.663396 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-08 15:40:18.663424 | 
2026-09-08 15:40:18.785132 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-08 15:40:18.786909 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-08 15:40:19.360302 | 
2026-09-08 15:40:19.360485 | PLAY [localhost]
2026-09-08 15:40:19.374152 | 
2026-09-08 15:40:19.374296 | TASK [Generate Zuul manifest]
2026-09-08 15:40:19.394004 | localhost | ok
2026-09-08 15:40:19.419335 | 
2026-09-08 15:40:19.419731 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-08 15:40:20.040653 | localhost | changed
2026-09-08 15:40:20.059847 | 
2026-09-08 15:40:20.060037 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-08 15:40:20.102572 | localhost | ok
2026-09-08 15:40:20.112906 | 
2026-09-08 15:40:20.113032 | TASK [Upload logs]
2026-09-08 15:40:20.132873 | localhost | ok
2026-09-08 15:40:20.192914 | 
2026-09-08 15:40:20.193021 | TASK [Set zuul-log-path fact]
2026-09-08 15:40:20.208316 | localhost | ok
2026-09-08 15:40:20.294492 | 
2026-09-08 15:40:20.294687 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-08 15:40:20.322797 | localhost | ok
2026-09-08 15:40:20.331100 | 
2026-09-08 15:40:20.331199 | TASK [upload-logs : Create log directories]
2026-09-08 15:40:20.784519 | localhost | changed
2026-09-08 15:40:20.793770 | 
2026-09-08 15:40:20.793907 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-08 15:40:21.241114 | localhost -> localhost | ok: Runtime: 0:00:00.006758
2026-09-08 15:40:21.250646 | 
2026-09-08 15:40:21.250784 | TASK [upload-logs : Upload logs to log server]
2026-09-08 15:40:21.790635 | localhost | Output suppressed because no_log was given
2026-09-08 15:40:21.841429 | 
2026-09-08 15:40:21.841593 | LOOP [upload-logs : Compress console log and json output]
2026-09-08 15:40:21.903413 | localhost | skipping: Conditional result was False
2026-09-08 15:40:21.914324 | localhost | skipping: Conditional result was False
2026-09-08 15:40:21.921879 | 
2026-09-08 15:40:21.922003 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-08 15:40:21.959949 | localhost | skipping: Conditional result was False
2026-09-08 15:40:21.960176 | 
2026-09-08 15:40:21.964402 | localhost | skipping: Conditional result was False
2026-09-08 15:40:21.973276 | 
2026-09-08 15:40:21.973414 | LOOP [upload-logs : Upload console log and json output]