2026-07-26 18:19:25.819462 | Job console starting 2026-07-26 18:19:25.830230 | Updating git repos 2026-07-26 18:19:28.309373 | Cloning repos into workspace 2026-07-26 18:19:39.923338 | Restoring repo states 2026-07-26 18:19:48.952308 | Merging changes 2026-07-26 18:19:50.793690 | Checking out repos 2026-07-26 18:19:52.438214 | Preparing playbooks 2026-07-26 18:19:55.346742 | Running Ansible setup 2026-07-26 18:19:59.689070 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-26 18:20:00.297981 | 2026-07-26 18:20:00.298109 | PLAY [localhost] 2026-07-26 18:20:00.305575 | 2026-07-26 18:20:00.305646 | TASK [Gathering Facts] 2026-07-26 18:20:01.177249 | localhost | ok 2026-07-26 18:20:01.187588 | 2026-07-26 18:20:01.187711 | TASK [Setup log path fact] 2026-07-26 18:20:01.209416 | localhost | ok 2026-07-26 18:20:01.222209 | 2026-07-26 18:20:01.222281 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-26 18:20:01.259186 | localhost | ok 2026-07-26 18:20:01.265488 | 2026-07-26 18:20:01.265582 | TASK [emit-job-header : Print job information] 2026-07-26 18:20:01.309404 | # Job Information 2026-07-26 18:20:01.309687 | Ansible Version: 2.16.18 2026-07-26 18:20:01.309761 | Job: atmosphere-molecule-csi-local-path-provisioner-selective 2026-07-26 18:20:01.309813 | Pipeline: check 2026-07-26 18:20:01.309859 | Executor: 2d72f0692154 2026-07-26 18:20:01.309903 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163 2026-07-26 18:20:01.309953 | Event ID: 27ac1810-891e-11f1-9273-d0210d8e1cbc 2026-07-26 18:20:01.313428 | 2026-07-26 18:20:01.313504 | LOOP [emit-job-header : Print node information] 2026-07-26 18:20:01.407143 | localhost | ok: 2026-07-26 18:20:01.407486 | localhost | # Node Information 2026-07-26 18:20:01.407572 | localhost | Inventory Hostname: instance 2026-07-26 18:20:01.407627 | localhost | Hostname: np0000186994 2026-07-26 18:20:01.407674 | localhost | Username: zuul 2026-07-26 18:20:01.407733 | localhost | Distro: Ubuntu 22.04 2026-07-26 18:20:01.407780 | localhost | Provider: yul1 2026-07-26 18:20:01.407824 | localhost | Region: ca-ymq-1 2026-07-26 18:20:01.407866 | localhost | Label: ubuntu-jammy 2026-07-26 18:20:01.407907 | localhost | Product Name: OpenStack Nova 2026-07-26 18:20:01.407948 | localhost | Interface IP: 199.204.45.95 2026-07-26 18:20:01.420300 | 2026-07-26 18:20:01.420457 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-26 18:20:01.800096 | localhost -> localhost | changed 2026-07-26 18:20:01.810424 | 2026-07-26 18:20:01.810498 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-26 18:20:02.614343 | localhost -> localhost | changed 2026-07-26 18:20:02.625723 | 2026-07-26 18:20:02.625785 | PLAY [all] 2026-07-26 18:20:02.633574 | 2026-07-26 18:20:02.633641 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-26 18:20:02.852851 | instance -> localhost | ok 2026-07-26 18:20:02.864256 | 2026-07-26 18:20:02.864323 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-26 18:20:02.889220 | instance | ok 2026-07-26 18:20:02.904131 | instance | included: /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-26 18:20:02.910612 | 2026-07-26 18:20:02.910670 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-26 18:20:03.744617 | instance -> localhost | Generating public/private rsa key pair. 2026-07-26 18:20:03.744898 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/81d890a224024a13b909249c5740d0bf_id_rsa 2026-07-26 18:20:03.744930 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/81d890a224024a13b909249c5740d0bf_id_rsa.pub 2026-07-26 18:20:03.744954 | instance -> localhost | The key fingerprint is: 2026-07-26 18:20:03.744997 | instance -> localhost | SHA256:w99QuLyo7/U818FSmrUAGSkqKneGYtN5mpzBcMje80I zuul-build-sshkey 2026-07-26 18:20:03.745038 | instance -> localhost | The key's randomart image is: 2026-07-26 18:20:03.745060 | instance -> localhost | +---[RSA 3072]----+ 2026-07-26 18:20:03.745085 | instance -> localhost | | .+ | 2026-07-26 18:20:03.745107 | instance -> localhost | | . = | 2026-07-26 18:20:03.745127 | instance -> localhost | |. . . o o | 2026-07-26 18:20:03.745147 | instance -> localhost | | + . . o . o . o | 2026-07-26 18:20:03.745167 | instance -> localhost | |. * + . S + B .| 2026-07-26 18:20:03.745186 | instance -> localhost | | * E + + + + + | 2026-07-26 18:20:03.745206 | instance -> localhost | |. B @ . + . ...| 2026-07-26 18:20:03.745226 | instance -> localhost | | * . . . o. . .| 2026-07-26 18:20:03.745248 | instance -> localhost | | . .oo oo | 2026-07-26 18:20:03.745269 | instance -> localhost | +----[SHA256]-----+ 2026-07-26 18:20:03.745322 | instance -> localhost | ok: Runtime: 0:00:00.441123 2026-07-26 18:20:03.750498 | 2026-07-26 18:20:03.750563 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-26 18:20:03.783502 | instance | ok 2026-07-26 18:20:03.793663 | instance | included: /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-26 18:20:03.801174 | 2026-07-26 18:20:03.801237 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-26 18:20:03.826691 | instance | skipping: Conditional result was False 2026-07-26 18:20:03.839680 | 2026-07-26 18:20:03.839895 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-26 18:20:04.276206 | instance | changed 2026-07-26 18:20:04.281070 | 2026-07-26 18:20:04.281133 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-26 18:20:04.461403 | instance | ok 2026-07-26 18:20:04.467465 | 2026-07-26 18:20:04.467534 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-26 18:20:05.311381 | instance | changed 2026-07-26 18:20:05.319640 | 2026-07-26 18:20:05.319708 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-26 18:20:06.196425 | instance | changed 2026-07-26 18:20:06.201367 | 2026-07-26 18:20:06.201429 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-26 18:20:06.224466 | instance | skipping: Conditional result was False 2026-07-26 18:20:06.231668 | 2026-07-26 18:20:06.231755 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-26 18:20:06.584710 | instance -> localhost | changed 2026-07-26 18:20:06.598494 | 2026-07-26 18:20:06.598556 | TASK [add-build-sshkey : Add back temp key] 2026-07-26 18:20:06.906614 | instance -> localhost | Identity added: /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/81d890a224024a13b909249c5740d0bf_id_rsa (zuul-build-sshkey) 2026-07-26 18:20:06.906896 | instance -> localhost | ok: Runtime: 0:00:00.015102 2026-07-26 18:20:06.912994 | 2026-07-26 18:20:06.913094 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-26 18:20:07.231867 | instance | ok 2026-07-26 18:20:07.236862 | 2026-07-26 18:20:07.236932 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-26 18:20:07.262710 | instance | skipping: Conditional result was False 2026-07-26 18:20:07.277607 | 2026-07-26 18:20:07.277678 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-07-26 18:20:07.610019 | instance | ok 2026-07-26 18:20:07.650273 | 2026-07-26 18:20:07.650405 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-07-26 18:20:10.839683 | instance | Output suppressed because no_log was given 2026-07-26 18:20:10.849015 | 2026-07-26 18:20:10.849086 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-07-26 18:20:11.043116 | instance | ok: "logs" 2026-07-26 18:20:11.043406 | instance | ok: All items complete 2026-07-26 18:20:11.043435 | 2026-07-26 18:20:11.190631 | instance | ok: "artifacts" 2026-07-26 18:20:11.350472 | instance | ok: "docs" 2026-07-26 18:20:11.365799 | 2026-07-26 18:20:11.365990 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-07-26 18:20:11.568111 | instance | changed: "logs" 2026-07-26 18:20:11.721650 | instance | changed: "artifacts" 2026-07-26 18:20:11.874883 | instance | changed: "docs" 2026-07-26 18:20:11.888212 | 2026-07-26 18:20:11.888360 | PLAY RECAP 2026-07-26 18:20:11.888417 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-07-26 18:20:11.888448 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-26 18:20:11.888469 | 2026-07-26 18:20:12.032537 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-26 18:20:12.034765 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-26 18:20:12.710689 | 2026-07-26 18:20:12.710884 | PLAY [all] 2026-07-26 18:20:12.727959 | 2026-07-26 18:20:12.728171 | TASK [setup-uv : Extract archive] 2026-07-26 18:20:15.084045 | instance | changed 2026-07-26 18:20:15.094450 | 2026-07-26 18:20:15.094537 | TASK [setup-uv : Print version] 2026-07-26 18:20:15.443202 | instance | uv 0.8.13 2026-07-26 18:20:15.639707 | instance | ok: Runtime: 0:00:00.021521 2026-07-26 18:20:15.650604 | 2026-07-26 18:20:15.650699 | TASK [Install Ansible collection siblings] 2026-07-26 18:20:24.578680 | instance | changed: 2026-07-26 18:20:24.578896 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-07-26 18:20:24.578936 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-07-26 18:20:24.578966 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-07-26 18:20:24.578994 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-07-26 18:20:24.579022 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-07-26 18:20:24.579053 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-07-26 18:20:24.579083 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-07-26 18:20:24.579112 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-07-26 18:20:24.579140 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-07-26 18:20:24.579167 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-07-26 18:20:24.579194 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-07-26 18:20:24.579220 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-07-26 18:20:24.579246 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-07-26 18:20:24.579271 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-07-26 18:20:24.579297 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0 2026-07-26 18:20:24.579324 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-07-26 18:20:24.579350 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-07-26 18:20:24.579376 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-07-26 18:20:24.579401 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-07-26 18:20:24.579427 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-07-26 18:20:24.579452 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0 2026-07-26 18:20:24.579478 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-07-26 18:20:24.579505 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-26 18:20:24.579549 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-07-26 18:20:24.579577 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0 2026-07-26 18:20:24.579603 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-26 18:20:24.579628 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-26 18:20:24.579653 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-26 18:20:24.579678 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-07-26 18:20:24.579703 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-07-26 18:20:24.579728 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-26 18:20:24.579754 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-26 18:20:24.579779 | instance | Checked out ansible.netcommon to 1.2.0 2026-07-26 18:20:24.579805 | 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-26 18:20:24.579837 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.579862 | instance | Process install dependency map 2026-07-26 18:20:24.579888 | instance | Starting collection install process 2026-07-26 18:20:24.579913 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-07-26 18:20:24.579938 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-07-26 18:20:24.579962 | instance | ansible.netcommon:* was installed successfully 2026-07-26 18:20:24.579987 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-07-26 18:20:24.580012 | instance | Creating virtual environment at: .venv 2026-07-26 18:20:24.580036 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-26 18:20:24.580060 | instance | Downloading netaddr (2.2MiB) 2026-07-26 18:20:24.580085 | instance | Downloading pygments (1.2MiB) 2026-07-26 18:20:24.580115 | instance | Downloading rjsonnet (1.2MiB) 2026-07-26 18:20:24.580140 | instance | Downloading openstacksdk (1.7MiB) 2026-07-26 18:20:24.580165 | instance | Downloading ansible-core (2.1MiB) 2026-07-26 18:20:24.580190 | instance | Downloading cryptography (4.2MiB) 2026-07-26 18:20:24.580215 | instance | Downloading setuptools (1.1MiB) 2026-07-26 18:20:24.580240 | instance | Downloading pydantic-core (2.0MiB) 2026-07-26 18:20:24.580266 | instance | Downloading kubernetes (1.9MiB) 2026-07-26 18:20:24.580291 | instance | Downloading rjsonnet 2026-07-26 18:20:24.580318 | instance | Building pyperclip==1.9.0 2026-07-26 18:20:24.580345 | instance | Downloading pydantic-core 2026-07-26 18:20:24.580371 | instance | Downloading netaddr 2026-07-26 18:20:24.580397 | instance | Downloading pygments 2026-07-26 18:20:24.580423 | instance | Downloading cryptography 2026-07-26 18:20:24.580448 | instance | Downloading setuptools 2026-07-26 18:20:24.580473 | instance | Downloading kubernetes 2026-07-26 18:20:24.580498 | instance | Downloading ansible-core 2026-07-26 18:20:24.580523 | instance | Downloading openstacksdk 2026-07-26 18:20:24.580549 | instance | Built pyperclip==1.9.0 2026-07-26 18:20:24.580574 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-26 18:20:24.580599 | instance | Installed 83 packages in 42ms 2026-07-26 18:20:24.580624 | instance | Checked out ansible.posix to 1.6.0 2026-07-26 18:20:24.580649 | 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-26 18:20:24.580674 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.580699 | instance | Process install dependency map 2026-07-26 18:20:24.580731 | instance | Starting collection install process 2026-07-26 18:20:24.580758 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-07-26 18:20:24.580783 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-07-26 18:20:24.580808 | instance | ansible.posix:1.6.0 was installed successfully 2026-07-26 18:20:24.580834 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.580859 | instance | 2.17.12 2026-07-26 18:20:24.580885 | instance | Checked out ansible.utils to v6.0.3 2026-07-26 18:20:24.580910 | 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-26 18:20:24.580936 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.580988 | instance | Process install dependency map 2026-07-26 18:20:24.581018 | instance | Starting collection install process 2026-07-26 18:20:24.581045 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-07-26 18:20:24.581071 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-07-26 18:20:24.581097 | instance | ansible.utils:6.0.3 was installed successfully 2026-07-26 18:20:24.581123 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.581150 | instance | 2.17.12 2026-07-26 18:20:24.581175 | instance | Checked out atmosphere.common to v0.7.0 2026-07-26 18:20:24.581201 | 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-26 18:20:24.581226 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.581251 | instance | Process install dependency map 2026-07-26 18:20:24.581276 | instance | Starting collection install process 2026-07-26 18:20:24.581300 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-07-26 18:20:24.581325 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-07-26 18:20:24.581350 | instance | atmosphere.common:0.7.0 was installed successfully 2026-07-26 18:20:24.581375 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.581399 | instance | 2.17.12 2026-07-26 18:20:24.581424 | instance | Checked out community.crypto to 2.2.3 2026-07-26 18:20:24.581449 | 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-26 18:20:24.581475 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.581499 | instance | Process install dependency map 2026-07-26 18:20:24.581524 | instance | Starting collection install process 2026-07-26 18:20:24.581549 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-07-26 18:20:24.581573 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-07-26 18:20:24.581598 | instance | community.crypto:2.2.3 was installed successfully 2026-07-26 18:20:24.581623 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.581647 | instance | 2.17.12 2026-07-26 18:20:24.581672 | instance | Checked out community.general to 7.3.0 2026-07-26 18:20:24.581698 | 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-26 18:20:24.581731 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.581757 | instance | Process install dependency map 2026-07-26 18:20:24.581782 | instance | Starting collection install process 2026-07-26 18:20:24.581807 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-07-26 18:20:24.581832 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-07-26 18:20:24.581857 | instance | community.general:7.3.0 was installed successfully 2026-07-26 18:20:24.581882 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.581907 | instance | 2.17.12 2026-07-26 18:20:24.581933 | instance | Checked out community.mysql to 3.6.0 2026-07-26 18:20:24.581961 | 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-26 18:20:24.581987 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.582013 | instance | Process install dependency map 2026-07-26 18:20:24.582038 | instance | Starting collection install process 2026-07-26 18:20:24.582064 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-07-26 18:20:24.582090 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-07-26 18:20:24.582115 | instance | community.mysql:3.6.0 was installed successfully 2026-07-26 18:20:24.582140 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.582165 | instance | 2.17.12 2026-07-26 18:20:24.582190 | instance | Checked out kubernetes.core to 2.4.0 2026-07-26 18:20:24.582216 | 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-26 18:20:24.582241 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.582266 | instance | Process install dependency map 2026-07-26 18:20:24.582292 | instance | Starting collection install process 2026-07-26 18:20:24.582318 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-07-26 18:20:24.582343 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-07-26 18:20:24.582369 | instance | kubernetes.core:2.4.0 was installed successfully 2026-07-26 18:20:24.582394 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.582420 | instance | 2.17.12 2026-07-26 18:20:24.582445 | instance | Checked out openstack.cloud to 2.6.0 2026-07-26 18:20:24.582471 | 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-26 18:20:24.582496 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.582521 | instance | Process install dependency map 2026-07-26 18:20:24.582545 | instance | Starting collection install process 2026-07-26 18:20:24.582570 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-07-26 18:20:24.582630 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-07-26 18:20:24.582657 | instance | openstack.cloud:2.6.0 was installed successfully 2026-07-26 18:20:24.582683 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.582714 | instance | 2.17.12 2026-07-26 18:20:24.582740 | instance | Checked out vexxhost.ceph to v4.1.0 2026-07-26 18:20:24.582766 | 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-26 18:20:24.582791 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.582816 | instance | Process install dependency map 2026-07-26 18:20:24.582840 | instance | Starting collection install process 2026-07-26 18:20:24.582865 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-07-26 18:20:24.582890 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-07-26 18:20:24.582915 | instance | vexxhost.ceph:4.1.0 was installed successfully 2026-07-26 18:20:24.582940 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.582964 | instance | 2.17.12 2026-07-26 18:20:24.582989 | instance | Checked out vexxhost.containers to v1.6.8 2026-07-26 18:20:24.583014 | 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-26 18:20:24.583039 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.583064 | instance | Process install dependency map 2026-07-26 18:20:24.583089 | instance | Starting collection install process 2026-07-26 18:20:24.583113 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-07-26 18:20:24.583137 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-07-26 18:20:24.583162 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-07-26 18:20:24.583186 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.583211 | instance | 2.17.12 2026-07-26 18:20:24.583237 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-07-26 18:20:24.583262 | 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-26 18:20:24.583288 | instance | Starting galaxy collection install process 2026-07-26 18:20:24.583313 | instance | Process install dependency map 2026-07-26 18:20:24.583337 | instance | Starting collection install process 2026-07-26 18:20:24.583362 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-07-26 18:20:24.583387 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-07-26 18:20:24.583412 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-07-26 18:20:24.583437 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-26 18:20:24.583460 | instance | 2.17.12 2026-07-26 18:20:24.589838 | 2026-07-26 18:20:24.589888 | PLAY RECAP 2026-07-26 18:20:24.589937 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-26 18:20:24.589959 | 2026-07-26 18:20:24.710519 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-26 18:20:24.712656 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-26 18:20:25.295371 | 2026-07-26 18:20:25.295504 | PLAY [all] 2026-07-26 18:20:25.307171 | 2026-07-26 18:20:25.307247 | TASK [Install "jq" for log collection] 2026-07-26 18:20:57.584208 | instance | changed 2026-07-26 18:20:57.587517 | 2026-07-26 18:20:57.587635 | PLAY RECAP 2026-07-26 18:20:57.587766 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-26 18:20:57.587859 | 2026-07-26 18:20:57.777002 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-26 18:20:57.781363 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-26 18:20:58.392573 | 2026-07-26 18:20:58.392738 | PLAY [Prepare Molecule dependencies] 2026-07-26 18:20:58.404660 | 2026-07-26 18:20:58.404751 | TASK [Install jq for log collection] 2026-07-26 18:21:00.620928 | instance | ok 2026-07-26 18:21:00.623620 | 2026-07-26 18:21:00.623681 | PLAY [Install Go for the Atmosphere deployment binary] 2026-07-26 18:21:00.630728 | 2026-07-26 18:21:00.630820 | TASK [ensure-go : Check installed go version] 2026-07-26 18:21:01.166824 | instance | ok: ERROR (ignored) 2026-07-26 18:21:01.167195 | instance | { 2026-07-26 18:21:01.167262 | instance | "failed_when_result": false, 2026-07-26 18:21:01.167314 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-07-26 18:21:01.167358 | instance | "rc": 2 2026-07-26 18:21:01.167398 | instance | } 2026-07-26 18:21:01.173119 | 2026-07-26 18:21:01.173183 | TASK [ensure-go : Skip if correct version of go is installed] 2026-07-26 18:21:01.228302 | instance | ok 2026-07-26 18:21:01.235797 | instance | included: /var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-07-26 18:21:01.240409 | 2026-07-26 18:21:01.240470 | TASK [ensure-go : Create temp directory] 2026-07-26 18:21:01.536868 | instance | changed 2026-07-26 18:21:01.541945 | 2026-07-26 18:21:01.542011 | TASK [ensure-go : Get archive checksum] 2026-07-26 18:21:02.093804 | instance | ok: OK (64 bytes) 2026-07-26 18:21:02.099144 | 2026-07-26 18:21:02.099208 | TASK [ensure-go : Download go archive] 2026-07-26 18:21:03.366878 | instance | changed: OK (78559214 bytes) 2026-07-26 18:21:03.372275 | 2026-07-26 18:21:03.372341 | TASK [ensure-go : Install go] 2026-07-26 18:21:09.232661 | instance | changed 2026-07-26 18:21:09.240429 | 2026-07-26 18:21:09.240484 | PLAY [Prepare selective Molecule execution plan] 2026-07-26 18:21:09.246558 | 2026-07-26 18:21:09.246623 | TASK [Build atmosphere binary] 2026-07-26 18:21:09.456155 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-07-26 18:21:09.461563 | instance | go: downloading golang.org/x/sync v0.18.0 2026-07-26 18:21:09.470430 | instance | go: downloading github.com/goccy/go-yaml v1.18.0 2026-07-26 18:21:09.716185 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-07-26 18:21:16.784049 | instance | ok: Runtime: 0:00:07.271582 2026-07-26 18:21:16.788737 | 2026-07-26 18:21:16.788803 | TASK [Generate selective CI plan] 2026-07-26 18:21:17.348101 | instance | ok: Runtime: 0:00:00.031947 2026-07-26 18:21:17.352819 | 2026-07-26 18:21:17.352890 | TASK [Explain selective CI plan] 2026-07-26 18:21:17.583696 | instance | CI plan mode: selective 2026-07-26 18:21:17.583938 | instance | Changed files: 2026-07-26 18:21:17.583953 | instance | A roles/heat/.ci-selective-test 2026-07-26 18:21:17.583964 | instance | A roles/octavia/.ci-selective-test 2026-07-26 18:21:17.583974 | instance | Matches: 2026-07-26 18:21:17.583987 | instance | roles/heat/.ci-selective-test: component:heat (targets) -> heat 2026-07-26 18:21:17.583998 | instance | roles/octavia/.ci-selective-test: component:octavia (targets) -> octavia 2026-07-26 18:21:17.584013 | instance | Direct targets: heat, octavia 2026-07-26 18:21:17.584022 | instance | Deployment roots: glance-images, heat, neutron, octavia 2026-07-26 18:21:17.584032 | instance | Verification profiles: load-balancer, orchestration 2026-07-26 18:21:17.584047 | instance | Variant openvswitch (23 components): ceph, ceph-provisioners, cert-manager, cluster-issuer, coredns, csi, glance, glance-images, heat, ingress-nginx, keycloak, keystone, kubernetes, libvirt, memcached, neutron, nova, octavia, openvswitch, percona-xtradb-cluster, percona-xtradb-cluster-operator, placement, rabbitmq-cluster-operator 2026-07-26 18:21:17.584058 | instance | Molecule jobs: 2026-07-26 18:21:17.584068 | instance | aio-openvswitch: run (23 components) - executes the openvswitch deployment variant 2026-07-26 18:21:17.584078 | instance | aio-ovn: skip - plan has no ovn deployment variant 2026-07-26 18:21:17.584087 | instance | csi-local-path-provisioner: skip - none of the job's verification profiles were requested 2026-07-26 18:21:17.584100 | instance | csi-rbd: skip - none of the job's verification profiles were requested 2026-07-26 18:21:17.584110 | instance | keycloak: skip - none of the job's verification profiles were requested 2026-07-26 18:21:17.892406 | instance | ok: Runtime: 0:00:00.034640 2026-07-26 18:21:17.897745 | 2026-07-26 18:21:17.897806 | TASK [Print selective CI plan] 2026-07-26 18:21:17.942116 | instance | ok 2026-07-26 18:21:17.948109 | 2026-07-26 18:21:17.948193 | TASK [Report conservative fallback] 2026-07-26 18:21:17.972732 | instance | skipping: Conditional result was False 2026-07-26 18:21:17.982095 | 2026-07-26 18:21:17.982160 | TASK [Create selective CI plan log directory] 2026-07-26 18:21:18.258381 | instance | changed 2026-07-26 18:21:18.264116 | 2026-07-26 18:21:18.264222 | TASK [Publish selective CI plan with job logs] 2026-07-26 18:21:18.611590 | instance | changed 2026-07-26 18:21:18.613724 | 2026-07-26 18:21:18.613769 | PLAY RECAP 2026-07-26 18:21:18.613812 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-26 18:21:18.613833 | 2026-07-26 18:21:18.736836 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-26 18:21:18.741090 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-26 18:21:19.385880 | 2026-07-26 18:21:19.386028 | PLAY [Run selected Molecule deployment and verification] 2026-07-26 18:21:19.397567 | 2026-07-26 18:21:19.397648 | TASK [Check for selective CI plan] 2026-07-26 18:21:19.734118 | instance | ok 2026-07-26 18:21:19.742186 | 2026-07-26 18:21:19.742293 | TASK [Validate selective CI plan] 2026-07-26 18:21:20.280266 | instance | ok: Runtime: 0:00:00.032349 2026-07-26 18:21:20.285583 | 2026-07-26 18:21:20.285651 | TASK [Resolve selective CI plan availability] 2026-07-26 18:21:20.340662 | instance | ok 2026-07-26 18:21:20.346690 | 2026-07-26 18:21:20.346775 | TASK [Read selective CI plan] 2026-07-26 18:21:20.675262 | instance | ok 2026-07-26 18:21:20.680735 | 2026-07-26 18:21:20.680804 | TASK [Load selective CI plan or full fallback] 2026-07-26 18:21:20.737823 | instance | ok 2026-07-26 18:21:20.743363 | 2026-07-26 18:21:20.743429 | TASK [Find this job in the selective CI plan] 2026-07-26 18:21:20.802596 | instance | ok 2026-07-26 18:21:20.810433 | 2026-07-26 18:21:20.810635 | TASK [Resolve this job or use full fallback] 2026-07-26 18:21:20.865790 | instance | ok 2026-07-26 18:21:20.871800 | 2026-07-26 18:21:20.871889 | TASK [Resolve deployment and verification inputs] 2026-07-26 18:21:20.936985 | instance | ok 2026-07-26 18:21:20.943195 | 2026-07-26 18:21:20.943304 | TASK [Resolve deployment tags] 2026-07-26 18:21:20.997879 | instance | ok 2026-07-26 18:21:21.003621 | 2026-07-26 18:21:21.003687 | TASK [Report Molecule job decision] 2026-07-26 18:21:21.046239 | instance | ok: {'job': 'csi-local-path-provisioner', 'mode': 'selective', 'run': False, 'reason': "none of the job's verification profiles were requested", 'network_backend': 'openvswitch', 'csi_driver': 'local-path-provisioner', 'components': [], 'verification_profiles': ['load-balancer', 'orchestration'], 'extra_vars': {}} 2026-07-26 18:21:21.053076 | 2026-07-26 18:21:21.053167 | TASK [Copy inventory file for Zuul] 2026-07-26 18:21:21.077995 | instance | skipping: Conditional result was False 2026-07-26 18:21:21.089130 | 2026-07-26 18:21:21.089222 | TASK [Switch ansible_host to private IP] 2026-07-26 18:21:21.114435 | instance | skipping: Conditional result was False 2026-07-26 18:21:21.124148 | 2026-07-26 18:21:21.124214 | TASK [Prepare Molecule scenario] 2026-07-26 18:21:21.652355 | instance | skipping: Conditional result was False 2026-07-26 18:21:21.687806 | 2026-07-26 18:21:21.687943 | TASK [Prepare host for Ceph-backed storage] 2026-07-26 18:21:22.213462 | instance | skipping: Conditional result was False 2026-07-26 18:21:22.219552 | 2026-07-26 18:21:22.219622 | TASK [Build deployment command] 2026-07-26 18:21:22.245322 | instance | skipping: Conditional result was False 2026-07-26 18:21:22.255072 | 2026-07-26 18:21:22.255156 | TASK [Run initial deployment with progress heartbeat] 2026-07-26 18:21:22.269936 | instance | skipping: Conditional result was False 2026-07-26 18:21:22.276864 | 2026-07-26 18:21:22.276968 | TASK [Run idempotence deployment with progress heartbeat] 2026-07-26 18:21:22.301829 | instance | skipping: Conditional result was False 2026-07-26 18:21:22.307480 | 2026-07-26 18:21:22.307549 | TASK [Check for br-ex interface] 2026-07-26 18:21:22.843122 | instance | skipping: Conditional result was False 2026-07-26 18:21:22.852614 | 2026-07-26 18:21:22.852706 | TASK [Add IP address to br-ex] 2026-07-26 18:21:23.380929 | instance | skipping: Conditional result was False 2026-07-26 18:21:23.390568 | 2026-07-26 18:21:23.390633 | TASK [Set br-ex interface up] 2026-07-26 18:21:23.916555 | instance | skipping: Conditional result was False 2026-07-26 18:21:23.925864 | 2026-07-26 18:21:23.925955 | TASK [Resolve Molecule verification command] 2026-07-26 18:21:23.951380 | instance | skipping: Conditional result was False 2026-07-26 18:21:23.960874 | 2026-07-26 18:21:23.960987 | TASK [Run Molecule verification with progress heartbeat] 2026-07-26 18:21:23.985645 | instance | skipping: Conditional result was False 2026-07-26 18:21:23.987475 | 2026-07-26 18:21:23.987570 | PLAY RECAP 2026-07-26 18:21:23.987668 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-07-26 18:21:23.987725 | 2026-07-26 18:21:24.115574 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-26 18:21:24.120107 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-26 18:21:24.735189 | 2026-07-26 18:21:24.735336 | PLAY [all] 2026-07-26 18:21:24.751096 | 2026-07-26 18:21:24.751270 | TASK [gather-host-logs : creating directory for system status] 2026-07-26 18:21:25.079821 | instance | ok 2026-07-26 18:21:25.086950 | 2026-07-26 18:21:25.087028 | TASK [gather-host-logs : Get logs for each host] 2026-07-26 18:21:25.423935 | instance | + systemd-cgls --full --all --no-pager 2026-07-26 18:21:25.435249 | instance | + ip addr 2026-07-26 18:21:25.437581 | instance | + ip route 2026-07-26 18:21:25.439851 | instance | + lsblk 2026-07-26 18:21:25.443746 | instance | + mount 2026-07-26 18:21:25.445885 | instance | + docker images 2026-07-26 18:21:25.446455 | instance | /bin/bash: line 7: docker: command not found 2026-07-26 18:21:25.446736 | instance | + brctl show 2026-07-26 18:21:25.447248 | instance | /bin/bash: line 8: brctl: command not found 2026-07-26 18:21:25.447531 | instance | + ps aux --sort=-%mem 2026-07-26 18:21:25.462766 | instance | + dpkg -l 2026-07-26 18:21:25.472288 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-07-26 18:21:25.472623 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-07-26 18:21:25.472658 | instance | /bin/bash: line 11: docker: command not found 2026-07-26 18:21:25.472983 | instance | + '[' '!' -z '' ']' 2026-07-26 18:21:25.624499 | instance | ok: Runtime: 0:00:00.054243 2026-07-26 18:21:25.632849 | 2026-07-26 18:21:25.632946 | TASK [gather-host-logs : Downloads logs to executor] 2026-07-26 18:21:26.277306 | instance | ERROR 2026-07-26 18:21:26.277603 | instance | { 2026-07-26 18:21:26.277636 | instance | "msg": "Warning: Permanently added '199.204.45.95' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/logs/instance/system/.ci-plan.json.AYs7Kh\" failed: Invalid argument (22)\nrsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [generator=3.2.7]\n", 2026-07-26 18:21:26.277677 | instance | "rc": 23 2026-07-26 18:21:26.277698 | instance | } 2026-07-26 18:21:26.277729 | instance | ERROR: Ignoring Errors 2026-07-26 18:21:26.286837 | 2026-07-26 18:21:26.286915 | LOOP [helm-release-status : creating directory for helm release status] 2026-07-26 18:21:26.486997 | instance | changed: "values" 2026-07-26 18:21:26.647763 | instance | changed: "releases" 2026-07-26 18:21:26.658310 | 2026-07-26 18:21:26.658529 | TASK [helm-release-status : Gather get release status for helm charts] 2026-07-26 18:21:26.862109 | instance | /bin/bash: line 3: kubectl: command not found 2026-07-26 18:21:27.204484 | instance | ok: Runtime: 0:00:00.005517 2026-07-26 18:21:27.210699 | 2026-07-26 18:21:27.210773 | TASK [helm-release-status : Downloads logs to executor] 2026-07-26 18:21:27.692998 | instance | changed: 2026-07-26 18:21:27.693235 | instance | cd+++++++++ helm/ 2026-07-26 18:21:27.693277 | instance | cd+++++++++ helm/releases/ 2026-07-26 18:21:27.693309 | instance | cd+++++++++ helm/values/ 2026-07-26 18:21:27.704110 | 2026-07-26 18:21:27.704194 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-07-26 18:21:27.911169 | instance | changed 2026-07-26 18:21:27.917892 | 2026-07-26 18:21:27.918003 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-07-26 18:21:28.178256 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-26 18:21:28.178557 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-26 18:21:28.183538 | instance | environment: line 1: kubectl: command not found 2026-07-26 18:21:28.184241 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-26 18:21:28.185609 | instance | environment: line 1: kubectl: command not found 2026-07-26 18:21:28.186505 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-26 18:21:28.187795 | instance | environment: line 1: kubectl: command not found 2026-07-26 18:21:28.188557 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-26 18:21:28.189766 | instance | environment: line 1: kubectl: command not found 2026-07-26 18:21:28.190852 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-26 18:21:28.191948 | instance | environment: line 1: kubectl: command not found 2026-07-26 18:21:28.193292 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-26 18:21:28.509641 | instance | ok: Runtime: 0:00:00.024246 2026-07-26 18:21:28.517333 | 2026-07-26 18:21:28.517433 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-07-26 18:21:28.714605 | instance | changed 2026-07-26 18:21:28.721159 | 2026-07-26 18:21:28.721253 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-07-26 18:21:28.928189 | instance | environment: line 5: kubectl: command not found 2026-07-26 18:21:28.929396 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-26 18:21:28.929722 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-26 18:21:28.930089 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-26 18:21:29.258352 | instance | ok: Runtime: 0:00:00.009063 2026-07-26 18:21:29.265196 | 2026-07-26 18:21:29.265259 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-07-26 18:21:29.736790 | instance | changed: 2026-07-26 18:21:29.736980 | instance | cd+++++++++ objects/ 2026-07-26 18:21:29.737009 | instance | cd+++++++++ objects/cluster/ 2026-07-26 18:21:29.737032 | instance | cd+++++++++ objects/namespaced/ 2026-07-26 18:21:29.745644 | 2026-07-26 18:21:29.745709 | TASK [gather-pod-logs : creating directory for pod logs] 2026-07-26 18:21:29.941316 | instance | changed 2026-07-26 18:21:29.947778 | 2026-07-26 18:21:29.947846 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-07-26 18:21:30.144992 | instance | changed 2026-07-26 18:21:30.149959 | 2026-07-26 18:21:30.150031 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-07-26 18:21:30.359363 | instance | environment: line 3: kubectl: command not found 2026-07-26 18:21:30.686479 | instance | ok: Runtime: 0:00:00.008293 2026-07-26 18:21:30.691979 | 2026-07-26 18:21:30.692046 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-07-26 18:21:31.180540 | instance | changed: 2026-07-26 18:21:31.180771 | instance | cd+++++++++ pod-logs/ 2026-07-26 18:21:31.180809 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-07-26 18:21:31.192815 | 2026-07-26 18:21:31.192879 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-07-26 18:21:31.387140 | instance | changed 2026-07-26 18:21:31.391960 | 2026-07-26 18:21:31.392027 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-07-26 18:21:31.599732 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-26 18:21:31.927428 | instance | ok: Runtime: 0:00:00.037776 2026-07-26 18:21:31.934060 | 2026-07-26 18:21:31.934148 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-07-26 18:21:32.139643 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-26 18:21:32.165223 | instance | ceph-mgr endpoints: 2026-07-26 18:21:32.469879 | instance | ok: Runtime: 0:00:00.031375 2026-07-26 18:21:32.475980 | 2026-07-26 18:21:32.476045 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-07-26 18:21:32.676267 | instance | /bin/bash: line 4: kubectl: command not found 2026-07-26 18:21:33.009441 | instance | ok: Runtime: 0:00:00.038166 2026-07-26 18:21:33.015393 | 2026-07-26 18:21:33.015455 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-07-26 18:21:33.482885 | instance | changed: cd+++++++++ prometheus/ 2026-07-26 18:21:33.495000 | 2026-07-26 18:21:33.495070 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-07-26 18:21:33.680374 | instance | changed 2026-07-26 18:21:33.687591 | 2026-07-26 18:21:33.687685 | TASK [gather-selenium-data : Get selenium data] 2026-07-26 18:21:33.935171 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-07-26 18:21:33.936706 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-07-26 18:21:34.271344 | instance | ERROR 2026-07-26 18:21:34.271667 | instance | { 2026-07-26 18:21:34.271737 | instance | "delta": "0:00:00.006048", 2026-07-26 18:21:34.271783 | instance | "end": "2026-07-26 18:21:33.936974", 2026-07-26 18:21:34.271824 | instance | "msg": "non-zero return code", 2026-07-26 18:21:34.271873 | instance | "rc": 1, 2026-07-26 18:21:34.271918 | instance | "start": "2026-07-26 18:21:33.930926" 2026-07-26 18:21:34.271957 | instance | } 2026-07-26 18:21:34.272016 | instance | ERROR: Ignoring Errors 2026-07-26 18:21:34.278802 | 2026-07-26 18:21:34.278888 | TASK [gather-selenium-data : Downloads logs to executor] 2026-07-26 18:21:34.747731 | instance | changed: cd+++++++++ selenium/ 2026-07-26 18:21:34.756044 | 2026-07-26 18:21:34.756113 | PLAY RECAP 2026-07-26 18:21:34.756176 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2 2026-07-26 18:21:34.756207 | 2026-07-26 18:21:34.871888 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-26 18:21:34.879857 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-26 18:21:35.482269 | 2026-07-26 18:21:35.482407 | PLAY [all] 2026-07-26 18:21:35.494021 | 2026-07-26 18:21:35.494096 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-26 18:21:35.539143 | instance | skipping: Conditional result was False 2026-07-26 18:21:35.548194 | 2026-07-26 18:21:35.548305 | TASK [fetch-output : Set log path for single node] 2026-07-26 18:21:35.592468 | instance | ok 2026-07-26 18:21:35.598808 | 2026-07-26 18:21:35.598918 | LOOP [fetch-output : Ensure local output dirs] 2026-07-26 18:21:35.988818 | instance -> localhost | ok: "/var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/logs" 2026-07-26 18:21:36.200341 | instance -> localhost | changed: "/var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/artifacts" 2026-07-26 18:21:36.420723 | instance -> localhost | changed: "/var/lib/zuul/builds/81d890a224024a13b909249c5740d0bf/work/docs" 2026-07-26 18:21:36.439427 | 2026-07-26 18:21:36.439596 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-26 18:21:37.091023 | instance | changed: .d..t...... ./ 2026-07-26 18:21:37.091318 | instance | changed: All items complete 2026-07-26 18:21:37.091365 | 2026-07-26 18:21:37.529788 | instance | changed: .d..t...... ./ 2026-07-26 18:21:37.989514 | instance | changed: .d..t...... ./ 2026-07-26 18:21:38.013598 | 2026-07-26 18:21:38.013762 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-26 18:21:38.424496 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007697 2026-07-26 18:21:38.635680 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006360 2026-07-26 18:21:38.652935 | 2026-07-26 18:21:38.653099 | PLAY [all] 2026-07-26 18:21:38.659255 | 2026-07-26 18:21:38.659323 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-26 18:21:39.088607 | instance | changed 2026-07-26 18:21:39.095914 | 2026-07-26 18:21:39.095980 | PLAY RECAP 2026-07-26 18:21:39.096039 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-26 18:21:39.096070 | 2026-07-26 18:21:39.214483 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-26 18:21:39.219369 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-26 18:21:39.793386 | 2026-07-26 18:21:39.793516 | PLAY [localhost] 2026-07-26 18:21:39.804326 | 2026-07-26 18:21:39.804409 | TASK [Generate Zuul manifest] 2026-07-26 18:21:39.821856 | localhost | ok 2026-07-26 18:21:39.836559 | 2026-07-26 18:21:39.836636 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-26 18:21:40.222194 | localhost | changed 2026-07-26 18:21:40.233195 | 2026-07-26 18:21:40.233268 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-26 18:21:40.264186 | localhost | ok 2026-07-26 18:21:40.274284 | 2026-07-26 18:21:40.274370 | TASK [Upload logs] 2026-07-26 18:21:40.295471 | localhost | ok 2026-07-26 18:21:40.353607 | 2026-07-26 18:21:40.353704 | TASK [Set zuul-log-path fact] 2026-07-26 18:21:40.374639 | localhost | ok 2026-07-26 18:21:40.389273 | 2026-07-26 18:21:40.389338 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-26 18:21:40.420217 | localhost | ok 2026-07-26 18:21:40.431197 | 2026-07-26 18:21:40.431260 | TASK [upload-logs : Create log directories] 2026-07-26 18:21:40.816904 | localhost | changed 2026-07-26 18:21:40.822992 | 2026-07-26 18:21:40.823083 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-26 18:21:41.252345 | localhost -> localhost | ok: Runtime: 0:00:00.006236 2026-07-26 18:21:41.286886 | 2026-07-26 18:21:41.287013 | TASK [upload-logs : Upload logs to log server] 2026-07-26 18:21:41.712682 | localhost | Output suppressed because no_log was given 2026-07-26 18:21:41.718117 | 2026-07-26 18:21:41.718181 | LOOP [upload-logs : Compress console log and json output] 2026-07-26 18:21:41.762312 | localhost | skipping: Conditional result was False 2026-07-26 18:21:41.769089 | localhost | skipping: Conditional result was False 2026-07-26 18:21:41.783452 | 2026-07-26 18:21:41.783650 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-26 18:21:41.825145 | localhost | skipping: Conditional result was False 2026-07-26 18:21:41.825623 | 2026-07-26 18:21:41.829023 | localhost | skipping: Conditional result was False 2026-07-26 18:21:41.838890 | 2026-07-26 18:21:41.839032 | LOOP [upload-logs : Upload console log and json output]