2026-07-25 10:08:13.154403 | Job console starting 2026-07-25 10:08:13.171961 | Updating git repos 2026-07-25 10:08:15.113681 | Cloning repos into workspace 2026-07-25 10:08:41.935013 | Restoring repo states 2026-07-25 10:08:50.852372 | Merging changes 2026-07-25 10:08:53.019979 | Checking out repos 2026-07-25 10:08:55.615441 | Preparing playbooks 2026-07-25 10:08:58.873290 | Running Ansible setup 2026-07-25 10:09:02.575291 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 10:09:03.144173 | 2026-07-25 10:09:03.144294 | PLAY [localhost] 2026-07-25 10:09:03.153216 | 2026-07-25 10:09:03.153297 | TASK [Gathering Facts] 2026-07-25 10:09:04.046344 | localhost | ok 2026-07-25 10:09:04.058053 | 2026-07-25 10:09:04.058126 | TASK [Setup log path fact] 2026-07-25 10:09:04.077164 | localhost | ok 2026-07-25 10:09:04.090863 | 2026-07-25 10:09:04.090955 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 10:09:04.120902 | localhost | ok 2026-07-25 10:09:04.129724 | 2026-07-25 10:09:04.129816 | TASK [emit-job-header : Print job information] 2026-07-25 10:09:04.171332 | # Job Information 2026-07-25 10:09:04.171564 | Ansible Version: 2.16.18 2026-07-25 10:09:04.171636 | Job: atmosphere-molecule-csi-local-path-provisioner-selective 2026-07-25 10:09:04.171686 | Pipeline: check 2026-07-25 10:09:04.171731 | Executor: 2d72f0692154 2026-07-25 10:09:04.171774 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163 2026-07-25 10:09:04.171822 | Event ID: 5784c7d0-8810-11f1-8b66-3032df0aed2c 2026-07-25 10:09:04.176666 | 2026-07-25 10:09:04.176729 | LOOP [emit-job-header : Print node information] 2026-07-25 10:09:04.267811 | localhost | ok: 2026-07-25 10:09:04.268085 | localhost | # Node Information 2026-07-25 10:09:04.268129 | localhost | Inventory Hostname: instance 2026-07-25 10:09:04.268161 | localhost | Hostname: np0000186798 2026-07-25 10:09:04.268189 | localhost | Username: zuul 2026-07-25 10:09:04.268221 | localhost | Distro: Ubuntu 22.04 2026-07-25 10:09:04.268248 | localhost | Provider: yul1 2026-07-25 10:09:04.268275 | localhost | Region: ca-ymq-1 2026-07-25 10:09:04.268301 | localhost | Label: ubuntu-jammy 2026-07-25 10:09:04.268327 | localhost | Product Name: OpenStack Nova 2026-07-25 10:09:04.268354 | localhost | Interface IP: 199.204.45.116 2026-07-25 10:09:04.288324 | 2026-07-25 10:09:04.288419 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-25 10:09:04.657950 | localhost -> localhost | changed 2026-07-25 10:09:04.667166 | 2026-07-25 10:09:04.667261 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-25 10:09:06.288063 | localhost -> localhost | changed 2026-07-25 10:09:06.294000 | 2026-07-25 10:09:06.294064 | PLAY [all] 2026-07-25 10:09:06.303876 | 2026-07-25 10:09:06.303961 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-25 10:09:06.550561 | instance -> localhost | ok 2026-07-25 10:09:06.561625 | 2026-07-25 10:09:06.561721 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-25 10:09:06.595040 | instance | ok 2026-07-25 10:09:06.610539 | instance | included: /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-25 10:09:06.616942 | 2026-07-25 10:09:06.617018 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-25 10:09:07.780152 | instance -> localhost | Generating public/private rsa key pair. 2026-07-25 10:09:07.780298 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/7715f212f110416c9c4aa4c23582e75f_id_rsa 2026-07-25 10:09:07.780330 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/7715f212f110416c9c4aa4c23582e75f_id_rsa.pub 2026-07-25 10:09:07.780363 | instance -> localhost | The key fingerprint is: 2026-07-25 10:09:07.780410 | instance -> localhost | SHA256:NloG/zPJxooEjr8FYv4lWIHu5Gl4117jZFrT/BzqsdA zuul-build-sshkey 2026-07-25 10:09:07.780452 | instance -> localhost | The key's randomart image is: 2026-07-25 10:09:07.780484 | instance -> localhost | +---[RSA 3072]----+ 2026-07-25 10:09:07.780519 | instance -> localhost | | | 2026-07-25 10:09:07.780549 | instance -> localhost | | . | 2026-07-25 10:09:07.780580 | instance -> localhost | | . . . | 2026-07-25 10:09:07.780612 | instance -> localhost | | . . o | 2026-07-25 10:09:07.780640 | instance -> localhost | | = + S | 2026-07-25 10:09:07.780670 | instance -> localhost | | B B + = O . | 2026-07-25 10:09:07.780699 | instance -> localhost | |. X + * O E . | 2026-07-25 10:09:07.780726 | instance -> localhost | | o + * O * O . | 2026-07-25 10:09:07.780757 | instance -> localhost | | +.+ o.+ o | 2026-07-25 10:09:07.780785 | instance -> localhost | +----[SHA256]-----+ 2026-07-25 10:09:07.780925 | instance -> localhost | ok: Runtime: 0:00:00.245806 2026-07-25 10:09:07.786241 | 2026-07-25 10:09:07.786306 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-25 10:09:07.818306 | instance | ok 2026-07-25 10:09:07.829093 | instance | included: /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-25 10:09:07.836926 | 2026-07-25 10:09:07.837053 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-25 10:09:07.871734 | instance | skipping: Conditional result was False 2026-07-25 10:09:07.883024 | 2026-07-25 10:09:07.883097 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-25 10:09:08.308329 | instance | changed 2026-07-25 10:09:08.366383 | 2026-07-25 10:09:08.366521 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-25 10:09:08.570711 | instance | ok 2026-07-25 10:09:08.581003 | 2026-07-25 10:09:08.581131 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-25 10:09:09.059868 | instance | changed 2026-07-25 10:09:09.067946 | 2026-07-25 10:09:09.068034 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-25 10:09:09.563951 | instance | changed 2026-07-25 10:09:09.569600 | 2026-07-25 10:09:09.569666 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-25 10:09:09.583304 | instance | skipping: Conditional result was False 2026-07-25 10:09:09.590807 | 2026-07-25 10:09:09.590898 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-25 10:09:09.937423 | instance -> localhost | changed 2026-07-25 10:09:09.953493 | 2026-07-25 10:09:09.953615 | TASK [add-build-sshkey : Add back temp key] 2026-07-25 10:09:10.266750 | instance -> localhost | Identity added: /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/7715f212f110416c9c4aa4c23582e75f_id_rsa (zuul-build-sshkey) 2026-07-25 10:09:10.267023 | instance -> localhost | ok: Runtime: 0:00:00.015017 2026-07-25 10:09:10.276607 | 2026-07-25 10:09:10.276721 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-25 10:09:10.611041 | instance | ok 2026-07-25 10:09:10.617613 | 2026-07-25 10:09:10.617694 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-25 10:09:10.642271 | instance | skipping: Conditional result was False 2026-07-25 10:09:10.654086 | 2026-07-25 10:09:10.654233 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-07-25 10:09:10.981849 | instance | ok 2026-07-25 10:09:11.016527 | 2026-07-25 10:09:11.016630 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-07-25 10:09:19.057291 | instance | Output suppressed because no_log was given 2026-07-25 10:09:19.068651 | 2026-07-25 10:09:19.068742 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-07-25 10:09:19.301444 | instance | ok: "logs" 2026-07-25 10:09:19.301855 | instance | ok: All items complete 2026-07-25 10:09:19.301886 | 2026-07-25 10:09:19.453806 | instance | ok: "artifacts" 2026-07-25 10:09:19.615947 | instance | ok: "docs" 2026-07-25 10:09:19.627423 | 2026-07-25 10:09:19.627604 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-07-25 10:09:19.814215 | instance | changed: "logs" 2026-07-25 10:09:19.984058 | instance | changed: "artifacts" 2026-07-25 10:09:20.157418 | instance | changed: "docs" 2026-07-25 10:09:20.176200 | 2026-07-25 10:09:20.176334 | PLAY RECAP 2026-07-25 10:09:20.176400 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-07-25 10:09:20.176452 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 10:09:20.176482 | 2026-07-25 10:09:20.295496 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 10:09:20.297688 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-25 10:09:20.882194 | 2026-07-25 10:09:20.882337 | PLAY [all] 2026-07-25 10:09:20.894039 | 2026-07-25 10:09:20.894146 | TASK [setup-uv : Extract archive] 2026-07-25 10:09:23.092632 | instance | changed 2026-07-25 10:09:23.100289 | 2026-07-25 10:09:23.100396 | TASK [setup-uv : Print version] 2026-07-25 10:09:23.450621 | instance | uv 0.8.13 2026-07-25 10:09:23.640389 | instance | ok: Runtime: 0:00:00.015630 2026-07-25 10:09:23.649914 | 2026-07-25 10:09:23.650038 | TASK [Install Ansible collection siblings] 2026-07-25 10:09:33.084536 | instance | changed: 2026-07-25 10:09:33.084691 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-07-25 10:09:33.084738 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-07-25 10:09:33.084765 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-07-25 10:09:33.084786 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-07-25 10:09:33.084806 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-07-25 10:09:33.084831 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-07-25 10:09:33.084852 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-07-25 10:09:33.084875 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-07-25 10:09:33.084895 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-07-25 10:09:33.084915 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-07-25 10:09:33.084933 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-07-25 10:09:33.084985 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-07-25 10:09:33.085034 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-07-25 10:09:33.085058 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-07-25 10:09:33.085077 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0 2026-07-25 10:09:33.085097 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-07-25 10:09:33.085116 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-07-25 10:09:33.085135 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-07-25 10:09:33.085153 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-07-25 10:09:33.085172 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-07-25 10:09:33.085190 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0 2026-07-25 10:09:33.085209 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-07-25 10:09:33.085229 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-25 10:09:33.085259 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-07-25 10:09:33.085279 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0 2026-07-25 10:09:33.085296 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-25 10:09:33.085314 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-25 10:09:33.085368 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-25 10:09:33.085389 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-07-25 10:09:33.085407 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-07-25 10:09:33.085425 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-25 10:09:33.085443 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-25 10:09:33.085461 | instance | Checked out ansible.netcommon to 1.2.0 2026-07-25 10:09:33.085480 | 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-25 10:09:33.085503 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.085522 | instance | Process install dependency map 2026-07-25 10:09:33.085540 | instance | Starting collection install process 2026-07-25 10:09:33.085558 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-07-25 10:09:33.085576 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-07-25 10:09:33.085595 | instance | ansible.netcommon:* was installed successfully 2026-07-25 10:09:33.085613 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-07-25 10:09:33.085630 | instance | Creating virtual environment at: .venv 2026-07-25 10:09:33.085649 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-25 10:09:33.085668 | instance | Downloading pygments (1.2MiB) 2026-07-25 10:09:33.085686 | instance | Downloading ansible-core (2.1MiB) 2026-07-25 10:09:33.085704 | instance | Downloading openstacksdk (1.7MiB) 2026-07-25 10:09:33.085722 | instance | Downloading rjsonnet (1.2MiB) 2026-07-25 10:09:33.085740 | instance | Downloading kubernetes (1.9MiB) 2026-07-25 10:09:33.085758 | instance | Downloading cryptography (4.2MiB) 2026-07-25 10:09:33.085776 | instance | Downloading netaddr (2.2MiB) 2026-07-25 10:09:33.085794 | instance | Downloading pydantic-core (2.0MiB) 2026-07-25 10:09:33.085812 | instance | Downloading setuptools (1.1MiB) 2026-07-25 10:09:33.085830 | instance | Building pyperclip==1.9.0 2026-07-25 10:09:33.085850 | instance | Downloading rjsonnet 2026-07-25 10:09:33.085869 | instance | Downloading pydantic-core 2026-07-25 10:09:33.085887 | instance | Downloading netaddr 2026-07-25 10:09:33.085906 | instance | Downloading pygments 2026-07-25 10:09:33.085924 | instance | Downloading cryptography 2026-07-25 10:09:33.085942 | instance | Downloading setuptools 2026-07-25 10:09:33.085960 | instance | Downloading kubernetes 2026-07-25 10:09:33.085978 | instance | Downloading ansible-core 2026-07-25 10:09:33.085997 | instance | Downloading openstacksdk 2026-07-25 10:09:33.086015 | instance | Built pyperclip==1.9.0 2026-07-25 10:09:33.086033 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-25 10:09:33.086051 | instance | Installed 83 packages in 189ms 2026-07-25 10:09:33.086069 | instance | Checked out ansible.posix to 1.6.0 2026-07-25 10:09:33.086087 | 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-25 10:09:33.086106 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.086124 | instance | Process install dependency map 2026-07-25 10:09:33.086148 | instance | Starting collection install process 2026-07-25 10:09:33.086168 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-07-25 10:09:33.086187 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-07-25 10:09:33.086205 | instance | ansible.posix:1.6.0 was installed successfully 2026-07-25 10:09:33.086223 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.086241 | instance | 2.17.12 2026-07-25 10:09:33.086259 | instance | Checked out ansible.utils to v6.0.3 2026-07-25 10:09:33.086277 | 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-25 10:09:33.086295 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.086313 | instance | Process install dependency map 2026-07-25 10:09:33.086331 | instance | Starting collection install process 2026-07-25 10:09:33.086350 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-07-25 10:09:33.086368 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-07-25 10:09:33.086386 | instance | ansible.utils:6.0.3 was installed successfully 2026-07-25 10:09:33.086405 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.086422 | instance | 2.17.12 2026-07-25 10:09:33.086440 | instance | Checked out atmosphere.common to v0.7.0 2026-07-25 10:09:33.086459 | 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-25 10:09:33.086477 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.086495 | instance | Process install dependency map 2026-07-25 10:09:33.086513 | instance | Starting collection install process 2026-07-25 10:09:33.086531 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-07-25 10:09:33.086549 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-07-25 10:09:33.086568 | instance | atmosphere.common:0.7.0 was installed successfully 2026-07-25 10:09:33.086586 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.086604 | instance | 2.17.12 2026-07-25 10:09:33.086622 | instance | Checked out community.crypto to 2.2.3 2026-07-25 10:09:33.086640 | 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-25 10:09:33.086658 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.086676 | instance | Process install dependency map 2026-07-25 10:09:33.086693 | instance | Starting collection install process 2026-07-25 10:09:33.086711 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-07-25 10:09:33.086729 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-07-25 10:09:33.086747 | instance | community.crypto:2.2.3 was installed successfully 2026-07-25 10:09:33.086765 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.086782 | instance | 2.17.12 2026-07-25 10:09:33.086800 | instance | Checked out community.general to 7.3.0 2026-07-25 10:09:33.086818 | 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-25 10:09:33.086843 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.086862 | instance | Process install dependency map 2026-07-25 10:09:33.086880 | instance | Starting collection install process 2026-07-25 10:09:33.086898 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-07-25 10:09:33.086916 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-07-25 10:09:33.086934 | instance | community.general:7.3.0 was installed successfully 2026-07-25 10:09:33.086967 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.087013 | instance | 2.17.12 2026-07-25 10:09:33.087042 | instance | Checked out community.mysql to 3.6.0 2026-07-25 10:09:33.087065 | 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-25 10:09:33.087093 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.087120 | instance | Process install dependency map 2026-07-25 10:09:33.087144 | instance | Starting collection install process 2026-07-25 10:09:33.087164 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-07-25 10:09:33.087192 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-07-25 10:09:33.087217 | instance | community.mysql:3.6.0 was installed successfully 2026-07-25 10:09:33.087241 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.087265 | instance | 2.17.12 2026-07-25 10:09:33.087293 | instance | Checked out kubernetes.core to 2.4.0 2026-07-25 10:09:33.087317 | 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-25 10:09:33.087341 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.087368 | instance | Process install dependency map 2026-07-25 10:09:33.087394 | instance | Starting collection install process 2026-07-25 10:09:33.087417 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-07-25 10:09:33.087441 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-07-25 10:09:33.087467 | instance | kubernetes.core:2.4.0 was installed successfully 2026-07-25 10:09:33.087491 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.087514 | instance | 2.17.12 2026-07-25 10:09:33.087537 | instance | Checked out openstack.cloud to 2.6.0 2026-07-25 10:09:33.087555 | 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-25 10:09:33.087575 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.087593 | instance | Process install dependency map 2026-07-25 10:09:33.087611 | instance | Starting collection install process 2026-07-25 10:09:33.087629 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-07-25 10:09:33.087647 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-07-25 10:09:33.087665 | instance | openstack.cloud:2.6.0 was installed successfully 2026-07-25 10:09:33.087684 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.087709 | instance | 2.17.12 2026-07-25 10:09:33.087728 | instance | Checked out vexxhost.ceph to v4.1.0 2026-07-25 10:09:33.087746 | 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-25 10:09:33.087765 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.087783 | instance | Process install dependency map 2026-07-25 10:09:33.087800 | instance | Starting collection install process 2026-07-25 10:09:33.087818 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-07-25 10:09:33.087836 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-07-25 10:09:33.087854 | instance | vexxhost.ceph:4.1.0 was installed successfully 2026-07-25 10:09:33.087872 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.087890 | instance | 2.17.12 2026-07-25 10:09:33.087908 | instance | Checked out vexxhost.containers to v1.6.8 2026-07-25 10:09:33.087926 | 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-25 10:09:33.087944 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.087962 | instance | Process install dependency map 2026-07-25 10:09:33.087979 | instance | Starting collection install process 2026-07-25 10:09:33.087997 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-07-25 10:09:33.088015 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-07-25 10:09:33.088033 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-07-25 10:09:33.088052 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.088071 | instance | 2.17.12 2026-07-25 10:09:33.088089 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-07-25 10:09:33.088108 | 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-25 10:09:33.088126 | instance | Starting galaxy collection install process 2026-07-25 10:09:33.088144 | instance | Process install dependency map 2026-07-25 10:09:33.088162 | instance | Starting collection install process 2026-07-25 10:09:33.088180 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-07-25 10:09:33.088198 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-07-25 10:09:33.088216 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-07-25 10:09:33.088234 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 10:09:33.088252 | instance | 2.17.12 2026-07-25 10:09:33.094432 | 2026-07-25 10:09:33.094476 | PLAY RECAP 2026-07-25 10:09:33.094517 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 10:09:33.094539 | 2026-07-25 10:09:33.212620 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-25 10:09:33.214668 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-25 10:09:33.829532 | 2026-07-25 10:09:33.829883 | PLAY [all] 2026-07-25 10:09:33.854031 | 2026-07-25 10:09:33.854174 | TASK [Install "jq" for log collection] 2026-07-25 10:09:45.005492 | instance | changed 2026-07-25 10:09:45.007380 | 2026-07-25 10:09:45.007495 | PLAY RECAP 2026-07-25 10:09:45.007584 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 10:09:45.007640 | 2026-07-25 10:09:45.126754 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-25 10:09:45.128825 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-25 10:09:45.774701 | 2026-07-25 10:09:45.774858 | PLAY [Prepare Molecule dependencies] 2026-07-25 10:09:45.786481 | 2026-07-25 10:09:45.786558 | TASK [Install jq for log collection] 2026-07-25 10:09:48.185822 | instance | ok 2026-07-25 10:09:48.188521 | 2026-07-25 10:09:48.188597 | PLAY [Install Go for the Atmosphere deployment binary] 2026-07-25 10:09:48.197916 | 2026-07-25 10:09:48.198107 | TASK [ensure-go : Check installed go version] 2026-07-25 10:09:48.737140 | instance | ok: ERROR (ignored) 2026-07-25 10:09:48.737488 | instance | { 2026-07-25 10:09:48.737555 | instance | "failed_when_result": false, 2026-07-25 10:09:48.737617 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-07-25 10:09:48.737900 | instance | "rc": 2 2026-07-25 10:09:48.737960 | instance | } 2026-07-25 10:09:48.743984 | 2026-07-25 10:09:48.744056 | TASK [ensure-go : Skip if correct version of go is installed] 2026-07-25 10:09:48.796734 | instance | ok 2026-07-25 10:09:48.807205 | instance | included: /var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-07-25 10:09:48.812178 | 2026-07-25 10:09:48.812253 | TASK [ensure-go : Create temp directory] 2026-07-25 10:09:49.121295 | instance | changed 2026-07-25 10:09:49.128342 | 2026-07-25 10:09:49.128427 | TASK [ensure-go : Get archive checksum] 2026-07-25 10:09:49.768637 | instance | ok: OK (64 bytes) 2026-07-25 10:09:49.773689 | 2026-07-25 10:09:49.773752 | TASK [ensure-go : Download go archive] 2026-07-25 10:09:51.281800 | instance | changed: OK (78559214 bytes) 2026-07-25 10:09:51.287688 | 2026-07-25 10:09:51.287789 | TASK [ensure-go : Install go] 2026-07-25 10:09:57.233396 | instance | changed 2026-07-25 10:09:57.241593 | 2026-07-25 10:09:57.241658 | PLAY [Prepare selective Molecule execution plan] 2026-07-25 10:09:57.247629 | 2026-07-25 10:09:57.247742 | TASK [Build atmosphere binary] 2026-07-25 10:09:57.494702 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-07-25 10:09:57.497219 | instance | go: downloading golang.org/x/sync v0.18.0 2026-07-25 10:09:57.501969 | instance | go: downloading github.com/goccy/go-yaml v1.18.0 2026-07-25 10:09:57.799004 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-07-25 10:10:04.289008 | instance | ok: Runtime: 0:00:06.748055 2026-07-25 10:10:04.295659 | 2026-07-25 10:10:04.295785 | TASK [Generate selective CI plan] 2026-07-25 10:10:04.860995 | instance | ok: Runtime: 0:00:00.025253 2026-07-25 10:10:04.868129 | 2026-07-25 10:10:04.868201 | TASK [Explain selective CI plan] 2026-07-25 10:10:05.082818 | instance | CI plan mode: selective 2026-07-25 10:10:05.082956 | instance | Changed files: 2026-07-25 10:10:05.082965 | instance | A roles/keystone/.ci-selective-test 2026-07-25 10:10:05.082972 | instance | Matches: 2026-07-25 10:10:05.082979 | instance | roles/keystone/.ci-selective-test: component:keystone (targets) -> keystone 2026-07-25 10:10:05.082985 | instance | Direct targets: keystone 2026-07-25 10:10:05.082994 | instance | Deployment roots: keystone 2026-07-25 10:10:05.083005 | instance | Verification profiles: identity, keycloak-federation 2026-07-25 10:10:05.083013 | instance | Variant openvswitch (12 components): ceph, cert-manager, cluster-issuer, csi, ingress-nginx, keycloak, keystone, kubernetes, memcached, percona-xtradb-cluster, percona-xtradb-cluster-operator, rabbitmq-cluster-operator 2026-07-25 10:10:05.083022 | instance | Molecule jobs: 2026-07-25 10:10:05.083028 | instance | aio-openvswitch: run (12 components) - executes the openvswitch deployment variant 2026-07-25 10:10:05.083034 | instance | aio-ovn: skip - plan has no ovn deployment variant 2026-07-25 10:10:05.083040 | instance | csi-local-path-provisioner: skip - none of the job's verification profiles were requested 2026-07-25 10:10:05.083046 | instance | csi-rbd: skip - none of the job's verification profiles were requested 2026-07-25 10:10:05.083052 | instance | keycloak: run - requested verification profiles: keycloak-federation 2026-07-25 10:10:05.403287 | instance | ok: Runtime: 0:00:00.021698 2026-07-25 10:10:05.408272 | 2026-07-25 10:10:05.408345 | TASK [Print selective CI plan] 2026-07-25 10:10:05.441184 | instance | ok 2026-07-25 10:10:05.447488 | 2026-07-25 10:10:05.447572 | TASK [Report conservative fallback] 2026-07-25 10:10:05.471756 | instance | skipping: Conditional result was False 2026-07-25 10:10:05.479651 | 2026-07-25 10:10:05.479746 | TASK [Create selective CI plan log directory] 2026-07-25 10:10:05.766155 | instance | changed 2026-07-25 10:10:05.773634 | 2026-07-25 10:10:05.773747 | TASK [Publish selective CI plan with job logs] 2026-07-25 10:10:06.144365 | instance | changed 2026-07-25 10:10:06.145852 | 2026-07-25 10:10:06.145898 | PLAY RECAP 2026-07-25 10:10:06.145939 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-25 10:10:06.145960 | 2026-07-25 10:10:06.252836 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-25 10:10:06.257485 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-25 10:10:06.846429 | 2026-07-25 10:10:06.846552 | PLAY [Run selected Molecule deployment and verification] 2026-07-25 10:10:06.858108 | 2026-07-25 10:10:06.858214 | TASK [Check for selective CI plan] 2026-07-25 10:10:07.215447 | instance | ok 2026-07-25 10:10:07.327630 | 2026-07-25 10:10:07.327771 | TASK [Validate selective CI plan] 2026-07-25 10:10:07.857499 | instance | ok: Runtime: 0:00:00.032809 2026-07-25 10:10:07.862893 | 2026-07-25 10:10:07.862988 | TASK [Resolve selective CI plan availability] 2026-07-25 10:10:07.910117 | instance | ok 2026-07-25 10:10:07.914951 | 2026-07-25 10:10:07.915034 | TASK [Read selective CI plan] 2026-07-25 10:10:08.204238 | instance | ok 2026-07-25 10:10:08.209370 | 2026-07-25 10:10:08.209437 | TASK [Load selective CI plan or full fallback] 2026-07-25 10:10:08.263854 | instance | ok 2026-07-25 10:10:08.270812 | 2026-07-25 10:10:08.270897 | TASK [Find this job in the selective CI plan] 2026-07-25 10:10:08.324882 | instance | ok 2026-07-25 10:10:08.331278 | 2026-07-25 10:10:08.331348 | TASK [Resolve this job or use full fallback] 2026-07-25 10:10:08.385550 | instance | ok 2026-07-25 10:10:08.391629 | 2026-07-25 10:10:08.391721 | TASK [Resolve deployment and verification inputs] 2026-07-25 10:10:08.445333 | instance | ok 2026-07-25 10:10:08.452392 | 2026-07-25 10:10:08.452490 | TASK [Resolve deployment tags] 2026-07-25 10:10:08.506542 | instance | ok 2026-07-25 10:10:08.511469 | 2026-07-25 10:10:08.511541 | TASK [Report Molecule job decision] 2026-07-25 10:10:08.547688 | 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': ['identity', 'keycloak-federation']} 2026-07-25 10:10:08.554761 | 2026-07-25 10:10:08.554842 | TASK [Copy inventory file for Zuul] 2026-07-25 10:10:08.580420 | instance | skipping: Conditional result was False 2026-07-25 10:10:08.591789 | 2026-07-25 10:10:08.591925 | TASK [Switch ansible_host to private IP] 2026-07-25 10:10:08.617671 | instance | skipping: Conditional result was False 2026-07-25 10:10:08.632226 | 2026-07-25 10:10:08.632325 | TASK [Prepare Molecule scenario] 2026-07-25 10:10:09.170954 | instance | skipping: Conditional result was False 2026-07-25 10:10:09.240413 | 2026-07-25 10:10:09.240629 | TASK [Build deployment command] 2026-07-25 10:10:09.266837 | instance | skipping: Conditional result was False 2026-07-25 10:10:09.279219 | 2026-07-25 10:10:09.279454 | TASK [Deploy with parallel orchestrator] 2026-07-25 10:10:09.820318 | instance | skipping: Conditional result was False 2026-07-25 10:10:09.830783 | 2026-07-25 10:10:09.830985 | TASK [Re-deploy to verify idempotent execution] 2026-07-25 10:10:10.360879 | instance | skipping: Conditional result was False 2026-07-25 10:10:10.371200 | 2026-07-25 10:10:10.371302 | TASK [Add IP address to br-ex] 2026-07-25 10:10:10.901126 | instance | skipping: Conditional result was False 2026-07-25 10:10:10.912390 | 2026-07-25 10:10:10.912538 | TASK [Set br-ex interface up] 2026-07-25 10:10:11.442769 | instance | skipping: Conditional result was False 2026-07-25 10:10:11.451999 | 2026-07-25 10:10:11.452212 | TASK [Verify Molecule scenario] 2026-07-25 10:10:11.985270 | instance | skipping: Conditional result was False 2026-07-25 10:10:11.988077 | 2026-07-25 10:10:11.988196 | PLAY RECAP 2026-07-25 10:10:11.988302 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0 2026-07-25 10:10:11.988353 | 2026-07-25 10:10:12.191999 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-25 10:10:12.196242 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-25 10:10:12.802224 | 2026-07-25 10:10:12.802345 | PLAY [all] 2026-07-25 10:10:12.815694 | 2026-07-25 10:10:12.815777 | TASK [gather-host-logs : creating directory for system status] 2026-07-25 10:10:13.153512 | instance | ok 2026-07-25 10:10:13.160209 | 2026-07-25 10:10:13.160314 | TASK [gather-host-logs : Get logs for each host] 2026-07-25 10:10:13.490118 | instance | + systemd-cgls --full --all --no-pager 2026-07-25 10:10:13.503573 | instance | + ip addr 2026-07-25 10:10:13.506273 | instance | + ip route 2026-07-25 10:10:13.507963 | instance | + lsblk 2026-07-25 10:10:13.511154 | instance | + mount 2026-07-25 10:10:13.512696 | instance | + docker images 2026-07-25 10:10:13.513058 | instance | /bin/bash: line 7: docker: command not found 2026-07-25 10:10:13.513222 | instance | + brctl show 2026-07-25 10:10:13.513754 | instance | /bin/bash: line 8: brctl: command not found 2026-07-25 10:10:13.513882 | instance | + ps aux --sort=-%mem 2026-07-25 10:10:13.528408 | instance | + dpkg -l 2026-07-25 10:10:13.534911 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-07-25 10:10:13.535577 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-07-25 10:10:13.535648 | instance | /bin/bash: line 11: docker: command not found 2026-07-25 10:10:13.536088 | instance | + '[' '!' -z '' ']' 2026-07-25 10:10:13.703349 | instance | ok: Runtime: 0:00:00.051576 2026-07-25 10:10:13.711474 | 2026-07-25 10:10:13.711554 | TASK [gather-host-logs : Downloads logs to executor] 2026-07-25 10:10:14.300030 | instance | ERROR 2026-07-25 10:10:14.300435 | instance | { 2026-07-25 10:10:14.300469 | instance | "msg": "Warning: Permanently added '199.204.45.116' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/logs/instance/system/.ci-plan.json.CEJxWl\" 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-25 10:10:14.300493 | instance | "rc": 23 2026-07-25 10:10:14.300513 | instance | } 2026-07-25 10:10:14.300540 | instance | ERROR: Ignoring Errors 2026-07-25 10:10:14.310962 | 2026-07-25 10:10:14.311117 | LOOP [helm-release-status : creating directory for helm release status] 2026-07-25 10:10:14.505864 | instance | changed: "values" 2026-07-25 10:10:14.689387 | instance | changed: "releases" 2026-07-25 10:10:14.707113 | 2026-07-25 10:10:14.707287 | TASK [helm-release-status : Gather get release status for helm charts] 2026-07-25 10:10:14.927554 | instance | /bin/bash: line 3: kubectl: command not found 2026-07-25 10:10:15.244309 | instance | ok: Runtime: 0:00:00.005541 2026-07-25 10:10:15.250994 | 2026-07-25 10:10:15.251109 | TASK [helm-release-status : Downloads logs to executor] 2026-07-25 10:10:15.732989 | instance | changed: 2026-07-25 10:10:15.733188 | instance | cd+++++++++ helm/ 2026-07-25 10:10:15.733217 | instance | cd+++++++++ helm/releases/ 2026-07-25 10:10:15.733238 | instance | cd+++++++++ helm/values/ 2026-07-25 10:10:15.742428 | 2026-07-25 10:10:15.742503 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-07-25 10:10:15.937684 | instance | changed 2026-07-25 10:10:15.942679 | 2026-07-25 10:10:15.942755 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-07-25 10:10:16.191181 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 10:10:16.191427 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 10:10:16.196464 | instance | environment: line 1: kubectl: command not found 2026-07-25 10:10:16.197878 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 10:10:16.198423 | instance | environment: line 1: kubectl: command not found 2026-07-25 10:10:16.199597 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 10:10:16.201311 | instance | environment: line 1: kubectl: command not found 2026-07-25 10:10:16.202956 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 10:10:16.203307 | instance | environment: line 1: kubectl: command not found 2026-07-25 10:10:16.205319 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 10:10:16.206569 | instance | environment: line 1: kubectl: command not found 2026-07-25 10:10:16.207459 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 10:10:16.508472 | instance | ok: Runtime: 0:00:00.025966 2026-07-25 10:10:16.516021 | 2026-07-25 10:10:16.516214 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-07-25 10:10:16.705515 | instance | changed 2026-07-25 10:10:16.714211 | 2026-07-25 10:10:16.714403 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-07-25 10:10:16.942213 | instance | environment: line 5: kubectl: command not found 2026-07-25 10:10:16.943329 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 10:10:16.943689 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 10:10:16.943791 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 10:10:17.254567 | instance | ok: Runtime: 0:00:00.009384 2026-07-25 10:10:17.262369 | 2026-07-25 10:10:17.262508 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-07-25 10:10:17.733970 | instance | changed: 2026-07-25 10:10:17.734273 | instance | cd+++++++++ objects/ 2026-07-25 10:10:17.734336 | instance | cd+++++++++ objects/cluster/ 2026-07-25 10:10:17.734385 | instance | cd+++++++++ objects/namespaced/ 2026-07-25 10:10:17.744571 | 2026-07-25 10:10:17.744675 | TASK [gather-pod-logs : creating directory for pod logs] 2026-07-25 10:10:17.938944 | instance | changed 2026-07-25 10:10:17.955941 | 2026-07-25 10:10:17.956093 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-07-25 10:10:18.146900 | instance | changed 2026-07-25 10:10:18.151697 | 2026-07-25 10:10:18.151762 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-07-25 10:10:18.364587 | instance | environment: line 3: kubectl: command not found 2026-07-25 10:10:18.703640 | instance | ok: Runtime: 0:00:00.007150 2026-07-25 10:10:18.708320 | 2026-07-25 10:10:18.708381 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-07-25 10:10:19.196475 | instance | changed: 2026-07-25 10:10:19.196757 | instance | cd+++++++++ pod-logs/ 2026-07-25 10:10:19.196798 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-07-25 10:10:19.213517 | 2026-07-25 10:10:19.213668 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-07-25 10:10:19.416683 | instance | changed 2026-07-25 10:10:19.422948 | 2026-07-25 10:10:19.423029 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-07-25 10:10:19.636976 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-25 10:10:19.959747 | instance | ok: Runtime: 0:00:00.034224 2026-07-25 10:10:19.964555 | 2026-07-25 10:10:19.964621 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-07-25 10:10:20.165570 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-25 10:10:20.196426 | instance | ceph-mgr endpoints: 2026-07-25 10:10:20.500379 | instance | ok: Runtime: 0:00:00.036587 2026-07-25 10:10:20.505227 | 2026-07-25 10:10:20.505292 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-07-25 10:10:20.721939 | instance | /bin/bash: line 4: kubectl: command not found 2026-07-25 10:10:21.040042 | instance | ok: Runtime: 0:00:00.037556 2026-07-25 10:10:21.045537 | 2026-07-25 10:10:21.045606 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-07-25 10:10:21.511210 | instance | changed: cd+++++++++ prometheus/ 2026-07-25 10:10:21.525312 | 2026-07-25 10:10:21.525393 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-07-25 10:10:21.716690 | instance | changed 2026-07-25 10:10:21.723338 | 2026-07-25 10:10:21.723411 | TASK [gather-selenium-data : Get selenium data] 2026-07-25 10:10:22.005288 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-07-25 10:10:22.007049 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-07-25 10:10:22.321579 | instance | ERROR 2026-07-25 10:10:22.321723 | instance | { 2026-07-25 10:10:22.321768 | instance | "delta": "0:00:00.006620", 2026-07-25 10:10:22.321797 | instance | "end": "2026-07-25 10:10:22.007459", 2026-07-25 10:10:22.321824 | instance | "msg": "non-zero return code", 2026-07-25 10:10:22.321853 | instance | "rc": 1, 2026-07-25 10:10:22.321880 | instance | "start": "2026-07-25 10:10:22.000839" 2026-07-25 10:10:22.321906 | instance | } 2026-07-25 10:10:22.321944 | instance | ERROR: Ignoring Errors 2026-07-25 10:10:22.327792 | 2026-07-25 10:10:22.327855 | TASK [gather-selenium-data : Downloads logs to executor] 2026-07-25 10:10:22.846203 | instance | changed: cd+++++++++ selenium/ 2026-07-25 10:10:22.854369 | 2026-07-25 10:10:22.854513 | PLAY RECAP 2026-07-25 10:10:22.854592 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2 2026-07-25 10:10:22.854623 | 2026-07-25 10:10:23.059956 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-25 10:10:23.064705 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 10:10:23.741980 | 2026-07-25 10:10:23.742104 | PLAY [all] 2026-07-25 10:10:23.753864 | 2026-07-25 10:10:23.753964 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-25 10:10:23.788700 | instance | skipping: Conditional result was False 2026-07-25 10:10:23.798881 | 2026-07-25 10:10:23.798964 | TASK [fetch-output : Set log path for single node] 2026-07-25 10:10:23.832047 | instance | ok 2026-07-25 10:10:23.838251 | 2026-07-25 10:10:23.838355 | LOOP [fetch-output : Ensure local output dirs] 2026-07-25 10:10:24.270244 | instance -> localhost | ok: "/var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/logs" 2026-07-25 10:10:24.471570 | instance -> localhost | changed: "/var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/artifacts" 2026-07-25 10:10:24.689290 | instance -> localhost | changed: "/var/lib/zuul/builds/7715f212f110416c9c4aa4c23582e75f/work/docs" 2026-07-25 10:10:24.706037 | 2026-07-25 10:10:24.706216 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-25 10:10:25.300027 | instance | changed: .d..t...... ./ 2026-07-25 10:10:25.300244 | instance | changed: All items complete 2026-07-25 10:10:25.300283 | 2026-07-25 10:10:25.746266 | instance | changed: .d..t...... ./ 2026-07-25 10:10:26.193599 | instance | changed: .d..t...... ./ 2026-07-25 10:10:26.206252 | 2026-07-25 10:10:26.206360 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-25 10:10:26.630911 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008044 2026-07-25 10:10:26.854883 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.005097 2026-07-25 10:10:26.869974 | 2026-07-25 10:10:26.870065 | PLAY [all] 2026-07-25 10:10:26.877486 | 2026-07-25 10:10:26.877549 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-25 10:10:27.307445 | instance | changed 2026-07-25 10:10:27.316004 | 2026-07-25 10:10:27.316086 | PLAY RECAP 2026-07-25 10:10:27.316153 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-25 10:10:27.316191 | 2026-07-25 10:10:27.452258 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 10:10:27.454444 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-25 10:10:28.019140 | 2026-07-25 10:10:28.019285 | PLAY [localhost] 2026-07-25 10:10:28.030280 | 2026-07-25 10:10:28.030418 | TASK [Generate Zuul manifest] 2026-07-25 10:10:28.049574 | localhost | ok 2026-07-25 10:10:28.067443 | 2026-07-25 10:10:28.067579 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-25 10:10:28.424187 | localhost | changed 2026-07-25 10:10:28.436458 | 2026-07-25 10:10:28.436610 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-25 10:10:28.465220 | localhost | ok 2026-07-25 10:10:28.476098 | 2026-07-25 10:10:28.476217 | TASK [Upload logs] 2026-07-25 10:10:28.497286 | localhost | ok 2026-07-25 10:10:28.562346 | 2026-07-25 10:10:28.562510 | TASK [Set zuul-log-path fact] 2026-07-25 10:10:28.582420 | localhost | ok 2026-07-25 10:10:28.601983 | 2026-07-25 10:10:28.602125 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 10:10:28.631783 | localhost | ok 2026-07-25 10:10:28.644701 | 2026-07-25 10:10:28.644871 | TASK [upload-logs : Create log directories] 2026-07-25 10:10:29.011480 | localhost | changed 2026-07-25 10:10:29.017701 | 2026-07-25 10:10:29.017767 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-25 10:10:29.432487 | localhost -> localhost | ok: Runtime: 0:00:00.006213 2026-07-25 10:10:29.468422 | 2026-07-25 10:10:29.468547 | TASK [upload-logs : Upload logs to log server] 2026-07-25 10:10:29.924765 | localhost | Output suppressed because no_log was given 2026-07-25 10:10:29.929548 | 2026-07-25 10:10:29.929621 | LOOP [upload-logs : Compress console log and json output] 2026-07-25 10:10:29.969237 | localhost | skipping: Conditional result was False 2026-07-25 10:10:29.976942 | localhost | skipping: Conditional result was False 2026-07-25 10:10:29.991492 | 2026-07-25 10:10:29.991687 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-25 10:10:30.039597 | localhost | skipping: Conditional result was False 2026-07-25 10:10:30.039936 | 2026-07-25 10:10:30.046811 | localhost | skipping: Conditional result was False 2026-07-25 10:10:30.062964 | 2026-07-25 10:10:30.063101 | LOOP [upload-logs : Upload console log and json output]