2026-08-22 14:29:24.203545 | Job console starting
2026-08-22 14:29:24.215830 | Updating git repos
2026-08-22 14:29:30.725213 | Cloning repos into workspace
2026-08-22 14:30:48.720493 | Restoring repo states
2026-08-22 14:30:54.922074 | Merging changes
2026-08-22 14:30:59.310440 | Checking out repos
2026-08-22 14:31:21.892663 | Preparing playbooks
2026-08-22 14:31:54.353867 | Running Ansible setup
2026-08-22 14:31:58.172197 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 14:31:58.838126 | 
2026-08-22 14:31:59.069058 | PLAY [localhost]
2026-08-22 14:31:59.085555 | 
2026-08-22 14:31:59.085746 | TASK [Gathering Facts]
2026-08-22 14:32:00.228131 | localhost | ok
2026-08-22 14:32:00.237633 | 
2026-08-22 14:32:00.237740 | TASK [Setup log path fact]
2026-08-22 14:32:00.260451 | localhost | ok
2026-08-22 14:32:00.272755 | 
2026-08-22 14:32:00.272825 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 14:32:00.303639 | localhost | ok
2026-08-22 14:32:00.312695 | 
2026-08-22 14:32:00.312798 | TASK [emit-job-header : Print job information]
2026-08-22 14:32:00.356126 | # Job Information
2026-08-22 14:32:00.356355 | Ansible Version: 2.16.18
2026-08-22 14:32:00.356401 | Job: atmosphere-molecule-csi-rbd
2026-08-22 14:32:00.356432 | Pipeline: check
2026-08-22 14:32:00.356460 | Executor: 2d72f0692154
2026-08-22 14:32:00.356487 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-08-22 14:32:00.356520 | Event ID: f8ef8210-9e34-11f1-962c-0ffc174bafca
2026-08-22 14:32:00.360980 | 
2026-08-22 14:32:00.361084 | LOOP [emit-job-header : Print node information]
2026-08-22 14:32:00.477545 | localhost | ok:
2026-08-22 14:32:00.477791 | localhost | # Node Information
2026-08-22 14:32:00.477823 | localhost | Inventory Hostname: instance
2026-08-22 14:32:00.477871 | localhost | Hostname: np0000190637
2026-08-22 14:32:00.477914 | localhost | Username: zuul
2026-08-22 14:32:00.477947 | localhost | Distro: Ubuntu 22.04
2026-08-22 14:32:00.477968 | localhost | Provider: yul1
2026-08-22 14:32:00.477988 | localhost | Region: ca-ymq-1
2026-08-22 14:32:00.478028 | localhost | Label: ubuntu-jammy
2026-08-22 14:32:00.478051 | localhost | Product Name: OpenStack Nova
2026-08-22 14:32:00.478094 | localhost | Interface IP: 199.204.45.109
2026-08-22 14:32:00.490452 | 
2026-08-22 14:32:00.490630 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 14:32:00.973303 | localhost -> localhost | changed
2026-08-22 14:32:00.981531 | 
2026-08-22 14:32:00.981628 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 14:32:05.131746 | localhost -> localhost | changed
2026-08-22 14:32:05.147062 | 
2026-08-22 14:32:05.147242 | PLAY [all]
2026-08-22 14:32:05.160702 | 
2026-08-22 14:32:05.160846 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 14:32:05.421102 | instance -> localhost | ok
2026-08-22 14:32:05.434441 | 
2026-08-22 14:32:05.434608 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 14:32:05.468183 | instance | ok
2026-08-22 14:32:05.490007 | instance | included: /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 14:32:05.497494 | 
2026-08-22 14:32:05.497626 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 14:32:06.575196 | instance -> localhost | Generating public/private rsa key pair.
2026-08-22 14:32:06.575466 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/40d22de5fc1c4da5bf591ccca3eee35a_id_rsa
2026-08-22 14:32:06.575508 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/40d22de5fc1c4da5bf591ccca3eee35a_id_rsa.pub
2026-08-22 14:32:06.575537 | instance -> localhost | The key fingerprint is:
2026-08-22 14:32:06.575563 | instance -> localhost | SHA256:AUMZwOu99vY2+38Ndpg5y0xQ9Q5IF0HuxNJS68Rkb8c zuul-build-sshkey
2026-08-22 14:32:06.575604 | instance -> localhost | The key's randomart image is:
2026-08-22 14:32:06.575630 | instance -> localhost | +---[RSA 3072]----+
2026-08-22 14:32:06.575666 | instance -> localhost | |   ..o=o    ..O+.|
2026-08-22 14:32:06.575709 | instance -> localhost | |    . .o   . @.+.|
2026-08-22 14:32:06.575737 | instance -> localhost | |     .  .   +.X E|
2026-08-22 14:32:06.575761 | instance -> localhost | |    .    .  .B +.|
2026-08-22 14:32:06.575785 | instance -> localhost | |   . .  S    .o+.|
2026-08-22 14:32:06.575809 | instance -> localhost | |    . .       O .|
2026-08-22 14:32:06.575832 | instance -> localhost | |       .     = =.|
2026-08-22 14:32:06.575855 | instance -> localhost | |      o . o   + o|
2026-08-22 14:32:06.575882 | instance -> localhost | |     . o.oo+.... |
2026-08-22 14:32:06.575906 | instance -> localhost | +----[SHA256]-----+
2026-08-22 14:32:06.575971 | instance -> localhost | ok: Runtime: 0:00:00.637934
2026-08-22 14:32:06.590556 | 
2026-08-22 14:32:06.590694 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 14:32:06.626843 | instance | ok
2026-08-22 14:32:06.637234 | instance | included: /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 14:32:06.645338 | 
2026-08-22 14:32:06.645409 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 14:32:06.670313 | instance | skipping: Conditional result was False
2026-08-22 14:32:06.683480 | 
2026-08-22 14:32:06.683640 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 14:32:07.170926 | instance | changed
2026-08-22 14:32:07.765719 | 
2026-08-22 14:32:07.765863 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 14:32:07.936885 | instance | ok
2026-08-22 14:32:07.942894 | 
2026-08-22 14:32:07.942971 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 14:32:08.438302 | instance | changed
2026-08-22 14:32:08.443726 | 
2026-08-22 14:32:08.443798 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 14:32:08.904254 | instance | changed
2026-08-22 14:32:08.913372 | 
2026-08-22 14:32:08.913460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 14:32:08.939051 | instance | skipping: Conditional result was False
2026-08-22 14:32:08.946160 | 
2026-08-22 14:32:08.946944 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 14:32:09.714127 | instance -> localhost | changed
2026-08-22 14:32:09.739556 | 
2026-08-22 14:32:09.739724 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 14:32:10.104011 | instance -> localhost | Identity added: /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/40d22de5fc1c4da5bf591ccca3eee35a_id_rsa (zuul-build-sshkey)
2026-08-22 14:32:10.104329 | instance -> localhost | ok: Runtime: 0:00:00.014045
2026-08-22 14:32:10.109357 | 
2026-08-22 14:32:10.109422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 14:32:10.453581 | instance | ok
2026-08-22 14:32:10.688722 | 
2026-08-22 14:32:10.688864 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 14:32:10.718513 | instance | skipping: Conditional result was False
2026-08-22 14:32:10.733391 | 
2026-08-22 14:32:10.733538 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 14:32:11.076402 | instance | ok
2026-08-22 14:32:11.085544 | 
2026-08-22 14:32:11.085615 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 14:32:18.854714 | instance | Output suppressed because no_log was given
2026-08-22 14:32:18.867695 | 
2026-08-22 14:32:18.867811 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 14:32:19.076538 | instance | ok: "logs"
2026-08-22 14:32:19.076924 | instance | ok: All items complete
2026-08-22 14:32:19.077020 | 
2026-08-22 14:32:19.228622 | instance | ok: "artifacts"
2026-08-22 14:32:19.379162 | instance | ok: "docs"
2026-08-22 14:32:19.402940 | 
2026-08-22 14:32:19.403099 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 14:32:19.605204 | instance | changed: "logs"
2026-08-22 14:32:19.758970 | instance | changed: "artifacts"
2026-08-22 14:32:19.934224 | instance | changed: "docs"
2026-08-22 14:32:19.953886 | 
2026-08-22 14:32:19.954042 | PLAY RECAP
2026-08-22 14:32:19.954144 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 14:32:19.954210 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 14:32:19.954259 | 
2026-08-22 14:32:20.194069 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 14:32:20.211157 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 14:32:20.860858 | 
2026-08-22 14:32:20.861028 | PLAY [all]
2026-08-22 14:32:20.872403 | 
2026-08-22 14:32:20.872480 | TASK [setup-uv : Extract archive]
2026-08-22 14:32:23.106127 | instance | changed
2026-08-22 14:32:25.810118 | 
2026-08-22 14:32:25.810314 | TASK [setup-uv : Print version]
2026-08-22 14:32:26.220155 | instance | uv 0.8.13
2026-08-22 14:32:26.363913 | instance | ok: Runtime: 0:00:00.013884
2026-08-22 14:32:26.375368 | 
2026-08-22 14:32:26.375438 | TASK [Install Ansible collection siblings]
2026-08-22 14:32:36.085233 | instance | changed:
2026-08-22 14:32:36.085401 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 14:32:36.085431 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 14:32:36.085454 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 14:32:36.085474 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 14:32:36.085495 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 14:32:36.085520 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 14:32:36.085541 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 14:32:36.085564 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 14:32:36.085584 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 14:32:36.085604 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 14:32:36.085624 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 14:32:36.085643 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 14:32:36.085662 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-22 14:32:36.085681 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-22 14:32:36.085700 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-22 14:32:36.085719 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-22 14:32:36.085738 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-22 14:32:36.085757 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-22 14:32:36.085776 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-22 14:32:36.085795 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-22 14:32:36.085814 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-22 14:32:36.085832 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-22 14:32:36.085853 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 14:32:36.085890 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-22 14:32:36.085910 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-22 14:32:36.085929 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 14:32:36.085948 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 14:32:36.085970 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 14:32:36.085990 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-22 14:32:36.086009 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-22 14:32:36.086028 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 14:32:36.086047 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 14:32:36.086066 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-22 14:32:36.086086 | 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-22 14:32:36.086111 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.086131 | instance | Process install dependency map
2026-08-22 14:32:36.086149 | instance | Starting collection install process
2026-08-22 14:32:36.086168 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-22 14:32:36.086187 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-22 14:32:36.086205 | instance | ansible.netcommon:* was installed successfully
2026-08-22 14:32:36.086223 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-22 14:32:36.086242 | instance | Creating virtual environment at: .venv
2026-08-22 14:32:36.086260 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 14:32:36.086278 | instance | Downloading kubernetes (1.9MiB)
2026-08-22 14:32:36.086297 | instance | Downloading ansible-core (2.1MiB)
2026-08-22 14:32:36.086318 | instance | Downloading rjsonnet (1.2MiB)
2026-08-22 14:32:36.086338 | instance | Downloading netaddr (2.2MiB)
2026-08-22 14:32:36.086356 | instance | Downloading pygments (1.2MiB)
2026-08-22 14:32:36.086374 | instance | Downloading cryptography (4.2MiB)
2026-08-22 14:32:36.086392 | instance | Downloading openstacksdk (1.7MiB)
2026-08-22 14:32:36.086411 | instance | Downloading setuptools (1.1MiB)
2026-08-22 14:32:36.086429 | instance |  Downloading rjsonnet
2026-08-22 14:32:36.086448 | instance |    Building pyperclip==1.9.0
2026-08-22 14:32:36.086468 | instance |  Downloading netaddr
2026-08-22 14:32:36.086487 | instance |  Downloading pygments
2026-08-22 14:32:36.086506 | instance |  Downloading cryptography
2026-08-22 14:32:36.086525 | instance |  Downloading setuptools
2026-08-22 14:32:36.086543 | instance |  Downloading kubernetes
2026-08-22 14:32:36.086561 | instance |  Downloading ansible-core
2026-08-22 14:32:36.086579 | instance |  Downloading openstacksdk
2026-08-22 14:32:36.086597 | instance |       Built pyperclip==1.9.0
2026-08-22 14:32:36.086616 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 14:32:36.086634 | instance | Installed 79 packages in 62ms
2026-08-22 14:32:36.086653 | instance | Checked out ansible.posix to 1.6.0
2026-08-22 14:32:36.086672 | 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-22 14:32:36.086690 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.086709 | instance | Process install dependency map
2026-08-22 14:32:36.086727 | instance | Starting collection install process
2026-08-22 14:32:36.086746 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-22 14:32:36.086770 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-22 14:32:36.086789 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-22 14:32:36.086809 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.086827 | instance | 2.17.12
2026-08-22 14:32:36.086845 | instance | Checked out ansible.utils to v6.1.0
2026-08-22 14:32:36.086864 | 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-22 14:32:36.086883 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.086901 | instance | Process install dependency map
2026-08-22 14:32:36.086919 | instance | Starting collection install process
2026-08-22 14:32:36.086938 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-22 14:32:36.086956 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-22 14:32:36.086975 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-22 14:32:36.086993 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087012 | instance | 2.17.12
2026-08-22 14:32:36.087031 | instance | Checked out atmosphere.common to v0.7.0
2026-08-22 14:32:36.087050 | 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-22 14:32:36.087068 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.087086 | instance | Process install dependency map
2026-08-22 14:32:36.087105 | instance | Starting collection install process
2026-08-22 14:32:36.087123 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-22 14:32:36.087141 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-22 14:32:36.087159 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-22 14:32:36.087178 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087197 | instance | 2.17.12
2026-08-22 14:32:36.087215 | instance | Checked out community.crypto to 2.2.3
2026-08-22 14:32:36.087234 | 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-22 14:32:36.087253 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.087272 | instance | Process install dependency map
2026-08-22 14:32:36.087290 | instance | Starting collection install process
2026-08-22 14:32:36.087309 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-22 14:32:36.087327 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-22 14:32:36.087345 | instance | community.crypto:2.2.3 was installed successfully
2026-08-22 14:32:36.087364 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087382 | instance | 2.17.12
2026-08-22 14:32:36.087400 | instance | Checked out community.general to 7.3.0
2026-08-22 14:32:36.087419 | 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-22 14:32:36.087437 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.087460 | instance | Process install dependency map
2026-08-22 14:32:36.087479 | instance | Starting collection install process
2026-08-22 14:32:36.087497 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-22 14:32:36.087515 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-22 14:32:36.087534 | instance | community.general:7.3.0 was installed successfully
2026-08-22 14:32:36.087552 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087571 | instance | 2.17.12
2026-08-22 14:32:36.087590 | instance | Checked out community.mysql to 3.6.0
2026-08-22 14:32:36.087609 | 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-22 14:32:36.087628 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.087648 | instance | Process install dependency map
2026-08-22 14:32:36.087667 | instance | Starting collection install process
2026-08-22 14:32:36.087686 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-22 14:32:36.087705 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-22 14:32:36.087724 | instance | community.mysql:3.6.0 was installed successfully
2026-08-22 14:32:36.087742 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087760 | instance | 2.17.12
2026-08-22 14:32:36.087779 | instance | Checked out kubernetes.core to 2.4.0
2026-08-22 14:32:36.087797 | 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-22 14:32:36.087816 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.087834 | instance | Process install dependency map
2026-08-22 14:32:36.087852 | instance | Starting collection install process
2026-08-22 14:32:36.087871 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-22 14:32:36.087889 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-22 14:32:36.087908 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-22 14:32:36.087927 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.087945 | instance | 2.17.12
2026-08-22 14:32:36.087964 | instance | Checked out openstack.cloud to 2.6.0
2026-08-22 14:32:36.087982 | 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-22 14:32:36.088001 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.088019 | instance | Process install dependency map
2026-08-22 14:32:36.088038 | instance | Starting collection install process
2026-08-22 14:32:36.088056 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-22 14:32:36.088074 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-22 14:32:36.088092 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-22 14:32:36.088110 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.088128 | instance | 2.17.12
2026-08-22 14:32:36.088147 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-22 14:32:36.088165 | 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-22 14:32:36.088187 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.088207 | instance | Process install dependency map
2026-08-22 14:32:36.088225 | instance | Starting collection install process
2026-08-22 14:32:36.088244 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-22 14:32:36.088262 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-22 14:32:36.088280 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-22 14:32:36.088298 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.088316 | instance | 2.17.12
2026-08-22 14:32:36.088334 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-22 14:32:36.088353 | 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-22 14:32:36.088371 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.088389 | instance | Process install dependency map
2026-08-22 14:32:36.088407 | instance | Starting collection install process
2026-08-22 14:32:36.088426 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-22 14:32:36.088482 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-22 14:32:36.088505 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-22 14:32:36.088524 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.088543 | instance | 2.17.12
2026-08-22 14:32:36.088562 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-22 14:32:36.088580 | 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-22 14:32:36.088599 | instance | Starting galaxy collection install process
2026-08-22 14:32:36.088617 | instance | Process install dependency map
2026-08-22 14:32:36.088635 | instance | Starting collection install process
2026-08-22 14:32:36.088654 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-22 14:32:36.088672 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-22 14:32:36.088691 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-22 14:32:36.088710 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 14:32:36.088727 | instance | 2.17.12
2026-08-22 14:32:36.095081 | 
2026-08-22 14:32:36.095129 | PLAY RECAP
2026-08-22 14:32:36.095175 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 14:32:36.095197 | 
2026-08-22 14:32:36.298133 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 14:32:36.419076 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 14:32:37.049823 | 
2026-08-22 14:32:37.049958 | PLAY [all]
2026-08-22 14:32:37.060907 | 
2026-08-22 14:32:37.061000 | TASK [Install "jq" for log collection]
2026-08-22 14:32:47.728793 | instance | changed
2026-08-22 14:32:47.732322 | 
2026-08-22 14:32:47.732478 | PLAY RECAP
2026-08-22 14:32:47.732665 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 14:32:47.732806 | 
2026-08-22 14:32:47.951334 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 14:32:49.248676 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 14:32:49.950015 | 
2026-08-22 14:32:49.950478 | PLAY [all]
2026-08-22 14:32:49.961870 | 
2026-08-22 14:32:49.961947 | LOOP [Check inventory directories]
2026-08-22 14:32:50.353661 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-22 14:32:50.506106 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-22 14:32:50.658904 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-22 14:32:50.670298 | 
2026-08-22 14:32:50.670504 | LOOP [Copy inventory file for Zuul]
2026-08-22 14:32:51.486558 | instance | changed:
2026-08-22 14:32:51.486785 | instance | {
2026-08-22 14:32:51.486825 | instance |   "ansible_loop_var": "item",
2026-08-22 14:32:51.486859 | instance |   "changed": false,
2026-08-22 14:32:51.486914 | instance |   "failed": false,
2026-08-22 14:32:51.486952 | instance |   "invocation": {
2026-08-22 14:32:51.486980 | instance |     "module_args": {
2026-08-22 14:32:51.487007 | instance |       "checksum_algorithm": "sha1",
2026-08-22 14:32:51.487033 | instance |       "follow": true,
2026-08-22 14:32:51.487059 | instance |       "get_attributes": true,
2026-08-22 14:32:51.487087 | instance |       "get_checksum": true,
2026-08-22 14:32:51.487113 | instance |       "get_mime": true,
2026-08-22 14:32:51.487139 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-22 14:32:51.487165 | instance |     }
2026-08-22 14:32:51.487190 | instance |   },
2026-08-22 14:32:51.487215 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-22 14:32:51.487240 | instance |   "stat": {
2026-08-22 14:32:51.487265 | instance |     "atime": 1787409148.9366086,
2026-08-22 14:32:51.487291 | instance |     "attr_flags": "e",
2026-08-22 14:32:51.487316 | instance |     "attributes": [
2026-08-22 14:32:51.487342 | instance |       "extents"
2026-08-22 14:32:51.487366 | instance |     ],
2026-08-22 14:32:51.487391 | instance |     "block_size": 4096,
2026-08-22 14:32:51.487415 | instance |     "blocks": 8,
2026-08-22 14:32:51.487440 | instance |     "charset": "unknown",
2026-08-22 14:32:51.487469 | instance |     "ctime": 1787409147.612586,
2026-08-22 14:32:51.487497 | instance |     "dev": 64513,
2026-08-22 14:32:51.487523 | instance |     "device_type": 0,
2026-08-22 14:32:51.487548 | instance |     "executable": true,
2026-08-22 14:32:51.487572 | instance |     "exists": true,
2026-08-22 14:32:51.487597 | instance |     "gid": 1000,
2026-08-22 14:32:51.487622 | instance |     "gr_name": "zuul",
2026-08-22 14:32:51.487647 | instance |     "inode": 1048527,
2026-08-22 14:32:51.487672 | instance |     "isblk": false,
2026-08-22 14:32:51.487697 | instance |     "ischr": false,
2026-08-22 14:32:51.487723 | instance |     "isdir": true,
2026-08-22 14:32:51.487747 | instance |     "isfifo": false,
2026-08-22 14:32:51.487772 | instance |     "isgid": false,
2026-08-22 14:32:51.487796 | instance |     "islnk": false,
2026-08-22 14:32:51.487821 | instance |     "isreg": false,
2026-08-22 14:32:51.487845 | instance |     "issock": false,
2026-08-22 14:32:51.487870 | instance |     "isuid": false,
2026-08-22 14:32:51.487893 | instance |     "mimetype": "unknown",
2026-08-22 14:32:51.487918 | instance |     "mode": "0755",
2026-08-22 14:32:51.487942 | instance |     "mtime": 1787409147.612586,
2026-08-22 14:32:51.487966 | instance |     "nlink": 22,
2026-08-22 14:32:51.487990 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-22 14:32:51.488016 | instance |     "pw_name": "zuul",
2026-08-22 14:32:51.488045 | instance |     "readable": true,
2026-08-22 14:32:51.488071 | instance |     "rgrp": true,
2026-08-22 14:32:51.488096 | instance |     "roth": true,
2026-08-22 14:32:51.488123 | instance |     "rusr": true,
2026-08-22 14:32:51.488148 | instance |     "size": 4096,
2026-08-22 14:32:51.488174 | instance |     "uid": 1000,
2026-08-22 14:32:51.488216 | instance |     "version": "2219103903",
2026-08-22 14:32:51.488242 | instance |     "wgrp": false,
2026-08-22 14:32:51.488269 | instance |     "woth": false,
2026-08-22 14:32:51.488294 | instance |     "writeable": true,
2026-08-22 14:32:51.488320 | instance |     "wusr": true,
2026-08-22 14:32:51.488346 | instance |     "xgrp": true,
2026-08-22 14:32:51.488370 | instance |     "xoth": true,
2026-08-22 14:32:51.488395 | instance |     "xusr": true
2026-08-22 14:32:51.488421 | instance |   }
2026-08-22 14:32:51.488446 | instance | }
2026-08-22 14:32:51.488494 | instance | ok: All items complete
2026-08-22 14:32:51.488525 | 
2026-08-22 14:32:51.490227 | instance | skipping: Conditional result was False
2026-08-22 14:32:51.491091 | instance | skipping: Conditional result was False
2026-08-22 14:32:51.517067 | 
2026-08-22 14:32:51.525859 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 14:32:51.886330 | instance | changed: 1 replacements made
2026-08-22 14:32:52.005632 | instance | skipping: Conditional result was False
2026-08-22 14:32:52.006658 | instance | skipping: Conditional result was False
2026-08-22 14:32:52.029695 | 
2026-08-22 14:32:52.029907 | TASK [Run Molecule scenario]
2026-08-22 14:32:53.084919 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-22 14:32:53.458051 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 14:32:53.458128 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-22 14:33:04.823878 | instance | INFO     [csi > dependency] Executing
2026-08-22 14:33:04.824104 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-22 14:33:04.824467 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-22 14:33:04.824616 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 14:33:04.833194 | instance | INFO     [csi > cleanup] Executing
2026-08-22 14:33:04.833470 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 14:33:04.841062 | instance | INFO     [csi > destroy] Executing
2026-08-22 14:33:04.841103 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-22 14:33:04.841168 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-22 14:33:05.494208 | instance | INFO     [csi > syntax] Executing
2026-08-22 14:33:07.092785 | instance |
2026-08-22 14:33:07.093076 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 14:33:07.150798 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-22 14:33:07.162414 | instance | INFO     [csi > create] Executing
2026-08-22 14:33:07.164155 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 14:33:07.171409 | instance | INFO     [csi > prepare] Executing
2026-08-22 14:33:08.104679 | instance |
2026-08-22 14:33:08.105046 | instance | PLAY [Prepare] *****************************************************************
2026-08-22 14:33:08.105312 | instance |
2026-08-22 14:33:08.105597 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 14:33:08.105872 | instance | Saturday 22 August 2026  14:33:08 +0000 (0:00:00.026)       0:00:00.026 *******
2026-08-22 14:33:09.288164 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 14:33:09.288458 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 14:33:09.288794 | instance | interpreter could change the meaning of that path. See
2026-08-22 14:33:09.289146 | instance | https://docs.ansible.com/ansible-
2026-08-22 14:33:09.289452 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 14:33:09.296100 | instance | ok: [instance]
2026-08-22 14:33:09.296375 | instance |
2026-08-22 14:33:09.296663 | instance | TASK [Configure short hostname] ************************************************
2026-08-22 14:33:09.297031 | instance | Saturday 22 August 2026  14:33:09 +0000 (0:00:01.191)       0:00:01.218 *******
2026-08-22 14:33:09.958351 | instance | changed: [instance]
2026-08-22 14:33:09.958474 | instance |
2026-08-22 14:33:09.958655 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-22 14:33:09.958841 | instance | Saturday 22 August 2026  14:33:09 +0000 (0:00:00.662)       0:00:01.880 *******
2026-08-22 14:33:10.206199 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-22 14:33:10.206502 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-22 14:33:10.206792 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-22 14:33:10.214143 | instance | changed: [instance]
2026-08-22 14:33:10.214503 | instance |
2026-08-22 14:33:10.214797 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-22 14:33:10.215139 | instance | Saturday 22 August 2026  14:33:10 +0000 (0:00:00.255)       0:00:02.136 *******
2026-08-22 14:33:11.035590 | instance | ok: [instance]
2026-08-22 14:33:11.035840 | instance |
2026-08-22 14:33:11.036129 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-22 14:33:11.036397 | instance |
2026-08-22 14:33:11.036678 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 14:33:11.037000 | instance | Saturday 22 August 2026  14:33:11 +0000 (0:00:00.821)       0:00:02.957 *******
2026-08-22 14:33:11.694365 | instance | ok: [instance]
2026-08-22 14:33:11.694601 | instance |
2026-08-22 14:33:11.694888 | instance | TASK [Install depedencies] *****************************************************
2026-08-22 14:33:11.695174 | instance | Saturday 22 August 2026  14:33:11 +0000 (0:00:00.658)       0:00:03.616 *******
2026-08-22 14:33:36.778442 | instance | changed: [instance]
2026-08-22 14:33:36.778726 | instance |
2026-08-22 14:33:36.778996 | instance | TASK [Start up service] ********************************************************
2026-08-22 14:33:36.779271 | instance | Saturday 22 August 2026  14:33:36 +0000 (0:00:25.083)       0:00:28.699 *******
2026-08-22 14:33:37.332420 | instance | ok: [instance]
2026-08-22 14:33:37.332678 | instance |
2026-08-22 14:33:37.333005 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-22 14:33:37.333295 | instance | Saturday 22 August 2026  14:33:37 +0000 (0:00:00.554)       0:00:29.254 *******
2026-08-22 14:33:37.637944 | instance | ok: [instance]
2026-08-22 14:33:37.638194 | instance |
2026-08-22 14:33:37.638497 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-22 14:33:37.638810 | instance | Saturday 22 August 2026  14:33:37 +0000 (0:00:00.305)       0:00:29.559 *******
2026-08-22 14:33:38.288555 | instance | changed: [instance]
2026-08-22 14:33:38.289011 | instance |
2026-08-22 14:33:38.289388 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-22 14:33:38.289812 | instance | Saturday 22 August 2026  14:33:38 +0000 (0:00:00.650)       0:00:30.210 *******
2026-08-22 14:33:38.484287 | instance | ok: [instance]
2026-08-22 14:33:38.484326 | instance |
2026-08-22 14:33:38.484334 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-22 14:33:38.484341 | instance | Saturday 22 August 2026  14:33:38 +0000 (0:00:00.195)       0:00:30.405 *******
2026-08-22 14:33:38.512298 | instance | skipping: [instance]
2026-08-22 14:33:38.512336 | instance |
2026-08-22 14:33:38.512345 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-22 14:33:38.512354 | instance | Saturday 22 August 2026  14:33:38 +0000 (0:00:00.027)       0:00:30.433 *******
2026-08-22 14:33:39.056823 | instance | changed: [instance] => (item=osd0)
2026-08-22 14:33:39.056909 | instance | changed: [instance] => (item=osd1)
2026-08-22 14:33:39.056923 | instance | changed: [instance] => (item=osd2)
2026-08-22 14:33:39.056933 | instance |
2026-08-22 14:33:39.056944 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-22 14:33:39.057092 | instance | Saturday 22 August 2026  14:33:39 +0000 (0:00:00.543)       0:00:30.977 *******
2026-08-22 14:33:39.649540 | instance | changed: [instance] => (item=osd0)
2026-08-22 14:33:39.649853 | instance | changed: [instance] => (item=osd1)
2026-08-22 14:33:39.650170 | instance | changed: [instance] => (item=osd2)
2026-08-22 14:33:39.650462 | instance |
2026-08-22 14:33:39.650751 | instance | TASK [Start loop devices] ******************************************************
2026-08-22 14:33:39.651032 | instance | Saturday 22 August 2026  14:33:39 +0000 (0:00:00.593)       0:00:31.571 *******
2026-08-22 14:33:40.306960 | instance | changed: [instance] => (item=osd0)
2026-08-22 14:33:40.307220 | instance | changed: [instance] => (item=osd1)
2026-08-22 14:33:40.307511 | instance | changed: [instance] => (item=osd2)
2026-08-22 14:33:40.307796 | instance |
2026-08-22 14:33:40.308098 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-22 14:33:40.308394 | instance | Saturday 22 August 2026  14:33:40 +0000 (0:00:00.657)       0:00:32.228 *******
2026-08-22 14:33:43.339021 | instance | changed: [instance] => (item=osd0)
2026-08-22 14:33:43.339065 | instance | changed: [instance] => (item=osd1)
2026-08-22 14:33:43.339071 | instance | changed: [instance] => (item=osd2)
2026-08-22 14:33:43.339078 | instance |
2026-08-22 14:33:43.339084 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-22 14:33:43.339090 | instance | Saturday 22 August 2026  14:33:43 +0000 (0:00:03.031)       0:00:35.260 *******
2026-08-22 14:33:45.148817 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-22 14:33:45.148884 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-22 14:33:45.148914 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-22 14:33:45.148924 | instance |
2026-08-22 14:33:45.148933 | instance | PLAY RECAP *********************************************************************
2026-08-22 14:33:45.148943 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 14:33:45.148953 | instance |
2026-08-22 14:33:45.148962 | instance | Saturday 22 August 2026  14:33:45 +0000 (0:00:01.808)       0:00:37.068 *******
2026-08-22 14:33:45.148971 | instance | ===============================================================================
2026-08-22 14:33:45.148980 | instance | Install depedencies ---------------------------------------------------- 25.08s
2026-08-22 14:33:45.148989 | instance | Create a volume group for each loop device ------------------------------ 3.03s
2026-08-22 14:33:45.148998 | instance | Create a logical volume for each loop device ---------------------------- 1.81s
2026-08-22 14:33:45.149007 | instance | Gathering Facts --------------------------------------------------------- 1.19s
2026-08-22 14:33:45.149016 | instance | Purge "snapd" package --------------------------------------------------- 0.82s
2026-08-22 14:33:45.149025 | instance | Configure short hostname ------------------------------------------------ 0.66s
2026-08-22 14:33:45.149041 | instance | Gathering Facts --------------------------------------------------------- 0.66s
2026-08-22 14:33:45.149050 | instance | Start loop devices ------------------------------------------------------ 0.66s
2026-08-22 14:33:45.150399 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-22 14:33:45.150444 | instance | Set permissions on loopback devices ------------------------------------- 0.59s
2026-08-22 14:33:45.150451 | instance | Start up service -------------------------------------------------------- 0.55s
2026-08-22 14:33:45.150457 | instance | Create devices for Ceph ------------------------------------------------- 0.54s
2026-08-22 14:33:45.150463 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-08-22 14:33:45.150469 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s
2026-08-22 14:33:45.150474 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-22 14:33:45.150480 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-22 14:33:45.213729 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-22 14:33:45.226301 | instance | INFO     [csi > converge] Executing
2026-08-22 14:33:46.676219 | instance |
2026-08-22 14:33:46.676641 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-22 14:33:46.677013 | instance |
2026-08-22 14:33:46.677393 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 14:33:46.677819 | instance | Saturday 22 August 2026  14:33:46 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-22 14:33:47.610077 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 14:33:47.610606 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 14:33:47.611008 | instance | interpreter could change the meaning of that path. See
2026-08-22 14:33:47.611367 | instance | https://docs.ansible.com/ansible-
2026-08-22 14:33:47.611726 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 14:33:47.620044 | instance | ok: [instance]
2026-08-22 14:33:47.620366 | instance |
2026-08-22 14:33:47.620693 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-22 14:33:47.621062 | instance | Saturday 22 August 2026  14:33:47 +0000 (0:00:00.944)       0:00:00.952 *******
2026-08-22 14:33:47.663865 | instance | ok: [instance] => {
2026-08-22 14:33:47.664220 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-22 14:33:47.664535 | instance | }
2026-08-22 14:33:47.664878 | instance |
2026-08-22 14:33:47.665202 | instance | PLAY [all] *********************************************************************
2026-08-22 14:33:47.665502 | instance |
2026-08-22 14:33:47.665856 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 14:33:47.666204 | instance | Saturday 22 August 2026  14:33:47 +0000 (0:00:00.043)       0:00:00.996 *******
2026-08-22 14:33:48.541318 | instance | ok: [instance]
2026-08-22 14:33:48.541884 | instance |
2026-08-22 14:33:48.542274 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-22 14:33:48.542643 | instance | Saturday 22 August 2026  14:33:48 +0000 (0:00:00.876)       0:00:01.872 *******
2026-08-22 14:33:48.733138 | instance | ok: [instance]
2026-08-22 14:33:48.733519 | instance |
2026-08-22 14:33:48.733931 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-22 14:33:48.734262 | instance |
2026-08-22 14:33:48.734606 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 14:33:48.734954 | instance | Saturday 22 August 2026  14:33:48 +0000 (0:00:00.191)       0:00:02.064 *******
2026-08-22 14:33:49.628109 | instance | ok: [instance]
2026-08-22 14:33:49.628478 | instance |
2026-08-22 14:33:49.628849 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 14:33:49.629201 | instance | Saturday 22 August 2026  14:33:49 +0000 (0:00:00.895)       0:00:02.959 *******
2026-08-22 14:33:49.903596 | instance | ok: [instance]
2026-08-22 14:33:49.903954 | instance |
2026-08-22 14:33:49.904297 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 14:33:49.904625 | instance | Saturday 22 August 2026  14:33:49 +0000 (0:00:00.275)       0:00:03.235 *******
2026-08-22 14:33:49.949916 | instance | skipping: [instance]
2026-08-22 14:33:49.950262 | instance |
2026-08-22 14:33:49.950602 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-22 14:33:49.950935 | instance | Saturday 22 August 2026  14:33:49 +0000 (0:00:00.046)       0:00:03.281 *******
2026-08-22 14:33:50.277917 | instance | changed: [instance]
2026-08-22 14:33:50.278325 | instance |
2026-08-22 14:33:50.278675 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 14:33:50.279014 | instance | Saturday 22 August 2026  14:33:50 +0000 (0:00:00.327)       0:00:03.609 *******
2026-08-22 14:33:50.350946 | instance | ok: [instance] => {
2026-08-22 14:33:50.351312 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-22 14:33:50.351635 | instance | }
2026-08-22 14:33:50.351944 | instance |
2026-08-22 14:33:50.352272 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 14:33:50.352602 | instance | Saturday 22 August 2026  14:33:50 +0000 (0:00:00.073)       0:00:03.682 *******
2026-08-22 14:33:50.994168 | instance | changed: [instance]
2026-08-22 14:33:50.994572 | instance |
2026-08-22 14:33:50.994954 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 14:33:50.995310 | instance | Saturday 22 August 2026  14:33:50 +0000 (0:00:00.642)       0:00:04.325 *******
2026-08-22 14:33:51.049573 | instance | skipping: [instance]
2026-08-22 14:33:51.049978 | instance |
2026-08-22 14:33:51.050339 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 14:33:51.050682 | instance | Saturday 22 August 2026  14:33:51 +0000 (0:00:00.053)       0:00:04.379 *******
2026-08-22 14:33:51.101457 | instance | skipping: [instance]
2026-08-22 14:33:51.101646 | instance |
2026-08-22 14:33:51.101889 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 14:33:51.102057 | instance | Saturday 22 August 2026  14:33:51 +0000 (0:00:00.050)       0:00:04.429 *******
2026-08-22 14:33:51.320402 | instance | ok: [instance]
2026-08-22 14:33:51.320586 | instance |
2026-08-22 14:33:51.320759 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 14:33:51.320918 | instance | Saturday 22 August 2026  14:33:51 +0000 (0:00:00.219)       0:00:04.649 *******
2026-08-22 14:33:52.512591 | instance | ok: [instance]
2026-08-22 14:33:52.512915 | instance |
2026-08-22 14:33:52.512933 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 14:33:52.512944 | instance | Saturday 22 August 2026  14:33:52 +0000 (0:00:01.194)       0:00:05.844 *******
2026-08-22 14:33:52.588758 | instance | ok: [instance] => {
2026-08-22 14:33:52.588855 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-22 14:33:52.589607 | instance | }
2026-08-22 14:33:52.589654 | instance |
2026-08-22 14:33:52.589662 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 14:33:52.589669 | instance | Saturday 22 August 2026  14:33:52 +0000 (0:00:00.075)       0:00:05.920 *******
2026-08-22 14:33:53.297945 | instance | changed: [instance]
2026-08-22 14:33:53.298108 | instance |
2026-08-22 14:33:53.298137 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 14:33:53.298153 | instance | Saturday 22 August 2026  14:33:53 +0000 (0:00:00.709)       0:00:06.629 *******
2026-08-22 14:33:56.120624 | instance | changed: [instance]
2026-08-22 14:33:56.120697 | instance |
2026-08-22 14:33:56.120989 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-22 14:33:56.121031 | instance | Saturday 22 August 2026  14:33:56 +0000 (0:00:02.822)       0:00:09.452 *******
2026-08-22 14:33:56.155747 | instance | skipping: [instance]
2026-08-22 14:33:56.156115 | instance |
2026-08-22 14:33:56.156139 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-22 14:33:56.156145 | instance | Saturday 22 August 2026  14:33:56 +0000 (0:00:00.035)       0:00:09.487 *******
2026-08-22 14:33:56.184637 | instance | skipping: [instance]
2026-08-22 14:33:56.184872 | instance |
2026-08-22 14:33:56.185231 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-22 14:33:56.185398 | instance | Saturday 22 August 2026  14:33:56 +0000 (0:00:00.028)       0:00:09.516 *******
2026-08-22 14:33:56.213842 | instance | skipping: [instance]
2026-08-22 14:33:56.213975 | instance |
2026-08-22 14:33:56.214234 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-22 14:33:56.214252 | instance | Saturday 22 August 2026  14:33:56 +0000 (0:00:00.029)       0:00:09.545 *******
2026-08-22 14:34:01.644924 | instance | changed: [instance]
2026-08-22 14:34:01.645172 | instance |
2026-08-22 14:34:01.645262 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-22 14:34:01.645454 | instance | Saturday 22 August 2026  14:34:01 +0000 (0:00:05.430)       0:00:14.976 *******
2026-08-22 14:34:02.205744 | instance | changed: [instance]
2026-08-22 14:34:02.205827 | instance |
2026-08-22 14:34:02.206135 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-22 14:34:02.206165 | instance | Saturday 22 August 2026  14:34:02 +0000 (0:00:00.561)       0:00:15.537 *******
2026-08-22 14:34:03.100344 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-22 14:34:03.100457 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-22 14:34:03.100802 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-22 14:34:03.100855 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-22 14:34:03.100882 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-22 14:34:03.101052 | instance |
2026-08-22 14:34:03.101267 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-22 14:34:03.101430 | instance | Saturday 22 August 2026  14:34:03 +0000 (0:00:00.894)       0:00:16.432 *******
2026-08-22 14:34:03.666443 | instance | changed: [instance]
2026-08-22 14:34:03.666507 | instance |
2026-08-22 14:34:03.667252 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-22 14:34:03.667290 | instance | Saturday 22 August 2026  14:34:03 +0000 (0:00:00.549)       0:00:16.982 *******
2026-08-22 14:34:03.667296 | instance |
2026-08-22 14:34:03.667301 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 14:34:03.667305 | instance | Saturday 22 August 2026  14:34:03 +0000 (0:00:00.016)       0:00:16.998 *******
2026-08-22 14:34:04.580916 | instance | ok: [instance]
2026-08-22 14:34:04.580950 | instance |
2026-08-22 14:34:04.580955 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-22 14:34:04.580960 | instance | Saturday 22 August 2026  14:34:04 +0000 (0:00:00.914)       0:00:17.912 *******
2026-08-22 14:34:04.994874 | instance | changed: [instance]
2026-08-22 14:34:04.994959 | instance |
2026-08-22 14:34:04.994971 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-22 14:34:04.994982 | instance | Saturday 22 August 2026  14:34:04 +0000 (0:00:00.412)       0:00:18.325 *******
2026-08-22 14:34:05.514417 | instance | changed: [instance]
2026-08-22 14:34:05.514476 | instance |
2026-08-22 14:34:05.514490 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 14:34:05.514501 | instance | Saturday 22 August 2026  14:34:05 +0000 (0:00:00.519)       0:00:18.845 *******
2026-08-22 14:34:05.724513 | instance | ok: [instance]
2026-08-22 14:34:05.724569 | instance |
2026-08-22 14:34:05.724584 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 14:34:05.724597 | instance | Saturday 22 August 2026  14:34:05 +0000 (0:00:00.210)       0:00:19.055 *******
2026-08-22 14:34:05.779020 | instance | ok: [instance] => {
2026-08-22 14:34:05.779061 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-22 14:34:05.779067 | instance | }
2026-08-22 14:34:05.779071 | instance |
2026-08-22 14:34:05.779076 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 14:34:05.779143 | instance | Saturday 22 August 2026  14:34:05 +0000 (0:00:00.054)       0:00:19.109 *******
2026-08-22 14:34:06.606760 | instance | changed: [instance]
2026-08-22 14:34:06.607030 | instance |
2026-08-22 14:34:06.607316 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 14:34:06.607600 | instance | Saturday 22 August 2026  14:34:06 +0000 (0:00:00.828)       0:00:19.938 *******
2026-08-22 14:34:10.941990 | instance | changed: [instance]
2026-08-22 14:34:10.942041 | instance |
2026-08-22 14:34:10.942047 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-22 14:34:10.942273 | instance | Saturday 22 August 2026  14:34:10 +0000 (0:00:04.334)       0:00:24.273 *******
2026-08-22 14:34:11.997121 | instance | ok: [instance]
2026-08-22 14:34:11.997620 | instance |
2026-08-22 14:34:11.997662 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-22 14:34:11.997669 | instance | Saturday 22 August 2026  14:34:11 +0000 (0:00:01.055)       0:00:25.328 *******
2026-08-22 14:34:12.954550 | instance | changed: [instance]
2026-08-22 14:34:12.954616 | instance |
2026-08-22 14:34:12.954905 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-22 14:34:12.954941 | instance | Saturday 22 August 2026  14:34:12 +0000 (0:00:00.957)       0:00:26.286 *******
2026-08-22 14:34:13.396695 | instance | changed: [instance]
2026-08-22 14:34:13.396793 | instance |
2026-08-22 14:34:13.397101 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-22 14:34:13.397143 | instance | Saturday 22 August 2026  14:34:13 +0000 (0:00:00.442)       0:00:26.728 *******
2026-08-22 14:34:13.936409 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-22 14:34:13.936501 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-22 14:34:13.936843 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-22 14:34:13.936948 | instance |
2026-08-22 14:34:13.936974 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-22 14:34:13.937056 | instance | Saturday 22 August 2026  14:34:13 +0000 (0:00:00.539)       0:00:27.268 *******
2026-08-22 14:34:14.350696 | instance | changed: [instance]
2026-08-22 14:34:14.350796 | instance |
2026-08-22 14:34:14.351040 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-22 14:34:14.351055 | instance | Saturday 22 August 2026  14:34:14 +0000 (0:00:00.414)       0:00:27.682 *******
2026-08-22 14:34:14.802942 | instance | changed: [instance]
2026-08-22 14:34:14.803035 | instance |
2026-08-22 14:34:14.803670 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-22 14:34:14.803708 | instance | Saturday 22 August 2026  14:34:14 +0000 (0:00:00.435)       0:00:28.118 *******
2026-08-22 14:34:14.803714 | instance |
2026-08-22 14:34:14.803718 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 14:34:14.803722 | instance | Saturday 22 August 2026  14:34:14 +0000 (0:00:00.016)       0:00:28.135 *******
2026-08-22 14:34:15.464995 | instance | ok: [instance]
2026-08-22 14:34:15.465083 | instance |
2026-08-22 14:34:15.465335 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-22 14:34:15.465380 | instance | Saturday 22 August 2026  14:34:15 +0000 (0:00:00.661)       0:00:28.797 *******
2026-08-22 14:34:17.029757 | instance | changed: [instance]
2026-08-22 14:34:17.029836 | instance |
2026-08-22 14:34:17.030089 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-22 14:34:17.030120 | instance | Saturday 22 August 2026  14:34:17 +0000 (0:00:01.564)       0:00:30.361 *******
2026-08-22 14:34:17.565590 | instance | changed: [instance]
2026-08-22 14:34:17.565623 | instance |
2026-08-22 14:34:17.565631 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-22 14:34:17.565637 | instance | Saturday 22 August 2026  14:34:17 +0000 (0:00:00.535)       0:00:30.896 *******
2026-08-22 14:34:17.618111 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-22 14:34:17.618143 | instance |
2026-08-22 14:34:17.618148 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-22 14:34:17.618153 | instance | Saturday 22 August 2026  14:34:17 +0000 (0:00:00.052)       0:00:30.949 *******
2026-08-22 14:34:22.289595 | instance | changed: [instance]
2026-08-22 14:34:22.289630 | instance |
2026-08-22 14:34:22.289636 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-22 14:34:22.289641 | instance | Saturday 22 August 2026  14:34:22 +0000 (0:00:04.671)       0:00:35.620 *******
2026-08-22 14:34:22.932597 | instance | ok: [instance] => (item=chronyd)
2026-08-22 14:34:22.932828 | instance | ok: [instance] => (item=sshd)
2026-08-22 14:34:22.933194 | instance |
2026-08-22 14:34:22.933236 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-22 14:34:22.933242 | instance | Saturday 22 August 2026  14:34:22 +0000 (0:00:00.643)       0:00:36.264 *******
2026-08-22 14:34:25.094657 | instance | changed: [instance]
2026-08-22 14:34:25.094766 | instance |
2026-08-22 14:34:25.095115 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-22 14:34:25.095263 | instance | Saturday 22 August 2026  14:34:25 +0000 (0:00:02.161)       0:00:38.426 *******
2026-08-22 14:34:25.293819 | instance | ok: [instance]
2026-08-22 14:34:25.293894 | instance |
2026-08-22 14:34:25.294183 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-22 14:34:25.294224 | instance | Saturday 22 August 2026  14:34:25 +0000 (0:00:00.199)       0:00:38.625 *******
2026-08-22 14:34:25.739385 | instance | changed: [instance]
2026-08-22 14:34:25.739457 | instance |
2026-08-22 14:34:25.739765 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-22 14:34:25.739804 | instance | Saturday 22 August 2026  14:34:25 +0000 (0:00:00.445)       0:00:39.071 *******
2026-08-22 14:34:26.071797 | instance | changed: [instance]
2026-08-22 14:34:26.071875 | instance |
2026-08-22 14:34:26.072147 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-22 14:34:26.072188 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.332)       0:00:39.403 *******
2026-08-22 14:34:26.186903 | instance | ok: [instance]
2026-08-22 14:34:26.187410 | instance |
2026-08-22 14:34:26.187454 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-22 14:34:26.187462 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.114)       0:00:39.518 *******
2026-08-22 14:34:26.392681 | instance | ok: [instance] => (item=instance)
2026-08-22 14:34:26.392777 | instance |
2026-08-22 14:34:26.393013 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-22 14:34:26.393056 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.205)       0:00:39.724 *******
2026-08-22 14:34:26.441210 | instance | ok: [instance]
2026-08-22 14:34:26.441288 | instance |
2026-08-22 14:34:26.441553 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-22 14:34:26.441593 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.048)       0:00:39.773 *******
2026-08-22 14:34:26.505430 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-22 14:34:26.505809 | instance |
2026-08-22 14:34:26.505851 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-22 14:34:26.505857 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.064)       0:00:39.837 *******
2026-08-22 14:34:26.831378 | instance | changed: [instance]
2026-08-22 14:34:26.831452 | instance |
2026-08-22 14:34:26.831759 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-22 14:34:26.831948 | instance | Saturday 22 August 2026  14:34:26 +0000 (0:00:00.325)       0:00:40.162 *******
2026-08-22 14:34:27.509743 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-22 14:34:27.509853 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-22 14:34:27.510354 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-22 14:34:27.510372 | instance |
2026-08-22 14:34:27.510381 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-22 14:34:27.510394 | instance | Saturday 22 August 2026  14:34:27 +0000 (0:00:00.678)       0:00:40.841 *******
2026-08-22 14:36:14.486747 | instance | ok: [instance]
2026-08-22 14:36:14.486877 | instance |
2026-08-22 14:36:14.487028 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-22 14:36:14.487095 | instance | Saturday 22 August 2026  14:36:14 +0000 (0:01:46.976)       0:02:27.818 *******
2026-08-22 14:36:14.702650 | instance | changed: [instance]
2026-08-22 14:36:14.702746 | instance |
2026-08-22 14:36:14.702984 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-22 14:36:14.702999 | instance | Saturday 22 August 2026  14:36:14 +0000 (0:00:00.216)       0:02:28.034 *******
2026-08-22 14:36:14.775586 | instance | ok: [instance]
2026-08-22 14:36:14.776019 | instance |
2026-08-22 14:36:14.776040 | instance | TASK [Install Ceph host] *******************************************************
2026-08-22 14:36:14.776048 | instance | Saturday 22 August 2026  14:36:14 +0000 (0:00:00.072)       0:02:28.107 *******
2026-08-22 14:36:14.854927 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-22 14:36:14.855062 | instance |
2026-08-22 14:36:14.855210 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-22 14:36:14.855395 | instance | Saturday 22 August 2026  14:36:14 +0000 (0:00:00.079)       0:02:28.187 *******
2026-08-22 14:36:19.619743 | instance | ok: [instance]
2026-08-22 14:36:19.619789 | instance |
2026-08-22 14:36:19.619795 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-22 14:36:19.619799 | instance | Saturday 22 August 2026  14:36:19 +0000 (0:00:04.764)       0:02:32.951 *******
2026-08-22 14:36:19.674985 | instance | ok: [instance] => (item=instance)
2026-08-22 14:36:19.675008 | instance |
2026-08-22 14:36:19.675014 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-22 14:36:19.675018 | instance | Saturday 22 August 2026  14:36:19 +0000 (0:00:00.055)       0:02:33.006 *******
2026-08-22 14:36:20.040766 | instance | ok: [instance]
2026-08-22 14:36:20.040805 | instance |
2026-08-22 14:36:20.040810 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-22 14:36:20.040815 | instance | Saturday 22 August 2026  14:36:20 +0000 (0:00:00.365)       0:02:33.372 *******
2026-08-22 14:36:24.161849 | instance | ok: [instance]
2026-08-22 14:36:24.161956 | instance |
2026-08-22 14:36:24.162209 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-22 14:36:24.162264 | instance | Saturday 22 August 2026  14:36:24 +0000 (0:00:04.121)       0:02:37.493 *******
2026-08-22 14:37:20.657541 | 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-22 14:37:20.658191 | 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_qdq_7vic/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_qdq_7vic/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_qdq_7vic/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_qdq_7vic/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-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCqs4lqlA81ECAAYc9r04I3UlhNR2gzlrk5m0FMPzaWiQ4znjR56GqJNCg=: Malformed input [buffer:3]\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCqs4lqlA81ECAAYc9r04I3UlhNR2gzlrk5m0FMPzaWiQ4znjR56GqJNCg=: Malformed input [buffer:3]\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCqs4lqlA81ECAAYc9r04I3UlhNR2gzlrk5m0FMPzaWiQ4znjR56GqJNCg=: Malformed input [buffer:3]\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:37:20.497+0000 7fcbfdaba640 -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-22 14:37:20.660952 | instance |
2026-08-22 14:37:20.661043 | instance | PLAY RECAP *********************************************************************
2026-08-22 14:37:20.661056 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-22 14:37:20.661077 | instance |
2026-08-22 14:37:20.664191 | instance | Saturday 22 August 2026  14:37:20 +0000 (0:00:56.499)       0:03:33.992 *******
2026-08-22 14:37:20.664214 | instance | ===============================================================================
2026-08-22 14:37:20.664219 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 106.98s
2026-08-22 14:37:20.664223 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 56.50s
2026-08-22 14:37:20.664227 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.43s
2026-08-22 14:37:20.664231 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 4.76s
2026-08-22 14:37:20.664235 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.67s
2026-08-22 14:37:20.664239 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.33s
2026-08-22 14:37:20.664242 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 4.12s
2026-08-22 14:37:20.664246 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.82s
2026-08-22 14:37:20.664257 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 2.16s
2026-08-22 14:37:20.664260 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s
2026-08-22 14:37:20.664264 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.56s
2026-08-22 14:37:20.664268 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.19s
2026-08-22 14:37:20.664272 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.06s
2026-08-22 14:37:20.664276 | instance | vexxhost.containers.docker : Ensure group "docker" exists --------------- 0.96s
2026-08-22 14:37:20.664280 | instance | Gathering Facts --------------------------------------------------------- 0.94s
2026-08-22 14:37:20.664283 | instance | Gathering Facts --------------------------------------------------------- 0.90s
2026-08-22 14:37:20.664287 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.89s
2026-08-22 14:37:20.664291 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-22 14:37:20.664295 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-08-22 14:37:20.664299 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s
2026-08-22 14:37:20.766490 | 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-22 14:37:20.766545 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-22 14:37:20.766635 | 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-22 14:37:21.420052 | instance | ERROR
2026-08-22 14:37:21.420244 | instance | {
2026-08-22 14:37:21.420285 | instance |   "delta": "0:04:28.362206",
2026-08-22 14:37:21.420306 | instance |   "end": "2026-08-22 14:37:20.818680",
2026-08-22 14:37:21.420325 | instance |   "msg": "non-zero return code",
2026-08-22 14:37:21.420344 | instance |   "rc": 2,
2026-08-22 14:37:21.420362 | instance |   "start": "2026-08-22 14:32:52.456474"
2026-08-22 14:37:21.420379 | instance | }
failure
2026-08-22 14:37:21.425802 | 
2026-08-22 14:37:21.425848 | PLAY RECAP
2026-08-22 14:37:21.425892 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-22 14:37:21.425913 | 
2026-08-22 14:37:21.833687 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 14:37:21.838622 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 14:37:22.867879 | 
2026-08-22 14:37:22.868007 | PLAY [all]
2026-08-22 14:37:22.881958 | 
2026-08-22 14:37:22.882038 | TASK [gather-host-logs : creating directory for system status]
2026-08-22 14:37:23.243523 | instance | changed
2026-08-22 14:37:23.248944 | 
2026-08-22 14:37:23.249041 | TASK [gather-host-logs : Get logs for each host]
2026-08-22 14:37:23.622399 | instance | + systemd-cgls --full --all --no-pager
2026-08-22 14:37:23.640652 | instance | + ip addr
2026-08-22 14:37:23.642171 | instance | + ip route
2026-08-22 14:37:23.644836 | instance | + lsblk
2026-08-22 14:37:23.650841 | instance | + mount
2026-08-22 14:37:23.653869 | instance | + docker images
2026-08-22 14:37:23.673170 | instance | + brctl show
2026-08-22 14:37:23.673887 | instance | /bin/bash: line 8: brctl: command not found
2026-08-22 14:37:23.674227 | instance | + ps aux --sort=-%mem
2026-08-22 14:37:23.691471 | instance | + dpkg -l
2026-08-22 14:37:23.701678 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-22 14:37:23.702247 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-22 14:37:23.719710 | instance | + '[' '!' -z '' ']'
2026-08-22 14:37:23.782160 | instance | ok: Runtime: 0:00:00.104142
2026-08-22 14:37:23.790993 | 
2026-08-22 14:37:23.791088 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-22 14:37:24.444909 | instance | changed:
2026-08-22 14:37:24.445104 | instance | created directory /var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/logs/instance
2026-08-22 14:37:24.445132 | instance | cd+++++++++ system/
2026-08-22 14:37:24.445154 | instance | >f+++++++++ system/brctl-show.txt
2026-08-22 14:37:24.445174 | instance | >f+++++++++ system/docker-images.txt
2026-08-22 14:37:24.445193 | instance | >f+++++++++ system/ip-addr.txt
2026-08-22 14:37:24.445215 | instance | >f+++++++++ system/ip-route.txt
2026-08-22 14:37:24.445236 | instance | >f+++++++++ system/lsblk.txt
2026-08-22 14:37:24.445256 | instance | >f+++++++++ system/mount.txt
2026-08-22 14:37:24.445275 | instance | >f+++++++++ system/packages.txt
2026-08-22 14:37:24.445295 | instance | >f+++++++++ system/ps.txt
2026-08-22 14:37:24.445347 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-22 14:37:24.455443 | 
2026-08-22 14:37:24.455524 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 14:37:24.649601 | instance | changed: "values"
2026-08-22 14:37:24.818892 | instance | changed: "releases"
2026-08-22 14:37:24.838258 | 
2026-08-22 14:37:24.838445 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 14:37:25.049943 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-22 14:37:25.380438 | instance | ok: Runtime: 0:00:00.006995
2026-08-22 14:37:25.388790 | 
2026-08-22 14:37:25.388883 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 14:37:25.910197 | instance | changed:
2026-08-22 14:37:25.910418 | instance | cd+++++++++ helm/
2026-08-22 14:37:25.910457 | instance | cd+++++++++ helm/releases/
2026-08-22 14:37:25.910488 | instance | cd+++++++++ helm/values/
2026-08-22 14:37:25.922630 | 
2026-08-22 14:37:25.922743 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 14:37:26.127192 | instance | changed
2026-08-22 14:37:26.133373 | 
2026-08-22 14:37:26.133463 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 14:37:26.399825 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 14:37:26.399972 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 14:37:26.405792 | instance | environment: line 1: kubectl: command not found
2026-08-22 14:37:26.407390 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 14:37:26.408196 | instance | environment: line 1: kubectl: command not found
2026-08-22 14:37:26.409810 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 14:37:26.410234 | instance | environment: line 1: kubectl: command not found
2026-08-22 14:37:26.411239 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 14:37:26.413745 | instance | environment: line 1: kubectl: command not found
2026-08-22 14:37:26.414597 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 14:37:26.415018 | instance | environment: line 1: kubectl: command not found
2026-08-22 14:37:26.415926 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 14:37:26.667802 | instance | ok: Runtime: 0:00:00.024647
2026-08-22 14:37:26.674758 | 
2026-08-22 14:37:26.674849 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 14:37:26.891658 | instance | changed
2026-08-22 14:37:26.896643 | 
2026-08-22 14:37:26.896714 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 14:37:27.103268 | instance | environment: line 5: kubectl: command not found
2026-08-22 14:37:27.103679 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 14:37:27.105053 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 14:37:27.105102 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 14:37:27.430885 | instance | ok: Runtime: 0:00:00.009976
2026-08-22 14:37:27.438261 | 
2026-08-22 14:37:27.438352 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 14:37:27.956303 | instance | changed:
2026-08-22 14:37:27.956575 | instance | cd+++++++++ objects/
2026-08-22 14:37:27.956637 | instance | cd+++++++++ objects/cluster/
2026-08-22 14:37:27.956687 | instance | cd+++++++++ objects/namespaced/
2026-08-22 14:37:27.969127 | 
2026-08-22 14:37:27.969194 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 14:37:28.174714 | instance | changed
2026-08-22 14:37:28.181553 | 
2026-08-22 14:37:28.181618 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 14:37:28.379073 | instance | changed
2026-08-22 14:37:28.385782 | 
2026-08-22 14:37:28.385853 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 14:37:28.587662 | instance | environment: line 3: kubectl: command not found
2026-08-22 14:37:28.918453 | instance | ok: Runtime: 0:00:00.008253
2026-08-22 14:37:28.930213 | 
2026-08-22 14:37:28.930312 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 14:37:29.439903 | instance | changed:
2026-08-22 14:37:29.440109 | instance | cd+++++++++ pod-logs/
2026-08-22 14:37:29.440164 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-22 14:37:29.452816 | 
2026-08-22 14:37:29.452875 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-22 14:37:29.654365 | instance | changed
2026-08-22 14:37:29.660331 | 
2026-08-22 14:37:29.660400 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-22 14:37:29.874773 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 14:37:30.196284 | instance | ok: Runtime: 0:00:00.034351
2026-08-22 14:37:30.203044 | 
2026-08-22 14:37:30.203138 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-22 14:37:30.403562 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 14:37:30.434425 | instance | ceph-mgr endpoints:
2026-08-22 14:37:30.739555 | instance | ok: Runtime: 0:00:00.038127
2026-08-22 14:37:30.746634 | 
2026-08-22 14:37:30.746723 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-22 14:37:30.953915 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-22 14:37:31.282369 | instance | ok: Runtime: 0:00:00.035322
2026-08-22 14:37:31.290003 | 
2026-08-22 14:37:31.290093 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-22 14:37:31.792585 | instance | changed: cd+++++++++ prometheus/
2026-08-22 14:37:31.805878 | 
2026-08-22 14:37:31.806039 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-22 14:37:31.994973 | instance | changed
2026-08-22 14:37:31.999958 | 
2026-08-22 14:37:32.000024 | TASK [gather-selenium-data : Get selenium data]
2026-08-22 14:37:32.249164 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-22 14:37:32.250678 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-22 14:37:32.538553 | instance | ERROR
2026-08-22 14:37:32.538880 | instance | {
2026-08-22 14:37:32.538960 | instance |   "delta": "0:00:00.007098",
2026-08-22 14:37:32.539011 | instance |   "end": "2026-08-22 14:37:32.251077",
2026-08-22 14:37:32.539060 | instance |   "msg": "non-zero return code",
2026-08-22 14:37:32.539104 | instance |   "rc": 1,
2026-08-22 14:37:32.539148 | instance |   "start": "2026-08-22 14:37:32.243979"
2026-08-22 14:37:32.539191 | instance | }
2026-08-22 14:37:32.539245 | instance | ERROR: Ignoring Errors
2026-08-22 14:37:32.544508 | 
2026-08-22 14:37:32.544575 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-22 14:37:33.063282 | instance | changed: cd+++++++++ selenium/
2026-08-22 14:37:33.071447 | 
2026-08-22 14:37:33.071519 | PLAY RECAP
2026-08-22 14:37:33.071586 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-22 14:37:33.071619 | 
2026-08-22 14:37:33.211357 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 14:37:33.213493 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 14:37:33.948449 | 
2026-08-22 14:37:33.948920 | PLAY [all]
2026-08-22 14:37:33.960800 | 
2026-08-22 14:37:33.960889 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 14:37:33.997466 | instance | skipping: Conditional result was False
2026-08-22 14:37:34.008321 | 
2026-08-22 14:37:34.008491 | TASK [fetch-output : Set log path for single node]
2026-08-22 14:37:34.053341 | instance | ok
2026-08-22 14:37:34.060430 | 
2026-08-22 14:37:34.060526 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 14:37:34.476643 | instance -> localhost | ok: "/var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/logs"
2026-08-22 14:37:34.697441 | instance -> localhost | changed: "/var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/artifacts"
2026-08-22 14:37:34.919212 | instance -> localhost | changed: "/var/lib/zuul/builds/40d22de5fc1c4da5bf591ccca3eee35a/work/docs"
2026-08-22 14:37:34.941699 | 
2026-08-22 14:37:34.941870 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 14:37:35.667361 | instance | changed: .d..t...... ./
2026-08-22 14:37:35.667767 | instance | changed: All items complete
2026-08-22 14:37:35.667826 | 
2026-08-22 14:37:36.145924 | instance | changed: .d..t...... ./
2026-08-22 14:37:36.652811 | instance | changed: .d..t...... ./
2026-08-22 14:37:36.680710 | 
2026-08-22 14:37:36.680863 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 14:37:37.148209 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008075
2026-08-22 14:37:37.378704 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007561
2026-08-22 14:37:37.394079 | 
2026-08-22 14:37:37.394230 | PLAY [all]
2026-08-22 14:37:37.400779 | 
2026-08-22 14:37:37.400847 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 14:37:37.841658 | instance | changed
2026-08-22 14:37:37.848588 | 
2026-08-22 14:37:37.848672 | PLAY RECAP
2026-08-22 14:37:37.848721 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 14:37:37.848744 | 
2026-08-22 14:37:38.002694 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 14:37:38.007657 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 14:37:38.580759 | 
2026-08-22 14:37:38.580892 | PLAY [localhost]
2026-08-22 14:37:38.590609 | 
2026-08-22 14:37:38.590678 | TASK [Generate Zuul manifest]
2026-08-22 14:37:38.610274 | localhost | ok
2026-08-22 14:37:38.629047 | 
2026-08-22 14:37:38.629141 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 14:37:39.036790 | localhost | changed
2026-08-22 14:37:39.047791 | 
2026-08-22 14:37:39.047866 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 14:37:39.079021 | localhost | ok
2026-08-22 14:37:39.088136 | 
2026-08-22 14:37:39.088222 | TASK [Upload logs]
2026-08-22 14:37:39.110101 | localhost | ok
2026-08-22 14:37:39.167092 | 
2026-08-22 14:37:39.167196 | TASK [Set zuul-log-path fact]
2026-08-22 14:37:39.187390 | localhost | ok
2026-08-22 14:37:39.203095 | 
2026-08-22 14:37:39.203165 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 14:37:39.233321 | localhost | ok
2026-08-22 14:37:39.243033 | 
2026-08-22 14:37:39.243126 | TASK [upload-logs : Create log directories]
2026-08-22 14:37:39.657543 | localhost | changed
2026-08-22 14:37:39.665065 | 
2026-08-22 14:37:39.665132 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 14:37:40.071996 | localhost -> localhost | ok: Runtime: 0:00:00.005615
2026-08-22 14:37:40.079157 | 
2026-08-22 14:37:40.079250 | TASK [upload-logs : Upload logs to log server]
2026-08-22 14:37:40.557372 | localhost | Output suppressed because no_log was given
2026-08-22 14:37:40.594965 | 
2026-08-22 14:37:40.595115 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 14:37:40.639405 | localhost | skipping: Conditional result was False
2026-08-22 14:37:40.646355 | localhost | skipping: Conditional result was False
2026-08-22 14:37:40.659705 | 
2026-08-22 14:37:40.659905 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 14:37:40.702766 | localhost | skipping: Conditional result was False
2026-08-22 14:37:40.703122 | 
2026-08-22 14:37:40.706468 | localhost | skipping: Conditional result was False
2026-08-22 14:37:40.716129 | 
2026-08-22 14:37:40.716290 | LOOP [upload-logs : Upload console log and json output]