2026-07-28 05:16:14.969487 | Job console starting
2026-07-28 05:16:14.979969 | Updating git repos
2026-07-28 05:16:16.876570 | Cloning repos into workspace
2026-07-28 05:16:30.211577 | Restoring repo states
2026-07-28 05:16:41.025539 | Merging changes
2026-07-28 05:16:42.284892 | Checking out repos
2026-07-28 05:16:43.746526 | Preparing playbooks
2026-07-28 05:16:46.387904 | Running Ansible setup
2026-07-28 05:16:49.905637 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-28 05:16:50.508953 | 
2026-07-28 05:16:50.509180 | PLAY [localhost]
2026-07-28 05:16:50.518205 | 
2026-07-28 05:16:50.518413 | TASK [Gathering Facts]
2026-07-28 05:16:51.392724 | localhost | ok
2026-07-28 05:16:51.403163 | 
2026-07-28 05:16:51.403234 | TASK [Setup log path fact]
2026-07-28 05:16:51.423688 | localhost | ok
2026-07-28 05:16:51.435374 | 
2026-07-28 05:16:51.435436 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-28 05:16:51.465283 | localhost | ok
2026-07-28 05:16:51.472625 | 
2026-07-28 05:16:51.472688 | TASK [emit-job-header : Print job information]
2026-07-28 05:16:51.512724 | # Job Information
2026-07-28 05:16:51.512873 | Ansible Version: 2.16.18
2026-07-28 05:16:51.512916 | Job: atmosphere-molecule-csi-local-path-provisioner-selective
2026-07-28 05:16:51.512946 | Pipeline: check
2026-07-28 05:16:51.512997 | Executor: 2d72f0692154
2026-07-28 05:16:51.513028 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4152
2026-07-28 05:16:51.513059 | Event ID: f82624c0-8a42-11f1-86dd-541e7fd58861
2026-07-28 05:16:51.516732 | 
2026-07-28 05:16:51.516815 | LOOP [emit-job-header : Print node information]
2026-07-28 05:16:51.612481 | localhost | ok:
2026-07-28 05:16:51.613191 | localhost | # Node Information
2026-07-28 05:16:51.613224 | localhost | Inventory Hostname: instance
2026-07-28 05:16:51.613246 | localhost | Hostname: np0000187242
2026-07-28 05:16:51.613265 | localhost | Username: zuul
2026-07-28 05:16:51.613287 | localhost | Distro: Ubuntu 22.04
2026-07-28 05:16:51.613307 | localhost | Provider: yul1
2026-07-28 05:16:51.613326 | localhost | Region: ca-ymq-1
2026-07-28 05:16:51.613344 | localhost | Label: ubuntu-jammy
2026-07-28 05:16:51.613363 | localhost | Product Name: OpenStack Nova
2026-07-28 05:16:51.613381 | localhost | Interface IP: 199.204.45.229
2026-07-28 05:16:51.625229 | 
2026-07-28 05:16:51.625351 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-28 05:16:52.141142 | localhost -> localhost | changed
2026-07-28 05:16:52.150125 | 
2026-07-28 05:16:52.150229 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-28 05:16:52.975777 | localhost -> localhost | changed
2026-07-28 05:16:52.986427 | 
2026-07-28 05:16:52.986502 | PLAY [all]
2026-07-28 05:16:52.994348 | 
2026-07-28 05:16:52.994426 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-28 05:16:53.222118 | instance -> localhost | ok
2026-07-28 05:16:53.234311 | 
2026-07-28 05:16:53.234491 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-28 05:16:53.267741 | instance | ok
2026-07-28 05:16:53.282370 | instance | included: /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-28 05:16:53.288819 | 
2026-07-28 05:16:53.288881 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-28 05:16:54.593013 | instance -> localhost | Generating public/private rsa key pair.
2026-07-28 05:16:54.593229 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/5baf9710df8d4d11913bc3d3ca32deec_id_rsa
2026-07-28 05:16:54.593271 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/5baf9710df8d4d11913bc3d3ca32deec_id_rsa.pub
2026-07-28 05:16:54.593303 | instance -> localhost | The key fingerprint is:
2026-07-28 05:16:54.593334 | instance -> localhost | SHA256:6QmVpEBxlLQF0qVzF708u50GV86R4/F/XUlPRx/ksNM zuul-build-sshkey
2026-07-28 05:16:54.593382 | instance -> localhost | The key's randomart image is:
2026-07-28 05:16:54.593414 | instance -> localhost | +---[RSA 3072]----+
2026-07-28 05:16:54.593451 | instance -> localhost | |   .===++ .. ... |
2026-07-28 05:16:54.593486 | instance -> localhost | |     +o* . .. =..|
2026-07-28 05:16:54.593517 | instance -> localhost | |      = + .. + E+|
2026-07-28 05:16:54.593547 | instance -> localhost | |       + o  + .*=|
2026-07-28 05:16:54.593576 | instance -> localhost | |      . S    oo=O|
2026-07-28 05:16:54.593606 | instance -> localhost | |       o .  o .o*|
2026-07-28 05:16:54.593634 | instance -> localhost | |        o    = .+|
2026-07-28 05:16:54.593663 | instance -> localhost | |            . + +|
2026-07-28 05:16:54.593695 | instance -> localhost | |             .  .|
2026-07-28 05:16:54.593724 | instance -> localhost | +----[SHA256]-----+
2026-07-28 05:16:54.593789 | instance -> localhost | ok: Runtime: 0:00:00.879990
2026-07-28 05:16:54.600753 | 
2026-07-28 05:16:54.600823 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-28 05:16:54.634031 | instance | ok
2026-07-28 05:16:54.644335 | instance | included: /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-28 05:16:54.651787 | 
2026-07-28 05:16:54.651853 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-28 05:16:54.677350 | instance | skipping: Conditional result was False
2026-07-28 05:16:54.687201 | 
2026-07-28 05:16:54.687293 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-28 05:16:55.160084 | instance | changed
2026-07-28 05:16:55.165310 | 
2026-07-28 05:16:55.165382 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-28 05:16:55.348588 | instance | ok
2026-07-28 05:16:55.400301 | 
2026-07-28 05:16:55.400438 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-28 05:16:55.879025 | instance | changed
2026-07-28 05:16:55.885508 | 
2026-07-28 05:16:55.885582 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-28 05:16:56.345343 | instance | changed
2026-07-28 05:16:56.351446 | 
2026-07-28 05:16:56.351521 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-28 05:16:56.376841 | instance | skipping: Conditional result was False
2026-07-28 05:16:56.382635 | 
2026-07-28 05:16:56.382701 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-28 05:16:56.748404 | instance -> localhost | changed
2026-07-28 05:16:56.764733 | 
2026-07-28 05:16:56.764817 | TASK [add-build-sshkey : Add back temp key]
2026-07-28 05:16:57.028514 | instance -> localhost | Identity added: /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/5baf9710df8d4d11913bc3d3ca32deec_id_rsa (zuul-build-sshkey)
2026-07-28 05:16:57.028713 | instance -> localhost | ok: Runtime: 0:00:00.013332
2026-07-28 05:16:57.033868 | 
2026-07-28 05:16:57.033935 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-28 05:16:57.378030 | instance | ok
2026-07-28 05:16:57.383254 | 
2026-07-28 05:16:57.383330 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-28 05:16:57.409111 | instance | skipping: Conditional result was False
2026-07-28 05:16:57.423537 | 
2026-07-28 05:16:57.423667 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-28 05:16:57.752421 | instance | ok
2026-07-28 05:16:57.792090 | 
2026-07-28 05:16:57.792224 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-28 05:17:01.006127 | instance | Output suppressed because no_log was given
2026-07-28 05:17:01.024980 | 
2026-07-28 05:17:01.025187 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-28 05:17:01.211458 | instance | ok: "logs"
2026-07-28 05:17:01.211776 | instance | ok: All items complete
2026-07-28 05:17:01.211805 | 
2026-07-28 05:17:01.377580 | instance | ok: "artifacts"
2026-07-28 05:17:01.531619 | instance | ok: "docs"
2026-07-28 05:17:01.539985 | 
2026-07-28 05:17:01.540124 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-28 05:17:01.737597 | instance | changed: "logs"
2026-07-28 05:17:01.882124 | instance | changed: "artifacts"
2026-07-28 05:17:02.049217 | instance | changed: "docs"
2026-07-28 05:17:02.057853 | 
2026-07-28 05:17:02.058147 | PLAY RECAP
2026-07-28 05:17:02.058199 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-28 05:17:02.058230 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 05:17:02.058254 | 
2026-07-28 05:17:02.197738 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-28 05:17:02.202958 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-28 05:17:02.805700 | 
2026-07-28 05:17:02.805853 | PLAY [all]
2026-07-28 05:17:02.817594 | 
2026-07-28 05:17:02.817679 | TASK [setup-uv : Extract archive]
2026-07-28 05:17:05.066435 | instance | changed
2026-07-28 05:17:05.073934 | 
2026-07-28 05:17:05.074011 | TASK [setup-uv : Print version]
2026-07-28 05:17:05.408739 | instance | uv 0.8.13
2026-07-28 05:17:05.608415 | instance | ok: Runtime: 0:00:00.011083
2026-07-28 05:17:05.619209 | 
2026-07-28 05:17:05.619281 | TASK [Install Ansible collection siblings]
2026-07-28 05:17:15.408409 | instance | changed:
2026-07-28 05:17:15.408625 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-28 05:17:15.408666 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-28 05:17:15.408698 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-28 05:17:15.408726 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-28 05:17:15.408754 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-28 05:17:15.408788 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-28 05:17:15.408904 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-28 05:17:15.408983 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-28 05:17:15.409019 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-28 05:17:15.409048 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-28 05:17:15.409075 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-28 05:17:15.409101 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-28 05:17:15.409127 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-28 05:17:15.409154 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-28 05:17:15.409180 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-28 05:17:15.409207 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-28 05:17:15.409234 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-28 05:17:15.409260 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-28 05:17:15.409286 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-28 05:17:15.409313 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-28 05:17:15.409340 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-28 05:17:15.409366 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-28 05:17:15.409495 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-28 05:17:15.409562 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-28 05:17:15.409594 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-28 05:17:15.409622 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-28 05:17:15.409649 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-28 05:17:15.409675 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-28 05:17:15.409701 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-28 05:17:15.409727 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-28 05:17:15.409753 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-28 05:17:15.409779 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-28 05:17:15.409805 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-28 05:17:15.409831 | 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-07-28 05:17:15.409867 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.409894 | instance | Process install dependency map
2026-07-28 05:17:15.409920 | instance | Starting collection install process
2026-07-28 05:17:15.409945 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-28 05:17:15.409971 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-28 05:17:15.409997 | instance | ansible.netcommon:* was installed successfully
2026-07-28 05:17:15.410022 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-28 05:17:15.410047 | instance | Creating virtual environment at: .venv
2026-07-28 05:17:15.410072 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-28 05:17:15.410209 | instance | Downloading openstacksdk (1.7MiB)
2026-07-28 05:17:15.410248 | instance | Downloading pygments (1.2MiB)
2026-07-28 05:17:15.410283 | instance | Downloading pydantic-core (2.0MiB)
2026-07-28 05:17:15.410328 | instance | Downloading cryptography (4.2MiB)
2026-07-28 05:17:15.410356 | instance | Downloading netaddr (2.2MiB)
2026-07-28 05:17:15.410383 | instance | Downloading setuptools (1.1MiB)
2026-07-28 05:17:15.410411 | instance | Downloading ansible-core (2.1MiB)
2026-07-28 05:17:15.410438 | instance | Downloading kubernetes (1.9MiB)
2026-07-28 05:17:15.410464 | instance | Downloading rjsonnet (1.2MiB)
2026-07-28 05:17:15.410490 | instance |    Building pyperclip==1.9.0
2026-07-28 05:17:15.410518 | instance |  Downloading rjsonnet
2026-07-28 05:17:15.410546 | instance |  Downloading pydantic-core
2026-07-28 05:17:15.410572 | instance |  Downloading netaddr
2026-07-28 05:17:15.410599 | instance |  Downloading pygments
2026-07-28 05:17:15.410625 | instance |  Downloading cryptography
2026-07-28 05:17:15.410652 | instance |  Downloading setuptools
2026-07-28 05:17:15.410678 | instance |  Downloading kubernetes
2026-07-28 05:17:15.410704 | instance |  Downloading ansible-core
2026-07-28 05:17:15.410731 | instance |  Downloading openstacksdk
2026-07-28 05:17:15.410757 | instance |       Built pyperclip==1.9.0
2026-07-28 05:17:15.410784 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-28 05:17:15.410914 | instance | Installed 83 packages in 40ms
2026-07-28 05:17:15.410955 | instance | Checked out ansible.posix to 1.6.0
2026-07-28 05:17:15.410984 | 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-07-28 05:17:15.411012 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.411039 | instance | Process install dependency map
2026-07-28 05:17:15.411074 | instance | Starting collection install process
2026-07-28 05:17:15.411102 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-28 05:17:15.411129 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-28 05:17:15.411155 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-28 05:17:15.411182 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.411209 | instance | 2.17.12
2026-07-28 05:17:15.411235 | instance | Checked out ansible.utils to v6.0.3
2026-07-28 05:17:15.411261 | 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-07-28 05:17:15.411288 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.411315 | instance | Process install dependency map
2026-07-28 05:17:15.411341 | instance | Starting collection install process
2026-07-28 05:17:15.411368 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-28 05:17:15.411394 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-28 05:17:15.411421 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-28 05:17:15.411552 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.411592 | instance | 2.17.12
2026-07-28 05:17:15.411621 | instance | Checked out atmosphere.common to v0.7.0
2026-07-28 05:17:15.411648 | 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-07-28 05:17:15.411676 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.411703 | instance | Process install dependency map
2026-07-28 05:17:15.411729 | instance | Starting collection install process
2026-07-28 05:17:15.411755 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-28 05:17:15.411781 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-28 05:17:15.411807 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-28 05:17:15.411833 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.411858 | instance | 2.17.12
2026-07-28 05:17:15.411884 | instance | Checked out community.crypto to 2.2.3
2026-07-28 05:17:15.411910 | 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-07-28 05:17:15.411935 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.411960 | instance | Process install dependency map
2026-07-28 05:17:15.411985 | instance | Starting collection install process
2026-07-28 05:17:15.412011 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-28 05:17:15.412036 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-28 05:17:15.412061 | instance | community.crypto:2.2.3 was installed successfully
2026-07-28 05:17:15.412086 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.412111 | instance | 2.17.12
2026-07-28 05:17:15.412136 | instance | Checked out community.general to 7.3.0
2026-07-28 05:17:15.412161 | 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-07-28 05:17:15.412197 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.412223 | instance | Process install dependency map
2026-07-28 05:17:15.412248 | instance | Starting collection install process
2026-07-28 05:17:15.412273 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-28 05:17:15.412299 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-28 05:17:15.412324 | instance | community.general:7.3.0 was installed successfully
2026-07-28 05:17:15.412350 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.412376 | instance | 2.17.12
2026-07-28 05:17:15.412402 | instance | Checked out community.mysql to 3.6.0
2026-07-28 05:17:15.412431 | 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-07-28 05:17:15.412458 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.412484 | instance | Process install dependency map
2026-07-28 05:17:15.412511 | instance | Starting collection install process
2026-07-28 05:17:15.412536 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-28 05:17:15.412562 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-28 05:17:15.412589 | instance | community.mysql:3.6.0 was installed successfully
2026-07-28 05:17:15.412618 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.412644 | instance | 2.17.12
2026-07-28 05:17:15.412670 | instance | Checked out kubernetes.core to 2.4.0
2026-07-28 05:17:15.412695 | 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-07-28 05:17:15.412721 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.412746 | instance | Process install dependency map
2026-07-28 05:17:15.412772 | instance | Starting collection install process
2026-07-28 05:17:15.412798 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-28 05:17:15.412824 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-28 05:17:15.412849 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-28 05:17:15.412875 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.412900 | instance | 2.17.12
2026-07-28 05:17:15.412926 | instance | Checked out openstack.cloud to 2.6.0
2026-07-28 05:17:15.412952 | 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-07-28 05:17:15.413004 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.413031 | instance | Process install dependency map
2026-07-28 05:17:15.413057 | instance | Starting collection install process
2026-07-28 05:17:15.413083 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-28 05:17:15.413109 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-28 05:17:15.413134 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-28 05:17:15.413160 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.413192 | instance | 2.17.12
2026-07-28 05:17:15.413218 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-28 05:17:15.413244 | 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-07-28 05:17:15.413269 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.413295 | instance | Process install dependency map
2026-07-28 05:17:15.413321 | instance | Starting collection install process
2026-07-28 05:17:15.413346 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-28 05:17:15.413372 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-28 05:17:15.413397 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-28 05:17:15.413423 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.413452 | instance | 2.17.12
2026-07-28 05:17:15.413478 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-28 05:17:15.413503 | 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-07-28 05:17:15.413529 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.413555 | instance | Process install dependency map
2026-07-28 05:17:15.413581 | instance | Starting collection install process
2026-07-28 05:17:15.413606 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-28 05:17:15.413632 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-28 05:17:15.413657 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-28 05:17:15.413683 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.413709 | instance | 2.17.12
2026-07-28 05:17:15.413735 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-28 05:17:15.413760 | 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-07-28 05:17:15.413786 | instance | Starting galaxy collection install process
2026-07-28 05:17:15.413811 | instance | Process install dependency map
2026-07-28 05:17:15.413836 | instance | Starting collection install process
2026-07-28 05:17:15.413961 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-28 05:17:15.414006 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-28 05:17:15.414035 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-28 05:17:15.414063 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-28 05:17:15.414090 | instance | 2.17.12
2026-07-28 05:17:15.420465 | 
2026-07-28 05:17:15.420513 | PLAY RECAP
2026-07-28 05:17:15.420558 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 05:17:15.420580 | 
2026-07-28 05:17:15.533639 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-28 05:17:15.538192 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-28 05:17:16.110383 | 
2026-07-28 05:17:16.110494 | PLAY [all]
2026-07-28 05:17:16.121580 | 
2026-07-28 05:17:16.121653 | TASK [Install "jq" for log collection]
2026-07-28 05:17:26.810999 | instance | changed
2026-07-28 05:17:26.812844 | 
2026-07-28 05:17:26.812906 | PLAY RECAP
2026-07-28 05:17:26.813002 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 05:17:26.813057 | 
2026-07-28 05:17:26.918168 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-28 05:17:26.922089 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-28 05:17:27.480140 | 
2026-07-28 05:17:27.480252 | PLAY [Prepare selective Molecule plan]
2026-07-28 05:17:27.490903 | 
2026-07-28 05:17:27.490973 | TASK [Generate selective Molecule plan]
2026-07-28 05:17:28.031971 | instance | ok: Runtime: 0:00:00.178011
2026-07-28 05:17:28.036731 | 
2026-07-28 05:17:28.036808 | TASK [Render selective Molecule plan]
2026-07-28 05:17:28.307260 | instance | Selective Molecule plan: full
2026-07-28 05:17:28.307358 | instance | Changed files:
2026-07-28 05:17:28.307372 | instance |   M .zuul.yaml
2026-07-28 05:17:28.307382 | instance |   A atmosphere/ci/__init__.py
2026-07-28 05:17:28.307394 | instance |   A atmosphere/ci/molecule_plan.py
2026-07-28 05:17:28.307405 | instance |   A charts/patches/tempest/0002-mount-only-ca-certificate.patch
2026-07-28 05:17:28.307418 | instance |   A charts/patches/tempest/0003-use-ca-for-python-ssl.patch
2026-07-28 05:17:28.307430 | instance |   A charts/patches/tempest/0004-support-ca-only-identity-trust.patch
2026-07-28 05:17:28.307441 | instance |   M charts/tempest/templates/job-ks-user.yaml
2026-07-28 05:17:28.307450 | instance |   M charts/tempest/templates/job-run-tests.yaml
2026-07-28 05:17:28.307460 | instance |   M charts/tempest/values.yaml
2026-07-28 05:17:28.307469 | instance |   A ci/molecule-plan.yaml
2026-07-28 05:17:28.307478 | instance |   M doc/source/deploy/index.rst
2026-07-28 05:17:28.307488 | instance |   A doc/source/deploy/selective-ci.rst
2026-07-28 05:17:28.307497 | instance |   M molecule/aio/converge.yml
2026-07-28 05:17:28.307506 | instance |   M molecule/aio/prepare.yml
2026-07-28 05:17:28.307515 | instance |   M molecule/aio/verify.yml
2026-07-28 05:17:28.307524 | instance |   M playbooks/tempest.yml
2026-07-28 05:17:28.307533 | instance |   M pyproject.toml
2026-07-28 05:17:28.307542 | instance |   A releasenotes/notes/selective-molecule-ci-3233e7ee8348d528.yaml
2026-07-28 05:17:28.307551 | instance |   M roles/tempest/defaults/main.yml
2026-07-28 05:17:28.307560 | instance |   M roles/tempest/tasks/main.yml
2026-07-28 05:17:28.307568 | instance |   M roles/tempest/vars/main.yml
2026-07-28 05:17:28.307577 | instance |   A test-playbooks/molecule/poll-command.yml
2026-07-28 05:17:28.307586 | instance |   A test-playbooks/molecule/post.yml
2026-07-28 05:17:28.307600 | instance |   A test-playbooks/molecule/prepare.yml
2026-07-28 05:17:28.307609 | instance |   A test-playbooks/molecule/run-command.yml
2026-07-28 05:17:28.307618 | instance |   A test-playbooks/molecule/selective-run.yml
2026-07-28 05:17:28.307626 | instance |   A tests/unit/ci/__init__.py
2026-07-28 05:17:28.307636 | instance |   A tests/unit/ci/test_molecule_plan.py
2026-07-28 05:17:28.307645 | instance |   M uv.lock
2026-07-28 05:17:28.307654 | instance | Job decisions:
2026-07-28 05:17:28.307663 | instance |   RUN  aio-openvswitch: full fallback
2026-07-28 05:17:28.307671 | instance |   RUN  aio-ovn: full fallback
2026-07-28 05:17:28.307680 | instance |   RUN  csi-local-path-provisioner: full fallback
2026-07-28 05:17:28.307689 | instance |   RUN  csi-rbd: full fallback
2026-07-28 05:17:28.307698 | instance |   RUN  keycloak: full fallback
2026-07-28 05:17:28.307707 | instance | Reason: the CI selection policy changed
2026-07-28 05:17:28.307716 | instance | Reason: shared deployment code can affect unrelated components
2026-07-28 05:17:28.307725 | instance | Reason: operational workflows need the complete integration environment
2026-07-28 05:17:28.571180 | instance | ok: Runtime: 0:00:00.097921
2026-07-28 05:17:28.578762 | 
2026-07-28 05:17:28.578836 | TASK [Report selective Molecule plan]
2026-07-28 05:17:28.612101 | instance | ok:
2026-07-28 05:17:28.612258 | instance | Selective Molecule plan: full
2026-07-28 05:17:28.612306 | instance | Changed files:
2026-07-28 05:17:28.612339 | instance |   M .zuul.yaml
2026-07-28 05:17:28.612366 | instance |   A atmosphere/ci/__init__.py
2026-07-28 05:17:28.612392 | instance |   A atmosphere/ci/molecule_plan.py
2026-07-28 05:17:28.612427 | instance |   A charts/patches/tempest/0002-mount-only-ca-certificate.patch
2026-07-28 05:17:28.612460 | instance |   A charts/patches/tempest/0003-use-ca-for-python-ssl.patch
2026-07-28 05:17:28.612487 | instance |   A charts/patches/tempest/0004-support-ca-only-identity-trust.patch
2026-07-28 05:17:28.612513 | instance |   M charts/tempest/templates/job-ks-user.yaml
2026-07-28 05:17:28.612540 | instance |   M charts/tempest/templates/job-run-tests.yaml
2026-07-28 05:17:28.612565 | instance |   M charts/tempest/values.yaml
2026-07-28 05:17:28.612592 | instance |   A ci/molecule-plan.yaml
2026-07-28 05:17:28.612621 | instance |   M doc/source/deploy/index.rst
2026-07-28 05:17:28.612649 | instance |   A doc/source/deploy/selective-ci.rst
2026-07-28 05:17:28.612677 | instance |   M molecule/aio/converge.yml
2026-07-28 05:17:28.612704 | instance |   M molecule/aio/prepare.yml
2026-07-28 05:17:28.612730 | instance |   M molecule/aio/verify.yml
2026-07-28 05:17:28.612756 | instance |   M playbooks/tempest.yml
2026-07-28 05:17:28.612781 | instance |   M pyproject.toml
2026-07-28 05:17:28.612806 | instance |   A releasenotes/notes/selective-molecule-ci-3233e7ee8348d528.yaml
2026-07-28 05:17:28.612831 | instance |   M roles/tempest/defaults/main.yml
2026-07-28 05:17:28.612857 | instance |   M roles/tempest/tasks/main.yml
2026-07-28 05:17:28.612883 | instance |   M roles/tempest/vars/main.yml
2026-07-28 05:17:28.612909 | instance |   A test-playbooks/molecule/poll-command.yml
2026-07-28 05:17:28.612934 | instance |   A test-playbooks/molecule/post.yml
2026-07-28 05:17:28.612982 | instance |   A test-playbooks/molecule/prepare.yml
2026-07-28 05:17:28.613012 | instance |   A test-playbooks/molecule/run-command.yml
2026-07-28 05:17:28.613038 | instance |   A test-playbooks/molecule/selective-run.yml
2026-07-28 05:17:28.613064 | instance |   A tests/unit/ci/__init__.py
2026-07-28 05:17:28.613089 | instance |   A tests/unit/ci/test_molecule_plan.py
2026-07-28 05:17:28.613114 | instance |   M uv.lock
2026-07-28 05:17:28.613139 | instance | Job decisions:
2026-07-28 05:17:28.613165 | instance |   RUN  aio-openvswitch: full fallback
2026-07-28 05:17:28.613190 | instance |   RUN  aio-ovn: full fallback
2026-07-28 05:17:28.613215 | instance |   RUN  csi-local-path-provisioner: full fallback
2026-07-28 05:17:28.613240 | instance |   RUN  csi-rbd: full fallback
2026-07-28 05:17:28.613265 | instance |   RUN  keycloak: full fallback
2026-07-28 05:17:28.613299 | instance | Reason: the CI selection policy changed
2026-07-28 05:17:28.613331 | instance | Reason: shared deployment code can affect unrelated components
2026-07-28 05:17:28.613357 | instance | Reason: operational workflows need the complete integration environment
2026-07-28 05:17:28.614701 | 
2026-07-28 05:17:28.614763 | PLAY RECAP
2026-07-28 05:17:28.614823 | instance | ok: 3 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 05:17:28.614852 | 
2026-07-28 05:17:28.735111 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-28 05:17:28.739603 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-28 05:17:29.304449 | 
2026-07-28 05:17:29.304577 | PLAY [Run selected Molecule scenario]
2026-07-28 05:17:29.316214 | 
2026-07-28 05:17:29.316285 | TASK [Read selective Molecule plan]
2026-07-28 05:17:29.613072 | instance | ok
2026-07-28 05:17:29.619782 | 
2026-07-28 05:17:29.619864 | TASK [Resolve this job decision]
2026-07-28 05:17:29.682780 | instance | ok
2026-07-28 05:17:29.691881 | 
2026-07-28 05:17:29.691947 | TASK [Assert this job exists in the plan]
2026-07-28 05:17:29.725985 | instance | ok: All assertions passed
2026-07-28 05:17:29.730389 | 
2026-07-28 05:17:29.730456 | TASK [Resolve selected scenario inputs]
2026-07-28 05:17:29.764901 | instance | ok
2026-07-28 05:17:29.770086 | 
2026-07-28 05:17:29.770154 | TASK [Report this job decision]
2026-07-28 05:17:29.822412 | instance | ok:
2026-07-28 05:17:29.822580 | instance | Selective Molecule job: csi-local-path-provisioner
2026-07-28 05:17:29.822618 | instance | Decision: RUN
2026-07-28 05:17:29.822651 | instance | Reason: full fallback
2026-07-28 05:17:29.822684 | instance | Scenario: csi
2026-07-28 05:17:29.822712 | instance | Targets: (none)
2026-07-28 05:17:29.822740 | instance | Components: (full scenario)
2026-07-28 05:17:29.830308 | 
2026-07-28 05:17:29.830407 | TASK [Prepare Molecule command]
2026-07-28 05:17:29.895619 | instance | ok
2026-07-28 05:17:29.902023 | 
2026-07-28 05:17:29.902091 | TASK [Run standard Molecule lifecycle with progress output]
2026-07-28 05:17:29.949194 | instance | ok
2026-07-28 05:17:29.959920 | instance | included: /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/run-command.yml
2026-07-28 05:17:29.965133 | 
2026-07-28 05:17:29.965194 | TASK [Create Molecule log directory]
2026-07-28 05:17:30.283505 | instance | changed
2026-07-28 05:17:30.288189 | 
2026-07-28 05:17:30.288254 | TASK [Resolve live Molecule log path]
2026-07-28 05:17:30.322134 | instance | ok
2026-07-28 05:17:30.329424 | 
2026-07-28 05:17:30.329496 | TASK [Start Molecule csi (csi-local-path-provisioner)]
2026-07-28 05:17:31.026377 | instance | ok: ERROR (ignored)
2026-07-28 05:17:31.026610 | instance | {
2026-07-28 05:17:31.026640 | instance |   "ansible_job_id": "j79909339094.1472",
2026-07-28 05:17:31.026662 | instance |   "finished": 0,
2026-07-28 05:17:31.026681 | instance |   "results_file": "/home/zuul/.ansible_async/j79909339094.1472",
2026-07-28 05:17:31.026700 | instance |   "started": 1
2026-07-28 05:17:31.026718 | instance | }
2026-07-28 05:17:31.033393 | 
2026-07-28 05:17:31.033464 | TASK [Initialize Molecule csi (csi-local-path-provisioner) progress monitor]
2026-07-28 05:17:31.098760 | instance | ok
2026-07-28 05:17:31.104881 | 
2026-07-28 05:17:31.104975 | TASK [Monitor Molecule csi (csi-local-path-provisioner)]
2026-07-28 05:17:31.129660 | instance | ok
2026-07-28 05:17:31.141451 | instance | included: /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml
2026-07-28 05:17:31.149706 | 
2026-07-28 05:17:31.149773 | TASK [Wait before polling Molecule csi (csi-local-path-provisioner)]
2026-07-28 05:17:51.206435 | instance | ok
2026-07-28 05:17:51.214886 | 
2026-07-28 05:17:51.214964 | TASK [Count Molecule csi (csi-local-path-provisioner) progress poll]
2026-07-28 05:17:51.268576 | instance | ok
2026-07-28 05:17:51.275837 | 
2026-07-28 05:17:51.275906 | TASK [Poll Molecule csi (csi-local-path-provisioner) status]
2026-07-28 05:17:51.602965 | instance | ok: non-zero return code
2026-07-28 05:17:51.612133 | 
2026-07-28 05:17:51.612211 | TASK [Inspect Molecule csi (csi-local-path-provisioner) live log]
2026-07-28 05:17:51.940873 | instance | ok
2026-07-28 05:17:51.947006 | 
2026-07-28 05:17:51.947084 | TASK [Calculate new Molecule csi (csi-local-path-provisioner) output]
2026-07-28 05:17:52.001848 | instance | ok
2026-07-28 05:17:52.008998 | 
2026-07-28 05:17:52.009070 | TASK [Read new Molecule csi (csi-local-path-provisioner) output]
2026-07-28 05:17:52.548943 | instance | skipping: Conditional result was False
2026-07-28 05:17:52.562565 | 
2026-07-28 05:17:52.562677 | TASK [Print new Molecule csi (csi-local-path-provisioner) output]
2026-07-28 05:17:52.608680 | instance | skipping: Conditional result was False
2026-07-28 05:17:52.622262 | 
2026-07-28 05:17:52.622342 | TASK [Advance Molecule csi (csi-local-path-provisioner) live log offset]
2026-07-28 05:17:52.677364 | instance | ok
2026-07-28 05:17:52.686635 | 
2026-07-28 05:17:52.686730 | TASK [Report Molecule csi (csi-local-path-provisioner) progress heartbeat]
2026-07-28 05:17:52.732948 | instance | skipping: Conditional result was False
2026-07-28 05:17:52.742609 | 
2026-07-28 05:17:52.742718 | TASK [Continue monitoring Molecule csi (csi-local-path-provisioner)]
2026-07-28 05:17:52.786293 | instance | skipping: Conditional result was False
2026-07-28 05:17:52.798508 | 
2026-07-28 05:17:52.798597 | TASK [Clean up Molecule csi (csi-local-path-provisioner) async state]
2026-07-28 05:17:52.995408 | instance | ok
2026-07-28 05:17:53.003036 | 
2026-07-28 05:17:53.003110 | TASK [Assert Molecule csi (csi-local-path-provisioner) succeeded]
2026-07-28 05:17:53.059908 | instance | ERROR
2026-07-28 05:17:53.060122 | instance | {
2026-07-28 05:17:53.060155 | instance |   "assertion": "(_atmosphere_ci_phase_result.rc | default(1) | int) == 0",
2026-07-28 05:17:53.060178 | instance |   "evaluated_to": false,
2026-07-28 05:17:53.060197 | instance |   "msg": "Molecule csi (csi-local-path-provisioner) failed with exit code 1. Complete output is in /tmp/logs/molecule-csi-local-path-provisioner.log."
2026-07-28 05:17:53.060218 | instance | }
failure
2026-07-28 05:17:53.061255 | 
2026-07-28 05:17:53.061299 | PLAY RECAP
2026-07-28 05:17:53.061350 | instance | ok: 19 changed: 2 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0
2026-07-28 05:17:53.061373 | 
2026-07-28 05:17:53.258641 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-28 05:17:53.262963 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-28 05:17:53.844200 | 
2026-07-28 05:17:53.844330 | PLAY [Publish selective Molecule plan]
2026-07-28 05:17:53.855741 | 
2026-07-28 05:17:53.855814 | TASK [Check for selective Molecule plan]
2026-07-28 05:17:54.195660 | instance | ok
2026-07-28 05:17:54.201239 | 
2026-07-28 05:17:54.201325 | TASK [Create log directory]
2026-07-28 05:17:54.550094 | instance | ok
2026-07-28 05:17:54.557593 | 
2026-07-28 05:17:54.557682 | TASK [Copy selective Molecule plan to logs]
2026-07-28 05:17:54.989790 | instance | changed
2026-07-28 05:17:54.991831 | 
2026-07-28 05:17:54.991899 | PLAY RECAP
2026-07-28 05:17:54.991966 | instance | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-28 05:17:54.991998 | 
2026-07-28 05:17:55.142016 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-07-28 05:17:55.146266 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-28 05:17:55.728456 | 
2026-07-28 05:17:55.728576 | PLAY [all]
2026-07-28 05:17:55.741964 | 
2026-07-28 05:17:55.742043 | TASK [gather-host-logs : creating directory for system status]
2026-07-28 05:17:56.099457 | instance | changed
2026-07-28 05:17:56.106900 | 
2026-07-28 05:17:56.107018 | TASK [gather-host-logs : Get logs for each host]
2026-07-28 05:17:56.449606 | instance | + systemd-cgls --full --all --no-pager
2026-07-28 05:17:56.460400 | instance | + ip addr
2026-07-28 05:17:56.462886 | instance | + ip route
2026-07-28 05:17:56.464212 | instance | + lsblk
2026-07-28 05:17:56.468255 | instance | + mount
2026-07-28 05:17:56.470773 | instance | + docker images
2026-07-28 05:17:56.471250 | instance | /bin/bash: line 7: docker: command not found
2026-07-28 05:17:56.471517 | instance | + brctl show
2026-07-28 05:17:56.471983 | instance | /bin/bash: line 8: brctl: command not found
2026-07-28 05:17:56.472253 | instance | + ps aux --sort=-%mem
2026-07-28 05:17:56.485717 | instance | + dpkg -l
2026-07-28 05:17:56.496975 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-28 05:17:56.497257 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-28 05:17:56.497287 | instance | /bin/bash: line 11: docker: command not found
2026-07-28 05:17:56.497499 | instance | + '[' '!' -z '' ']'
2026-07-28 05:17:56.646625 | instance | ok: Runtime: 0:00:00.053016
2026-07-28 05:17:56.653128 | 
2026-07-28 05:17:56.653262 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-28 05:17:57.281899 | instance | changed:
2026-07-28 05:17:57.282063 | instance | created directory /var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/logs/instance
2026-07-28 05:17:57.282091 | instance | cd+++++++++ system/
2026-07-28 05:17:57.282112 | instance | >f+++++++++ system/brctl-show.txt
2026-07-28 05:17:57.282132 | instance | >f+++++++++ system/docker-images.txt
2026-07-28 05:17:57.282152 | instance | >f+++++++++ system/ip-addr.txt
2026-07-28 05:17:57.282173 | instance | >f+++++++++ system/ip-route.txt
2026-07-28 05:17:57.282193 | instance | >f+++++++++ system/lsblk.txt
2026-07-28 05:17:57.282213 | instance | >f+++++++++ system/mount.txt
2026-07-28 05:17:57.282234 | instance | >f+++++++++ system/packages.txt
2026-07-28 05:17:57.282253 | instance | >f+++++++++ system/ps.txt
2026-07-28 05:17:57.282272 | instance | >f+++++++++ system/systemd-cgls.txt
2026-07-28 05:17:57.291092 | 
2026-07-28 05:17:57.291161 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-28 05:17:57.483783 | instance | changed: "values"
2026-07-28 05:17:57.664308 | instance | changed: "releases"
2026-07-28 05:17:57.678106 | 
2026-07-28 05:17:57.678346 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-28 05:17:57.891440 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-28 05:17:58.215827 | instance | ok: Runtime: 0:00:00.005931
2026-07-28 05:17:58.221800 | 
2026-07-28 05:17:58.256649 | TASK [helm-release-status : Downloads logs to executor]
2026-07-28 05:17:58.758915 | instance | changed:
2026-07-28 05:17:58.759232 | instance | cd+++++++++ helm/
2026-07-28 05:17:58.759295 | instance | cd+++++++++ helm/releases/
2026-07-28 05:17:58.759342 | instance | cd+++++++++ helm/values/
2026-07-28 05:17:58.769654 | 
2026-07-28 05:17:58.769724 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-28 05:17:58.966700 | instance | changed
2026-07-28 05:17:58.973900 | 
2026-07-28 05:17:58.974015 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-28 05:17:59.229058 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuexargs:
2026-07-28 05:17:59.229203 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-28 05:17:59.234492 | instance | environment: line 1: kubectl: command not found
2026-07-28 05:17:59.235712 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-28 05:17:59.235877 | instance | environment: line 1: kubectl: command not found
2026-07-28 05:17:59.237452 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-28 05:17:59.239175 | instance | environment: line 1: kubectl: command not found
2026-07-28 05:17:59.240191 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-28 05:17:59.241541 | instance | environment: line 1: kubectl: command not found
2026-07-28 05:17:59.242737 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-28 05:17:59.243954 | instance | environment: line 1: kubectl: command not found
2026-07-28 05:17:59.245096 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-28 05:17:59.559819 | instance | ok: Runtime: 0:00:00.025696
2026-07-28 05:17:59.565482 | 
2026-07-28 05:17:59.565553 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-28 05:17:59.762148 | instance | changed
2026-07-28 05:17:59.767499 | 
2026-07-28 05:17:59.767580 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-28 05:17:59.981164 | instance | environment: line 5: kubectl: command not found
2026-07-28 05:17:59.981785 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-28 05:17:59.981938 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-28 05:17:59.982188 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-28 05:18:00.308137 | instance | ok: Runtime: 0:00:00.009757
2026-07-28 05:18:00.313709 | 
2026-07-28 05:18:00.313784 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-28 05:18:00.788856 | instance | changed:
2026-07-28 05:18:00.789098 | instance | cd+++++++++ objects/
2026-07-28 05:18:00.789139 | instance | cd+++++++++ objects/cluster/
2026-07-28 05:18:00.789170 | instance | cd+++++++++ objects/namespaced/
2026-07-28 05:18:00.800301 | 
2026-07-28 05:18:00.800367 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-28 05:18:00.995483 | instance | changed
2026-07-28 05:18:01.002355 | 
2026-07-28 05:18:01.002423 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-28 05:18:01.213598 | instance | changed
2026-07-28 05:18:01.235118 | 
2026-07-28 05:18:01.235246 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-28 05:18:01.448882 | instance | environment: line 3: kubectl: command not found
2026-07-28 05:18:01.772706 | instance | ok: Runtime: 0:00:00.009689
2026-07-28 05:18:01.780757 | 
2026-07-28 05:18:01.780853 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-28 05:18:02.272064 | instance | changed:
2026-07-28 05:18:02.272329 | instance | cd+++++++++ pod-logs/
2026-07-28 05:18:02.272372 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-28 05:18:02.282126 | 
2026-07-28 05:18:02.282192 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-28 05:18:02.485601 | instance | changed
2026-07-28 05:18:02.492126 | 
2026-07-28 05:18:02.492221 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-28 05:18:02.706408 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-28 05:18:03.028062 | instance | ok: Runtime: 0:00:00.036750
2026-07-28 05:18:03.035000 | 
2026-07-28 05:18:03.035114 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-28 05:18:03.246114 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-28 05:18:03.271996 | instance | ceph-mgr endpoints:
2026-07-28 05:18:03.575398 | instance | ok: Runtime: 0:00:00.031430
2026-07-28 05:18:03.581400 | 
2026-07-28 05:18:03.581465 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-28 05:18:03.792790 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-28 05:18:04.117529 | instance | ok: Runtime: 0:00:00.038001
2026-07-28 05:18:04.124043 | 
2026-07-28 05:18:04.124134 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-28 05:18:04.605590 | instance | changed: cd+++++++++ prometheus/
2026-07-28 05:18:04.619624 | 
2026-07-28 05:18:04.619771 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-28 05:18:04.815175 | instance | changed
2026-07-28 05:18:04.822172 | 
2026-07-28 05:18:04.822286 | TASK [gather-selenium-data : Get selenium data]
2026-07-28 05:18:05.108565 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-28 05:18:05.110188 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-28 05:18:05.413770 | instance | ERROR
2026-07-28 05:18:05.414030 | instance | {
2026-07-28 05:18:05.414089 | instance |   "delta": "0:00:00.007643",
2026-07-28 05:18:05.414118 | instance |   "end": "2026-07-28 05:18:05.110658",
2026-07-28 05:18:05.414138 | instance |   "msg": "non-zero return code",
2026-07-28 05:18:05.414157 | instance |   "rc": 1,
2026-07-28 05:18:05.414175 | instance |   "start": "2026-07-28 05:18:05.103015"
2026-07-28 05:18:05.414206 | instance | }
2026-07-28 05:18:05.414232 | instance | ERROR: Ignoring Errors
2026-07-28 05:18:05.420708 | 
2026-07-28 05:18:05.420839 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-28 05:18:05.921069 | instance | changed: cd+++++++++ selenium/
2026-07-28 05:18:05.931834 | 
2026-07-28 05:18:05.931894 | PLAY RECAP
2026-07-28 05:18:05.931974 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-07-28 05:18:05.932000 | 
2026-07-28 05:18:06.124713 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-28 05:18:06.129242 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-28 05:18:06.778236 | 
2026-07-28 05:18:06.778376 | PLAY [all]
2026-07-28 05:18:06.790059 | 
2026-07-28 05:18:06.790139 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-28 05:18:06.836010 | instance | skipping: Conditional result was False
2026-07-28 05:18:06.846893 | 
2026-07-28 05:18:06.847056 | TASK [fetch-output : Set log path for single node]
2026-07-28 05:18:06.893227 | instance | ok
2026-07-28 05:18:06.900900 | 
2026-07-28 05:18:06.900988 | LOOP [fetch-output : Ensure local output dirs]
2026-07-28 05:18:07.277970 | instance -> localhost | ok: "/var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/logs"
2026-07-28 05:18:07.491605 | instance -> localhost | changed: "/var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/artifacts"
2026-07-28 05:18:07.707948 | instance -> localhost | changed: "/var/lib/zuul/builds/5baf9710df8d4d11913bc3d3ca32deec/work/docs"
2026-07-28 05:18:07.727415 | 
2026-07-28 05:18:07.727558 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-28 05:18:08.368695 | instance | changed: .d..t...... ./
2026-07-28 05:18:08.369038 | instance | changed: All items complete
2026-07-28 05:18:08.369092 | 
2026-07-28 05:18:08.805898 | instance | changed: .d..t...... ./
2026-07-28 05:18:09.242048 | instance | changed: .d..t...... ./
2026-07-28 05:18:09.265927 | 
2026-07-28 05:18:09.266070 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-28 05:18:09.674493 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006881
2026-07-28 05:18:09.906180 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006985
2026-07-28 05:18:09.920704 | 
2026-07-28 05:18:09.920832 | PLAY [all]
2026-07-28 05:18:09.928634 | 
2026-07-28 05:18:09.928702 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-28 05:18:10.327321 | instance | changed
2026-07-28 05:18:10.373287 | 
2026-07-28 05:18:10.373363 | PLAY RECAP
2026-07-28 05:18:10.373410 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-28 05:18:10.373432 | 
2026-07-28 05:18:10.557519 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-28 05:18:10.562190 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-28 05:18:11.223368 | 
2026-07-28 05:18:11.223506 | PLAY [localhost]
2026-07-28 05:18:11.234173 | 
2026-07-28 05:18:11.234247 | TASK [Generate Zuul manifest]
2026-07-28 05:18:11.252283 | localhost | ok
2026-07-28 05:18:11.267302 | 
2026-07-28 05:18:11.267390 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-28 05:18:11.630375 | localhost | changed
2026-07-28 05:18:11.647585 | 
2026-07-28 05:18:11.647837 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-28 05:18:11.680486 | localhost | ok
2026-07-28 05:18:11.691506 | 
2026-07-28 05:18:11.691602 | TASK [Upload logs]
2026-07-28 05:18:11.712039 | localhost | ok
2026-07-28 05:18:11.776626 | 
2026-07-28 05:18:11.776721 | TASK [Set zuul-log-path fact]
2026-07-28 05:18:11.797480 | localhost | ok
2026-07-28 05:18:11.812903 | 
2026-07-28 05:18:11.813030 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-28 05:18:11.841305 | localhost | ok
2026-07-28 05:18:11.848716 | 
2026-07-28 05:18:11.848782 | TASK [upload-logs : Create log directories]
2026-07-28 05:18:12.259106 | localhost | changed
2026-07-28 05:18:12.265958 | 
2026-07-28 05:18:12.266044 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-28 05:18:12.730647 | localhost -> localhost | ok: Runtime: 0:00:00.006003
2026-07-28 05:18:12.760484 | 
2026-07-28 05:18:12.760598 | TASK [upload-logs : Upload logs to log server]
2026-07-28 05:18:13.276612 | localhost | Output suppressed because no_log was given
2026-07-28 05:18:13.282565 | 
2026-07-28 05:18:13.282624 | LOOP [upload-logs : Compress console log and json output]
2026-07-28 05:18:13.326032 | localhost | skipping: Conditional result was False
2026-07-28 05:18:13.333215 | localhost | skipping: Conditional result was False
2026-07-28 05:18:13.343705 | 
2026-07-28 05:18:13.343803 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-28 05:18:13.383008 | localhost | skipping: Conditional result was False
2026-07-28 05:18:13.383316 | 
2026-07-28 05:18:13.388616 | localhost | skipping: Conditional result was False
2026-07-28 05:18:13.406049 | 
2026-07-28 05:18:13.406206 | LOOP [upload-logs : Upload console log and json output]