2026-08-14 09:00:07.574402 | Job console starting 2026-08-14 09:00:07.590700 | Updating git repos 2026-08-14 09:00:09.634542 | Cloning repos into workspace 2026-08-14 09:01:07.200550 | Restoring repo states 2026-08-14 09:01:15.041125 | Merging changes 2026-08-14 09:01:17.713400 | Checking out repos 2026-08-14 09:01:29.524030 | Preparing playbooks 2026-08-14 09:01:41.042815 | Running Ansible setup 2026-08-14 09:01:45.295024 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-14 09:01:45.995662 | 2026-08-14 09:01:45.995851 | PLAY [localhost] 2026-08-14 09:01:46.005076 | 2026-08-14 09:01:46.005184 | TASK [Gathering Facts] 2026-08-14 09:01:47.503210 | localhost | ok 2026-08-14 09:01:47.513501 | 2026-08-14 09:01:47.513642 | TASK [Setup log path fact] 2026-08-14 09:01:47.545650 | localhost | ok 2026-08-14 09:01:47.558560 | 2026-08-14 09:01:47.558705 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-14 09:01:47.592116 | localhost | ok 2026-08-14 09:01:47.599490 | 2026-08-14 09:01:47.599561 | TASK [emit-job-header : Print job information] 2026-08-14 09:01:47.643447 | # Job Information 2026-08-14 09:01:47.643703 | Ansible Version: 2.16.18 2026-08-14 09:01:47.643753 | Job: atmosphere-molecule-csi-rbd 2026-08-14 09:01:47.643785 | Pipeline: check 2026-08-14 09:01:47.643813 | Executor: 2d72f0692154 2026-08-14 09:01:47.643841 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3864 2026-08-14 09:01:47.643877 | Event ID: 3dfc75f0-97bb-11f1-888e-d5c685d976b3 2026-08-14 09:01:47.648162 | 2026-08-14 09:01:47.648260 | LOOP [emit-job-header : Print node information] 2026-08-14 09:01:47.747943 | localhost | ok: 2026-08-14 09:01:47.748331 | localhost | # Node Information 2026-08-14 09:01:47.748413 | localhost | Inventory Hostname: instance 2026-08-14 09:01:47.748472 | localhost | Hostname: np0000189650 2026-08-14 09:01:47.748527 | localhost | Username: zuul 2026-08-14 09:01:47.748587 | localhost | Distro: Ubuntu 22.04 2026-08-14 09:01:47.748643 | localhost | Provider: yul1 2026-08-14 09:01:47.748695 | localhost | Region: ca-ymq-1 2026-08-14 09:01:47.748745 | localhost | Label: ubuntu-jammy 2026-08-14 09:01:47.748795 | localhost | Product Name: OpenStack Nova 2026-08-14 09:01:47.748845 | localhost | Interface IP: 199.204.45.74 2026-08-14 09:01:47.765194 | 2026-08-14 09:01:47.765364 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-14 09:01:48.184737 | localhost -> localhost | changed 2026-08-14 09:01:48.194837 | 2026-08-14 09:01:48.194981 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-14 09:01:49.350115 | localhost -> localhost | changed 2026-08-14 09:01:49.362566 | 2026-08-14 09:01:49.362666 | PLAY [all] 2026-08-14 09:01:49.375946 | 2026-08-14 09:01:49.376097 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-14 09:01:49.654793 | instance -> localhost | ok 2026-08-14 09:01:49.664700 | 2026-08-14 09:01:49.664810 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-14 09:01:49.700568 | instance | ok 2026-08-14 09:01:49.719521 | instance | included: /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-14 09:01:49.726627 | 2026-08-14 09:01:49.726727 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-14 09:01:50.980166 | instance -> localhost | Generating public/private rsa key pair. 2026-08-14 09:01:50.980385 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/8a9ed5a8230448f2aa107f6f101ddff6_id_rsa 2026-08-14 09:01:50.980429 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/8a9ed5a8230448f2aa107f6f101ddff6_id_rsa.pub 2026-08-14 09:01:50.980463 | instance -> localhost | The key fingerprint is: 2026-08-14 09:01:50.980495 | instance -> localhost | SHA256:jIwmGasc8rVtvMbwiEUqMXdq3IkErI/VkGkXBJ039zE zuul-build-sshkey 2026-08-14 09:01:50.980538 | instance -> localhost | The key's randomart image is: 2026-08-14 09:01:50.980572 | instance -> localhost | +---[RSA 3072]----+ 2026-08-14 09:01:50.980608 | instance -> localhost | |. .*oo | 2026-08-14 09:01:50.980641 | instance -> localhost | |..= + o . E | 2026-08-14 09:01:50.980671 | instance -> localhost | |.o.+ . o . o | 2026-08-14 09:01:50.980702 | instance -> localhost | |+ +++o o . | 2026-08-14 09:01:50.980733 | instance -> localhost | |.@+B+.o S | 2026-08-14 09:01:50.980762 | instance -> localhost | |=oO+=+ | 2026-08-14 09:01:50.980791 | instance -> localhost | |.+.o.=+ | 2026-08-14 09:01:50.980820 | instance -> localhost | | . ..+. | 2026-08-14 09:01:50.980853 | instance -> localhost | | .. | 2026-08-14 09:01:50.980883 | instance -> localhost | +----[SHA256]-----+ 2026-08-14 09:01:50.980991 | instance -> localhost | ok: Runtime: 0:00:00.526272 2026-08-14 09:01:50.989793 | 2026-08-14 09:01:50.989889 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-14 09:01:51.025159 | instance | ok 2026-08-14 09:01:51.034831 | instance | included: /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-14 09:01:51.042579 | 2026-08-14 09:01:51.042667 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-14 09:01:51.080361 | instance | skipping: Conditional result was False 2026-08-14 09:01:51.091958 | 2026-08-14 09:01:51.155871 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-14 09:01:52.646389 | instance | changed 2026-08-14 09:01:52.657485 | 2026-08-14 09:01:53.520044 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-14 09:01:53.785903 | instance | ok 2026-08-14 09:01:53.793599 | 2026-08-14 09:01:53.793728 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-14 09:01:54.315837 | instance | changed 2026-08-14 09:01:54.323126 | 2026-08-14 09:01:54.323280 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-14 09:01:54.786375 | instance | changed 2026-08-14 09:01:54.799666 | 2026-08-14 09:01:54.799866 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-14 09:01:54.825046 | instance | skipping: Conditional result was False 2026-08-14 09:01:54.836343 | 2026-08-14 09:01:54.836442 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-14 09:01:55.248881 | instance -> localhost | changed 2026-08-14 09:01:55.263117 | 2026-08-14 09:01:55.263289 | TASK [add-build-sshkey : Add back temp key] 2026-08-14 09:01:55.575510 | instance -> localhost | Identity added: /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/8a9ed5a8230448f2aa107f6f101ddff6_id_rsa (zuul-build-sshkey) 2026-08-14 09:01:55.575734 | instance -> localhost | ok: Runtime: 0:00:00.014220 2026-08-14 09:01:55.581010 | 2026-08-14 09:01:55.581077 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-14 09:01:55.875503 | instance | ok 2026-08-14 09:01:55.880110 | 2026-08-14 09:01:55.880180 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-14 09:01:55.904845 | instance | skipping: Conditional result was False 2026-08-14 09:01:55.914659 | 2026-08-14 09:01:55.914746 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-14 09:01:56.265854 | instance | ok 2026-08-14 09:01:56.271802 | 2026-08-14 09:01:56.271878 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-14 09:02:08.011737 | instance | Output suppressed because no_log was given 2026-08-14 09:02:08.024374 | 2026-08-14 09:02:08.024445 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-14 09:02:08.233016 | instance | ok: "logs" 2026-08-14 09:02:08.233499 | instance | ok: All items complete 2026-08-14 09:02:08.233585 | 2026-08-14 09:02:08.381507 | instance | ok: "artifacts" 2026-08-14 09:02:08.541395 | instance | ok: "docs" 2026-08-14 09:02:08.561393 | 2026-08-14 09:02:08.561591 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-14 09:02:08.751141 | instance | changed: "logs" 2026-08-14 09:02:08.910504 | instance | changed: "artifacts" 2026-08-14 09:02:09.055317 | instance | changed: "docs" 2026-08-14 09:02:09.072780 | 2026-08-14 09:02:09.072907 | PLAY RECAP 2026-08-14 09:02:09.072976 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-14 09:02:09.073009 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:02:09.073033 | 2026-08-14 09:02:09.218992 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-14 09:02:09.905753 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-14 09:02:11.526707 | 2026-08-14 09:02:11.526851 | PLAY [all] 2026-08-14 09:02:11.538531 | 2026-08-14 09:02:11.538650 | TASK [setup-uv : Extract archive] 2026-08-14 09:02:13.788647 | instance | changed 2026-08-14 09:02:13.796820 | 2026-08-14 09:02:13.796989 | TASK [setup-uv : Print version] 2026-08-14 09:02:14.154933 | instance | uv 0.8.13 2026-08-14 09:02:14.860009 | instance | ok: Runtime: 0:00:00.008948 2026-08-14 09:02:14.875303 | 2026-08-14 09:02:14.875539 | TASK [Install Ansible collection siblings] 2026-08-14 09:02:23.476214 | instance | changed: 2026-08-14 09:02:23.476592 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-14 09:02:23.476658 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-14 09:02:23.476694 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-14 09:02:23.476724 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-14 09:02:23.476752 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-14 09:02:23.476785 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-14 09:02:23.476815 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-14 09:02:23.476846 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-14 09:02:23.476874 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-14 09:02:23.476901 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-14 09:02:23.476928 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-14 09:02:23.476981 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-14 09:02:23.477015 | instance | Resolved ansible.netcommon to v8.5.0 for 8.5.0 2026-08-14 09:02:23.477050 | instance | Resolved ansible.posix to 2.1.0 for 2.1.0 2026-08-14 09:02:23.477091 | instance | Resolved ansible.utils to v6.1.0 for >=6.0.0,>=3.0.0 2026-08-14 09:02:23.477129 | instance | Resolved community.crypto to 3.2.0 for 3.2.0 2026-08-14 09:02:23.477158 | instance | Resolved community.general to 12.6.0 for 12.6.0 2026-08-14 09:02:23.477185 | instance | Resolved community.mysql to 4.2.0 for 4.2.0 2026-08-14 09:02:23.477211 | instance | Resolved kubernetes.core to 6.3.0 for 6.3.0 2026-08-14 09:02:23.477237 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-14 09:02:23.477290 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-14 09:02:23.477316 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-14 09:02:23.477344 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-14 09:02:23.477422 | instance | Resolved ansible.utils to v6.1.0 for >=6.0.0,>=3.0.0 2026-08-14 09:02:23.477468 | instance | Resolved community.general to 12.6.0 for 12.6.0,>=4.5.0 2026-08-14 09:02:23.477498 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-14 09:02:23.477525 | instance | Resolved kubernetes.core to 6.3.0 for 6.3.0,>=2.4.0,>=2.3.2 2026-08-14 09:02:23.477574 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-14 09:02:23.477624 | instance | Resolved ansible.posix to 2.1.0 for 2.1.0,>=1.6.0 2026-08-14 09:02:23.477654 | instance | Resolved community.crypto to 3.2.0 for 3.2.0,>=2.2.3 2026-08-14 09:02:23.477680 | instance | Resolved kubernetes.core to 6.3.0 for 6.3.0,>=2.4.0,>=2.3.2 2026-08-14 09:02:23.477715 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-14 09:02:23.477779 | instance | Checked out ansible.netcommon to v8.5.0 2026-08-14 09:02:23.477812 | 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-14 09:02:23.477851 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.477878 | instance | Process install dependency map 2026-08-14 09:02:23.477905 | instance | Starting collection install process 2026-08-14 09:02:23.477931 | instance | Installing 'ansible.netcommon:8.5.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-14 09:02:23.477957 | instance | Created collection for ansible.netcommon:8.5.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-14 09:02:23.477983 | instance | ansible.netcommon:8.5.0 was installed successfully 2026-08-14 09:02:23.478008 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-14 09:02:23.478033 | instance | Creating virtual environment at: .venv 2026-08-14 09:02:23.478058 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-14 09:02:23.478084 | instance | Downloading kubernetes (1.9MiB) 2026-08-14 09:02:23.478109 | instance | Downloading netaddr (2.2MiB) 2026-08-14 09:02:23.478160 | instance | Downloading ansible-core (2.1MiB) 2026-08-14 09:02:23.478211 | instance | Downloading pydantic-core (2.0MiB) 2026-08-14 09:02:23.478242 | instance | Downloading pygments (1.2MiB) 2026-08-14 09:02:23.478269 | instance | Downloading openstacksdk (1.7MiB) 2026-08-14 09:02:23.478295 | instance | Downloading setuptools (1.1MiB) 2026-08-14 09:02:23.478323 | instance | Downloading cryptography (4.2MiB) 2026-08-14 09:02:23.478350 | instance | Downloading rjsonnet (1.2MiB) 2026-08-14 09:02:23.478376 | instance | Building pyperclip==1.9.0 2026-08-14 09:02:23.478405 | instance | Downloading rjsonnet 2026-08-14 09:02:23.478471 | instance | Downloading pydantic-core 2026-08-14 09:02:23.478539 | instance | Downloading netaddr 2026-08-14 09:02:23.478608 | instance | Downloading pygments 2026-08-14 09:02:23.478647 | instance | Downloading cryptography 2026-08-14 09:02:23.478676 | instance | Downloading setuptools 2026-08-14 09:02:23.478704 | instance | Downloading kubernetes 2026-08-14 09:02:23.478733 | instance | Downloading ansible-core 2026-08-14 09:02:23.478761 | instance | Downloading openstacksdk 2026-08-14 09:02:23.478789 | instance | Built pyperclip==1.9.0 2026-08-14 09:02:23.478815 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-14 09:02:23.478842 | instance | Installed 83 packages in 31ms 2026-08-14 09:02:23.478870 | instance | Checked out ansible.posix to 2.1.0 2026-08-14 09:02:23.478933 | 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-14 09:02:23.478986 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.479019 | instance | Process install dependency map 2026-08-14 09:02:23.479066 | instance | Starting collection install process 2026-08-14 09:02:23.479165 | instance | Installing 'ansible.posix:2.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-14 09:02:23.479200 | instance | Created collection for ansible.posix:2.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-14 09:02:23.479227 | instance | ansible.posix:2.1.0 was installed successfully 2026-08-14 09:02:23.479257 | instance | Checked out ansible.utils to v6.1.0 2026-08-14 09:02:23.479294 | 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-14 09:02:23.479324 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.479351 | instance | Process install dependency map 2026-08-14 09:02:23.479378 | instance | Starting collection install process 2026-08-14 09:02:23.479405 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-14 09:02:23.479431 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-14 09:02:23.479460 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-14 09:02:23.479488 | instance | Checked out atmosphere.common to v0.7.0 2026-08-14 09:02:23.479514 | 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-14 09:02:23.479545 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.479620 | instance | Process install dependency map 2026-08-14 09:02:23.479679 | instance | Starting collection install process 2026-08-14 09:02:23.479710 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-14 09:02:23.479738 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-14 09:02:23.479765 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-14 09:02:23.479792 | instance | Checked out community.crypto to 3.2.0 2026-08-14 09:02:23.479818 | 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-14 09:02:23.479845 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.479870 | instance | Process install dependency map 2026-08-14 09:02:23.479896 | instance | Starting collection install process 2026-08-14 09:02:23.479922 | instance | Installing 'community.crypto:3.2.0' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-14 09:02:23.479948 | instance | Created collection for community.crypto:3.2.0 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-14 09:02:23.479974 | instance | community.crypto:3.2.0 was installed successfully 2026-08-14 09:02:23.480080 | instance | Checked out community.general to 12.6.0 2026-08-14 09:02:23.480127 | 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-14 09:02:23.480158 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.480187 | instance | Process install dependency map 2026-08-14 09:02:23.480213 | instance | Starting collection install process 2026-08-14 09:02:23.480240 | instance | Installing 'community.general:12.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-14 09:02:23.480266 | instance | Created collection for community.general:12.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-14 09:02:23.480303 | instance | community.general:12.6.0 was installed successfully 2026-08-14 09:02:23.480331 | instance | Checked out community.mysql to 4.2.0 2026-08-14 09:02:23.480364 | 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-14 09:02:23.480397 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.480425 | instance | Process install dependency map 2026-08-14 09:02:23.480452 | instance | Starting collection install process 2026-08-14 09:02:23.480477 | instance | Installing 'community.mysql:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-14 09:02:23.480503 | instance | Created collection for community.mysql:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-14 09:02:23.480536 | instance | community.mysql:4.2.0 was installed successfully 2026-08-14 09:02:23.480572 | instance | Checked out kubernetes.core to 6.3.0 2026-08-14 09:02:23.480600 | 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-14 09:02:23.480628 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.480658 | instance | Process install dependency map 2026-08-14 09:02:23.480687 | instance | Starting collection install process 2026-08-14 09:02:23.480713 | instance | Installing 'kubernetes.core:6.3.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-14 09:02:23.480740 | instance | Created collection for kubernetes.core:6.3.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-14 09:02:23.480766 | instance | kubernetes.core:6.3.0 was installed successfully 2026-08-14 09:02:23.480792 | instance | Checked out openstack.cloud to 2.6.0 2026-08-14 09:02:23.480818 | 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-14 09:02:23.480845 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.480871 | instance | Process install dependency map 2026-08-14 09:02:23.480900 | instance | Starting collection install process 2026-08-14 09:02:23.480936 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-14 09:02:23.480990 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-14 09:02:23.481021 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-14 09:02:23.481048 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-14 09:02:23.481076 | 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-14 09:02:23.481103 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.481129 | instance | Process install dependency map 2026-08-14 09:02:23.481155 | instance | Starting collection install process 2026-08-14 09:02:23.481181 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-14 09:02:23.481207 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-14 09:02:23.481233 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-14 09:02:23.481258 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-14 09:02:23.481284 | 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-14 09:02:23.481309 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.481344 | instance | Process install dependency map 2026-08-14 09:02:23.481370 | instance | Starting collection install process 2026-08-14 09:02:23.481400 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-14 09:02:23.481434 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-14 09:02:23.481462 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-14 09:02:23.481487 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-14 09:02:23.481513 | 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-14 09:02:23.481538 | instance | Starting galaxy collection install process 2026-08-14 09:02:23.481563 | instance | Process install dependency map 2026-08-14 09:02:23.481588 | instance | Starting collection install process 2026-08-14 09:02:23.481613 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-14 09:02:23.481638 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-14 09:02:23.481663 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-14 09:02:23.488719 | 2026-08-14 09:02:23.488927 | PLAY RECAP 2026-08-14 09:02:23.489057 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:02:23.489099 | 2026-08-14 09:02:23.642314 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-14 09:02:23.644331 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-14 09:02:24.367859 | 2026-08-14 09:02:24.367993 | PLAY [all] 2026-08-14 09:02:24.379263 | 2026-08-14 09:02:24.379339 | TASK [Install "jq" for log collection] 2026-08-14 09:03:25.598849 | instance | changed 2026-08-14 09:03:25.601606 | 2026-08-14 09:03:25.601688 | PLAY RECAP 2026-08-14 09:03:25.601758 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:03:25.601913 | 2026-08-14 09:03:25.733079 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-14 09:03:25.737435 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-14 09:03:26.614892 | 2026-08-14 09:03:26.615035 | PLAY [all] 2026-08-14 09:03:26.627957 | 2026-08-14 09:03:26.628098 | LOOP [Check inventory directories] 2026-08-14 09:03:26.988719 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-14 09:03:27.137604 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-14 09:03:27.283261 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-14 09:03:27.299247 | 2026-08-14 09:03:27.299432 | LOOP [Copy inventory file for Zuul] 2026-08-14 09:03:28.085131 | instance | changed: 2026-08-14 09:03:28.085391 | instance | { 2026-08-14 09:03:28.085432 | instance | "ansible_loop_var": "item", 2026-08-14 09:03:28.085464 | instance | "changed": false, 2026-08-14 09:03:28.085492 | instance | "failed": false, 2026-08-14 09:03:28.085529 | instance | "invocation": { 2026-08-14 09:03:28.085582 | instance | "module_args": { 2026-08-14 09:03:28.085626 | instance | "checksum_algorithm": "sha1", 2026-08-14 09:03:28.085653 | instance | "follow": true, 2026-08-14 09:03:28.085679 | instance | "get_attributes": true, 2026-08-14 09:03:28.085707 | instance | "get_checksum": true, 2026-08-14 09:03:28.085732 | instance | "get_mime": true, 2026-08-14 09:03:28.085757 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-14 09:03:28.085802 | instance | } 2026-08-14 09:03:28.085828 | instance | }, 2026-08-14 09:03:28.085852 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-14 09:03:28.085876 | instance | "stat": { 2026-08-14 09:03:28.085899 | instance | "atime": 1786698136.6364572, 2026-08-14 09:03:28.085924 | instance | "attr_flags": "e", 2026-08-14 09:03:28.085949 | instance | "attributes": [ 2026-08-14 09:03:28.085973 | instance | "extents" 2026-08-14 09:03:28.085996 | instance | ], 2026-08-14 09:03:28.086019 | instance | "block_size": 4096, 2026-08-14 09:03:28.086043 | instance | "blocks": 8, 2026-08-14 09:03:28.086066 | instance | "charset": "unknown", 2026-08-14 09:03:28.086092 | instance | "ctime": 1786698135.6444235, 2026-08-14 09:03:28.086116 | instance | "dev": 64513, 2026-08-14 09:03:28.086140 | instance | "device_type": 0, 2026-08-14 09:03:28.086163 | instance | "executable": true, 2026-08-14 09:03:28.086188 | instance | "exists": true, 2026-08-14 09:03:28.086212 | instance | "gid": 1000, 2026-08-14 09:03:28.086235 | instance | "gr_name": "zuul", 2026-08-14 09:03:28.086259 | instance | "inode": 1047438, 2026-08-14 09:03:28.086286 | instance | "isblk": false, 2026-08-14 09:03:28.086312 | instance | "ischr": false, 2026-08-14 09:03:28.086335 | instance | "isdir": true, 2026-08-14 09:03:28.086359 | instance | "isfifo": false, 2026-08-14 09:03:28.086382 | instance | "isgid": false, 2026-08-14 09:03:28.086406 | instance | "islnk": false, 2026-08-14 09:03:28.086429 | instance | "isreg": false, 2026-08-14 09:03:28.086453 | instance | "issock": false, 2026-08-14 09:03:28.086476 | instance | "isuid": false, 2026-08-14 09:03:28.086521 | instance | "mimetype": "unknown", 2026-08-14 09:03:28.086566 | instance | "mode": "0755", 2026-08-14 09:03:28.086636 | instance | "mtime": 1786698135.6444235, 2026-08-14 09:03:28.086695 | instance | "nlink": 25, 2026-08-14 09:03:28.086737 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-14 09:03:28.086777 | instance | "pw_name": "zuul", 2026-08-14 09:03:28.086816 | instance | "readable": true, 2026-08-14 09:03:28.086853 | instance | "rgrp": true, 2026-08-14 09:03:28.086888 | instance | "roth": true, 2026-08-14 09:03:28.086926 | instance | "rusr": true, 2026-08-14 09:03:28.086960 | instance | "size": 4096, 2026-08-14 09:03:28.086995 | instance | "uid": 1000, 2026-08-14 09:03:28.087030 | instance | "version": "3027330747", 2026-08-14 09:03:28.087056 | instance | "wgrp": false, 2026-08-14 09:03:28.087084 | instance | "woth": false, 2026-08-14 09:03:28.087109 | instance | "writeable": true, 2026-08-14 09:03:28.087134 | instance | "wusr": true, 2026-08-14 09:03:28.087158 | instance | "xgrp": true, 2026-08-14 09:03:28.087184 | instance | "xoth": true, 2026-08-14 09:03:28.087218 | instance | "xusr": true 2026-08-14 09:03:28.087252 | instance | } 2026-08-14 09:03:28.087287 | instance | } 2026-08-14 09:03:28.087348 | instance | ok: All items complete 2026-08-14 09:03:28.087381 | 2026-08-14 09:03:28.089654 | instance | skipping: Conditional result was False 2026-08-14 09:03:28.090486 | instance | skipping: Conditional result was False 2026-08-14 09:03:28.113097 | 2026-08-14 09:03:28.113212 | LOOP [Switch "ansible_host" to private IP] 2026-08-14 09:03:28.510910 | instance | changed: 1 replacements made 2026-08-14 09:03:28.512885 | instance | skipping: Conditional result was False 2026-08-14 09:03:28.517918 | instance | skipping: Conditional result was False 2026-08-14 09:03:28.535943 | 2026-08-14 09:03:28.536098 | TASK [Run Molecule scenario] 2026-08-14 09:03:29.470183 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-14 09:03:29.856897 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-14 09:03:29.856953 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-14 09:03:40.184112 | instance | INFO [csi > dependency] Executing 2026-08-14 09:03:40.184384 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-14 09:03:40.184634 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-14 09:03:40.184832 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-14 09:03:40.193507 | instance | INFO [csi > cleanup] Executing 2026-08-14 09:03:40.193818 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-14 09:03:40.201310 | instance | INFO [csi > destroy] Executing 2026-08-14 09:03:40.201388 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-14 09:03:40.201460 | instance | INFO [csi > destroy] Executed: Successful 2026-08-14 09:03:40.208928 | instance | INFO [csi > syntax] Executing 2026-08-14 09:03:40.820087 | instance | [WARNING]: provided hosts list is empty, only localhost is available. Note that 2026-08-14 09:03:40.820366 | instance | the implicit localhost does not match 'all' 2026-08-14 09:03:40.949018 | instance | 2026-08-14 09:03:40.949306 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-14 09:03:40.986612 | instance | INFO [csi > syntax] Executed: Successful 2026-08-14 09:03:40.997514 | instance | INFO [csi > create] Executing 2026-08-14 09:03:40.999336 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-14 09:03:41.006795 | instance | INFO [csi > prepare] Executing 2026-08-14 09:03:41.704754 | instance | [WARNING]: provided hosts list is empty, only localhost is available. Note that 2026-08-14 09:03:41.705024 | instance | the implicit localhost does not match 'all' 2026-08-14 09:03:41.816597 | instance | [WARNING]: Could not match supplied host pattern, ignoring: cephs 2026-08-14 09:03:41.816942 | instance | 2026-08-14 09:03:41.817209 | instance | PLAY [Prepare] ***************************************************************** 2026-08-14 09:03:41.817581 | instance | skipping: no hosts matched 2026-08-14 09:03:41.817857 | instance | 2026-08-14 09:03:41.818173 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-14 09:03:41.818409 | instance | skipping: no hosts matched 2026-08-14 09:03:41.818678 | instance | 2026-08-14 09:03:41.818985 | instance | PLAY RECAP ********************************************************************* 2026-08-14 09:03:41.819293 | instance | 2026-08-14 09:03:41.819630 | instance | 2026-08-14 09:03:41.819986 | instance | TASKS RECAP ******************************************************************** 2026-08-14 09:03:41.820345 | instance | Friday 14 August 2026 09:03:41 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-08-14 09:03:41.820700 | instance | =============================================================================== 2026-08-14 09:03:41.858283 | instance | INFO [csi > prepare] Executed: Successful 2026-08-14 09:03:41.868805 | instance | INFO [csi > converge] Executing 2026-08-14 09:03:42.465197 | instance | [WARNING]: provided hosts list is empty, only localhost is available. Note that 2026-08-14 09:03:42.465401 | instance | the implicit localhost does not match 'all' 2026-08-14 09:03:42.527035 | instance | 2026-08-14 09:03:42.527111 | instance | PLAY [all] ********************************************************************* 2026-08-14 09:03:42.527241 | instance | skipping: no hosts matched 2026-08-14 09:03:42.527330 | instance | 2026-08-14 09:03:42.527448 | instance | PLAY RECAP ********************************************************************* 2026-08-14 09:03:42.527560 | instance | 2026-08-14 09:03:42.527664 | instance | 2026-08-14 09:03:42.527799 | instance | TASKS RECAP ******************************************************************** 2026-08-14 09:03:42.527907 | instance | Friday 14 August 2026 09:03:42 +0000 (0:00:00.001) 0:00:00.001 ********* 2026-08-14 09:03:42.528024 | instance | =============================================================================== 2026-08-14 09:03:42.570992 | instance | INFO [csi > converge] Executed: Successful 2026-08-14 09:03:42.583080 | instance | INFO [csi > idempotence] Executing 2026-08-14 09:03:43.169109 | instance | [WARNING]: provided hosts list is empty, only localhost is available. Note that 2026-08-14 09:03:43.169443 | instance | the implicit localhost does not match 'all' 2026-08-14 09:03:43.230139 | instance | 2026-08-14 09:03:43.230378 | instance | PLAY [all] ********************************************************************* 2026-08-14 09:03:43.230642 | instance | skipping: no hosts matched 2026-08-14 09:03:43.230890 | instance | 2026-08-14 09:03:43.231154 | instance | PLAY RECAP ********************************************************************* 2026-08-14 09:03:43.231400 | instance | 2026-08-14 09:03:43.231658 | instance | 2026-08-14 09:03:43.231955 | instance | TASKS RECAP ******************************************************************** 2026-08-14 09:03:43.232237 | instance | Friday 14 August 2026 09:03:43 +0000 (0:00:00.001) 0:00:00.001 ********* 2026-08-14 09:03:43.232502 | instance | =============================================================================== 2026-08-14 09:03:43.270716 | instance | INFO [csi > idempotence] Executed: Successful 2026-08-14 09:03:43.282605 | instance | INFO [csi > side_effect] Executing 2026-08-14 09:03:43.282910 | instance | WARNING [csi > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-14 09:03:43.290055 | instance | INFO [csi > verify] Executing 2026-08-14 09:03:43.891255 | instance | [WARNING]: provided hosts list is empty, only localhost is available. Note that 2026-08-14 09:03:43.891517 | instance | the implicit localhost does not match 'all' 2026-08-14 09:03:43.937530 | instance | [WARNING]: Could not match supplied host pattern, ignoring: controllers 2026-08-14 09:03:43.937857 | instance | 2026-08-14 09:03:43.938130 | instance | PLAY [Verify] ****************************************************************** 2026-08-14 09:03:43.938384 | instance | skipping: no hosts matched 2026-08-14 09:03:43.938633 | instance | 2026-08-14 09:03:43.938902 | instance | PLAY RECAP ********************************************************************* 2026-08-14 09:03:43.939142 | instance | 2026-08-14 09:03:43.939377 | instance | 2026-08-14 09:03:43.939635 | instance | TASKS RECAP ******************************************************************** 2026-08-14 09:03:43.939906 | instance | Friday 14 August 2026 09:03:43 +0000 (0:00:00.001) 0:00:00.001 ********* 2026-08-14 09:03:43.940159 | instance | =============================================================================== 2026-08-14 09:03:43.976824 | instance | INFO [csi > verify] Executed: Successful 2026-08-14 09:03:43.991434 | instance | INFO [csi > cleanup] Executing 2026-08-14 09:03:43.991758 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-14 09:03:43.999111 | instance | INFO [csi > destroy] Executing 2026-08-14 09:03:43.999179 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-14 09:03:43.999258 | instance | INFO [csi > destroy] Executed: Successful 2026-08-14 09:03:43.999552 | instance | WARNING Molecule executed 1 scenario (1 missing files) 2026-08-14 09:03:47.514739 | instance | ok: Runtime: 0:00:15.148482 2026-08-14 09:03:47.518173 | 2026-08-14 09:03:47.518449 | PLAY RECAP 2026-08-14 09:03:47.518532 | instance | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:03:47.518570 | 2026-08-14 09:03:47.686758 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-14 09:03:47.689006 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-14 09:03:49.856079 | 2026-08-14 09:03:50.549101 | PLAY [all] 2026-08-14 09:03:50.571513 | 2026-08-14 09:03:50.571678 | TASK [gather-host-logs : creating directory for system status] 2026-08-14 09:03:50.933665 | instance | changed 2026-08-14 09:03:50.939020 | 2026-08-14 09:03:50.939107 | TASK [gather-host-logs : Get logs for each host] 2026-08-14 09:03:51.290547 | instance | + systemd-cgls --full --all --no-pager 2026-08-14 09:03:51.300753 | instance | + ip addr 2026-08-14 09:03:51.302250 | instance | + ip route 2026-08-14 09:03:51.303683 | instance | + lsblk 2026-08-14 09:03:51.306204 | instance | + mount 2026-08-14 09:03:51.307401 | instance | + docker images 2026-08-14 09:03:51.307834 | instance | /bin/bash: line 7: docker: command not found 2026-08-14 09:03:51.308023 | instance | + brctl show 2026-08-14 09:03:51.308352 | instance | /bin/bash: line 8: brctl: command not found 2026-08-14 09:03:51.308499 | instance | + ps aux --sort=-%mem 2026-08-14 09:03:51.320317 | instance | + dpkg -l 2026-08-14 09:03:51.327695 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-14 09:03:51.328015 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-14 09:03:51.328066 | instance | /bin/bash: line 11: docker: command not found 2026-08-14 09:03:51.328301 | instance | + '[' '!' -z '' ']' 2026-08-14 09:03:51.479328 | instance | ok: Runtime: 0:00:00.042553 2026-08-14 09:03:51.486665 | 2026-08-14 09:03:51.486746 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-14 09:03:52.163987 | instance | changed: 2026-08-14 09:03:52.164179 | instance | created directory /var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/logs/instance 2026-08-14 09:03:52.164209 | instance | cd+++++++++ system/ 2026-08-14 09:03:52.164231 | instance | >f+++++++++ system/brctl-show.txt 2026-08-14 09:03:52.164252 | instance | >f+++++++++ system/docker-images.txt 2026-08-14 09:03:52.164272 | instance | >f+++++++++ system/ip-addr.txt 2026-08-14 09:03:52.164295 | instance | >f+++++++++ system/ip-route.txt 2026-08-14 09:03:52.164316 | instance | >f+++++++++ system/lsblk.txt 2026-08-14 09:03:52.164337 | instance | >f+++++++++ system/mount.txt 2026-08-14 09:03:52.164359 | instance | >f+++++++++ system/packages.txt 2026-08-14 09:03:52.164380 | instance | >f+++++++++ system/ps.txt 2026-08-14 09:03:52.164399 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-14 09:03:52.174018 | 2026-08-14 09:03:52.174094 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-14 09:03:52.370499 | instance | changed: "values" 2026-08-14 09:03:52.542668 | instance | changed: "releases" 2026-08-14 09:03:52.558657 | 2026-08-14 09:03:52.558847 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-14 09:03:52.774176 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-14 09:03:53.098425 | instance | ok: Runtime: 0:00:00.006662 2026-08-14 09:03:53.105847 | 2026-08-14 09:03:53.105992 | TASK [helm-release-status : Downloads logs to executor] 2026-08-14 09:03:53.618477 | instance | changed: 2026-08-14 09:03:53.618669 | instance | cd+++++++++ helm/ 2026-08-14 09:03:53.618709 | instance | cd+++++++++ helm/releases/ 2026-08-14 09:03:53.618743 | instance | cd+++++++++ helm/values/ 2026-08-14 09:03:53.630916 | 2026-08-14 09:03:53.631050 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-14 09:03:53.841285 | instance | changed 2026-08-14 09:03:53.849954 | 2026-08-14 09:03:53.850107 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-14 09:03:54.113816 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-14 09:03:54.113986 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-14 09:03:54.119179 | instance | environment: line 1: kubectl: command not found 2026-08-14 09:03:54.120782 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-14 09:03:54.121806 | instance | environment: line 1: kubectl: command not found 2026-08-14 09:03:54.122742 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-14 09:03:54.126054 | instance | environment: line 1: kubectl: command not found 2026-08-14 09:03:54.126448 | instance | environment: line 1: kubectl: command not found 2026-08-14 09:03:54.127568 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-14 09:03:54.127966 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-14 09:03:54.130945 | instance | environment: line 1: kubectl: command not found 2026-08-14 09:03:54.132031 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-14 09:03:54.389832 | instance | ok: Runtime: 0:00:00.029715 2026-08-14 09:03:54.396768 | 2026-08-14 09:03:54.396854 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-14 09:03:54.600423 | instance | changed 2026-08-14 09:03:54.607537 | 2026-08-14 09:03:54.607621 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-14 09:03:54.815714 | instance | environment: line 5: kubectl: command not found 2026-08-14 09:03:54.816248 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-14 09:03:54.816959 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-14 09:03:54.817446 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-14 09:03:55.144751 | instance | ok: Runtime: 0:00:00.009686 2026-08-14 09:03:55.151491 | 2026-08-14 09:03:55.151567 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-14 09:03:55.659846 | instance | changed: 2026-08-14 09:03:55.660040 | instance | cd+++++++++ objects/ 2026-08-14 09:03:55.660068 | instance | cd+++++++++ objects/cluster/ 2026-08-14 09:03:55.660090 | instance | cd+++++++++ objects/namespaced/ 2026-08-14 09:03:55.670118 | 2026-08-14 09:03:55.670190 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-14 09:03:55.878838 | instance | changed 2026-08-14 09:03:55.885360 | 2026-08-14 09:03:55.885439 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-14 09:03:56.430361 | instance | changed 2026-08-14 09:03:56.435461 | 2026-08-14 09:03:56.435566 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-14 09:03:56.661519 | instance | environment: line 3: kubectl: command not found 2026-08-14 09:03:56.975763 | instance | ok: Runtime: 0:00:00.009252 2026-08-14 09:03:56.982791 | 2026-08-14 09:03:56.982864 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-14 09:03:57.479215 | instance | changed: 2026-08-14 09:03:57.479398 | instance | cd+++++++++ pod-logs/ 2026-08-14 09:03:57.479443 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-14 09:03:57.489054 | 2026-08-14 09:03:57.489126 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-14 09:03:57.682613 | instance | changed 2026-08-14 09:03:57.687937 | 2026-08-14 09:03:57.688087 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-14 09:03:57.894230 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-14 09:03:58.221123 | instance | ok: Runtime: 0:00:00.037196 2026-08-14 09:03:58.226217 | 2026-08-14 09:03:58.226320 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-14 09:03:58.443261 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-14 09:03:58.476240 | instance | ceph-mgr endpoints: 2026-08-14 09:03:58.776722 | instance | ok: Runtime: 0:00:00.037248 2026-08-14 09:03:58.782451 | 2026-08-14 09:03:58.782526 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-14 09:03:58.989594 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-14 09:03:59.319359 | instance | ok: Runtime: 0:00:00.034612 2026-08-14 09:03:59.325031 | 2026-08-14 09:03:59.325099 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-14 09:03:59.817125 | instance | changed: cd+++++++++ prometheus/ 2026-08-14 09:04:00.093437 | 2026-08-14 09:04:00.093606 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-14 09:04:00.304997 | instance | changed 2026-08-14 09:04:00.311031 | 2026-08-14 09:04:00.311104 | TASK [gather-selenium-data : Get selenium data] 2026-08-14 09:04:00.584794 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-14 09:04:00.586261 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-14 09:04:00.844621 | instance | ERROR 2026-08-14 09:04:00.844875 | instance | { 2026-08-14 09:04:00.844923 | instance | "delta": "0:00:00.006276", 2026-08-14 09:04:00.844977 | instance | "end": "2026-08-14 09:04:00.586591", 2026-08-14 09:04:00.845011 | instance | "msg": "non-zero return code", 2026-08-14 09:04:00.845040 | instance | "rc": 1, 2026-08-14 09:04:00.845068 | instance | "start": "2026-08-14 09:04:00.580315" 2026-08-14 09:04:00.845095 | instance | } 2026-08-14 09:04:00.845132 | instance | ERROR: Ignoring Errors 2026-08-14 09:04:00.851426 | 2026-08-14 09:04:00.851512 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-14 09:04:01.356372 | instance | changed: cd+++++++++ selenium/ 2026-08-14 09:04:01.362929 | 2026-08-14 09:04:01.362995 | PLAY RECAP 2026-08-14 09:04:01.363048 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-14 09:04:01.363072 | 2026-08-14 09:04:01.540948 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-14 09:04:01.545645 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-14 09:04:03.300920 | 2026-08-14 09:04:03.301130 | PLAY [all] 2026-08-14 09:04:03.314524 | 2026-08-14 09:04:03.314636 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-14 09:04:03.360247 | instance | skipping: Conditional result was False 2026-08-14 09:04:03.369795 | 2026-08-14 09:04:03.369886 | TASK [fetch-output : Set log path for single node] 2026-08-14 09:04:03.413819 | instance | ok 2026-08-14 09:04:03.420596 | 2026-08-14 09:04:03.420692 | LOOP [fetch-output : Ensure local output dirs] 2026-08-14 09:04:03.920690 | instance -> localhost | ok: "/var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/logs" 2026-08-14 09:04:04.147478 | instance -> localhost | changed: "/var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/artifacts" 2026-08-14 09:04:04.376471 | instance -> localhost | changed: "/var/lib/zuul/builds/8a9ed5a8230448f2aa107f6f101ddff6/work/docs" 2026-08-14 09:04:04.396847 | 2026-08-14 09:04:04.397449 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-14 09:04:05.084423 | instance | changed: .d..t...... ./ 2026-08-14 09:04:06.829701 | instance | changed: All items complete 2026-08-14 09:04:06.830113 | 2026-08-14 09:04:06.903243 | instance | changed: .d..t...... ./ 2026-08-14 09:04:07.415047 | instance | changed: .d..t...... ./ 2026-08-14 09:04:07.433986 | 2026-08-14 09:04:07.434153 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-14 09:04:07.930014 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008379 2026-08-14 09:04:08.202086 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008180 2026-08-14 09:04:08.222186 | 2026-08-14 09:04:08.222442 | PLAY [all] 2026-08-14 09:04:08.232525 | 2026-08-14 09:04:08.232731 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-14 09:04:08.736419 | instance | changed 2026-08-14 09:04:08.741963 | 2026-08-14 09:04:08.742012 | PLAY RECAP 2026-08-14 09:04:08.742061 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-14 09:04:08.742083 | 2026-08-14 09:04:08.879609 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-14 09:04:08.895278 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-14 09:04:10.304719 | 2026-08-14 09:04:10.304938 | PLAY [localhost] 2026-08-14 09:04:10.317356 | 2026-08-14 09:04:10.317489 | TASK [Generate Zuul manifest] 2026-08-14 09:04:10.341895 | localhost | ok 2026-08-14 09:04:11.649051 | 2026-08-14 09:04:11.649300 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-14 09:04:12.045017 | localhost | changed 2026-08-14 09:04:12.058809 | 2026-08-14 09:04:12.058937 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-14 09:04:12.243584 | localhost | ok 2026-08-14 09:04:12.250853 | 2026-08-14 09:04:12.250921 | TASK [Upload logs] 2026-08-14 09:04:12.274926 | localhost | ok 2026-08-14 09:04:15.162977 | 2026-08-14 09:04:17.519626 | TASK [Set zuul-log-path fact] 2026-08-14 09:04:17.544282 | localhost | ok 2026-08-14 09:04:17.560151 | 2026-08-14 09:04:17.560326 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-14 09:04:17.591540 | localhost | ok 2026-08-14 09:04:17.602451 | 2026-08-14 09:04:17.602621 | TASK [upload-logs : Create log directories] 2026-08-14 09:04:18.047140 | localhost | changed 2026-08-14 09:04:18.052333 | 2026-08-14 09:04:18.052413 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-14 09:04:18.501482 | localhost -> localhost | ok: Runtime: 0:00:00.005913 2026-08-14 09:04:18.509452 | 2026-08-14 09:04:18.509591 | TASK [upload-logs : Upload logs to log server] 2026-08-14 09:04:19.344556 | localhost | Output suppressed because no_log was given 2026-08-14 09:04:19.440830 | 2026-08-14 09:04:19.440997 | LOOP [upload-logs : Compress console log and json output] 2026-08-14 09:04:19.492762 | localhost | skipping: Conditional result was False 2026-08-14 09:04:19.501572 | localhost | skipping: Conditional result was False 2026-08-14 09:04:19.515782 | 2026-08-14 09:04:19.515975 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-14 09:04:19.561797 | localhost | skipping: Conditional result was False 2026-08-14 09:04:19.562493 | 2026-08-14 09:04:19.565124 | localhost | skipping: Conditional result was False 2026-08-14 09:04:19.581921 | 2026-08-14 09:04:19.582101 | LOOP [upload-logs : Upload console log and json output]