2026-07-25 21:10:19.275012 | Job console starting 2026-07-25 21:10:19.284475 | Updating git repos 2026-07-25 21:10:22.396200 | Cloning repos into workspace 2026-07-25 21:10:35.354717 | Restoring repo states 2026-07-25 21:10:42.266773 | Merging changes 2026-07-25 21:10:44.387425 | Checking out repos 2026-07-25 21:10:46.283929 | Preparing playbooks 2026-07-25 21:10:48.854666 | Running Ansible setup 2026-07-25 21:10:52.785343 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 21:10:53.449113 | 2026-07-25 21:10:53.449282 | PLAY [localhost] 2026-07-25 21:10:53.457610 | 2026-07-25 21:10:53.457681 | TASK [Gathering Facts] 2026-07-25 21:10:54.338525 | localhost | ok 2026-07-25 21:10:54.349452 | 2026-07-25 21:10:54.349525 | TASK [Setup log path fact] 2026-07-25 21:10:54.371302 | localhost | ok 2026-07-25 21:10:54.384267 | 2026-07-25 21:10:54.384347 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 21:10:54.425741 | localhost | ok 2026-07-25 21:10:54.432528 | 2026-07-25 21:10:54.432598 | TASK [emit-job-header : Print job information] 2026-07-25 21:10:54.474173 | # Job Information 2026-07-25 21:10:54.474341 | Ansible Version: 2.16.18 2026-07-25 21:10:54.474386 | Job: atmosphere-molecule-aio-ovn-selective 2026-07-25 21:10:54.474415 | Pipeline: check 2026-07-25 21:10:54.474443 | Executor: 2d72f0692154 2026-07-25 21:10:54.474470 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163 2026-07-25 21:10:54.474500 | Event ID: e759bee0-886c-11f1-9a5d-aab81a407576 2026-07-25 21:10:54.479347 | 2026-07-25 21:10:54.479437 | LOOP [emit-job-header : Print node information] 2026-07-25 21:10:54.576248 | localhost | ok: 2026-07-25 21:10:54.576507 | localhost | # Node Information 2026-07-25 21:10:54.576569 | localhost | Inventory Hostname: instance 2026-07-25 21:10:54.576602 | localhost | Hostname: np0000186879 2026-07-25 21:10:54.576630 | localhost | Username: zuul 2026-07-25 21:10:54.576660 | localhost | Distro: Ubuntu 22.04 2026-07-25 21:10:54.576691 | localhost | Provider: yul1 2026-07-25 21:10:54.576718 | localhost | Region: ca-ymq-1 2026-07-25 21:10:54.576744 | localhost | Label: ubuntu-jammy-16 2026-07-25 21:10:54.576770 | localhost | Product Name: OpenStack Nova 2026-07-25 21:10:54.576795 | localhost | Interface IP: 199.204.45.116 2026-07-25 21:10:54.594345 | 2026-07-25 21:10:54.594514 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-25 21:10:54.975983 | localhost -> localhost | changed 2026-07-25 21:10:54.983265 | 2026-07-25 21:10:54.983340 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-25 21:10:55.841907 | localhost -> localhost | changed 2026-07-25 21:10:55.852605 | 2026-07-25 21:10:55.852712 | PLAY [all] 2026-07-25 21:10:55.861290 | 2026-07-25 21:10:55.861419 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-25 21:10:56.068031 | instance -> localhost | ok 2026-07-25 21:10:56.077521 | 2026-07-25 21:10:56.077608 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-25 21:10:56.107219 | instance | ok 2026-07-25 21:10:56.120412 | instance | included: /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-25 21:10:56.126102 | 2026-07-25 21:10:56.126166 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-25 21:10:56.982626 | instance -> localhost | Generating public/private rsa key pair. 2026-07-25 21:10:56.982886 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/167b011e62e54934b5a48032445fe017_id_rsa 2026-07-25 21:10:56.982953 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/167b011e62e54934b5a48032445fe017_id_rsa.pub 2026-07-25 21:10:56.983004 | instance -> localhost | The key fingerprint is: 2026-07-25 21:10:56.983053 | instance -> localhost | SHA256:/bINkMXMeLQiGXNZCX6Z0ippWnJ9BEp5FbdhUWq7qMU zuul-build-sshkey 2026-07-25 21:10:56.983119 | instance -> localhost | The key's randomart image is: 2026-07-25 21:10:56.983167 | instance -> localhost | +---[RSA 3072]----+ 2026-07-25 21:10:56.983219 | instance -> localhost | | +.+==o=o. | 2026-07-25 21:10:56.983266 | instance -> localhost | | ..BoO.* + | 2026-07-25 21:10:56.983310 | instance -> localhost | | +.= & + | 2026-07-25 21:10:56.983353 | instance -> localhost | | + @ . . | 2026-07-25 21:10:56.983396 | instance -> localhost | | . * S o . | 2026-07-25 21:10:56.983440 | instance -> localhost | | * . + o . | 2026-07-25 21:10:56.983482 | instance -> localhost | | . E o | 2026-07-25 21:10:56.983525 | instance -> localhost | | o = | 2026-07-25 21:10:56.983576 | instance -> localhost | | . . . | 2026-07-25 21:10:56.983641 | instance -> localhost | +----[SHA256]-----+ 2026-07-25 21:10:56.983751 | instance -> localhost | ok: Runtime: 0:00:00.418940 2026-07-25 21:10:56.991208 | 2026-07-25 21:10:56.991271 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-25 21:10:57.022681 | instance | ok 2026-07-25 21:10:57.033816 | instance | included: /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-25 21:10:57.041361 | 2026-07-25 21:10:57.041425 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-25 21:10:57.065458 | instance | skipping: Conditional result was False 2026-07-25 21:10:57.076170 | 2026-07-25 21:10:57.076247 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-25 21:10:57.547578 | instance | changed 2026-07-25 21:10:57.555576 | 2026-07-25 21:10:57.555674 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-25 21:10:57.780251 | instance | ok 2026-07-25 21:10:57.785175 | 2026-07-25 21:10:57.785239 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-25 21:10:58.253969 | instance | changed 2026-07-25 21:10:58.261294 | 2026-07-25 21:10:58.261395 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-25 21:10:58.721991 | instance | changed 2026-07-25 21:10:58.732797 | 2026-07-25 21:10:58.732865 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-25 21:10:58.748373 | instance | skipping: Conditional result was False 2026-07-25 21:10:58.757753 | 2026-07-25 21:10:58.757839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-25 21:10:59.054614 | instance -> localhost | changed 2026-07-25 21:10:59.068446 | 2026-07-25 21:10:59.068525 | TASK [add-build-sshkey : Add back temp key] 2026-07-25 21:10:59.356841 | instance -> localhost | Identity added: /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/167b011e62e54934b5a48032445fe017_id_rsa (zuul-build-sshkey) 2026-07-25 21:10:59.357536 | instance -> localhost | ok: Runtime: 0:00:00.014379 2026-07-25 21:10:59.365226 | 2026-07-25 21:10:59.365289 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-25 21:10:59.631889 | instance | ok 2026-07-25 21:10:59.641934 | 2026-07-25 21:10:59.642043 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-25 21:10:59.669128 | instance | skipping: Conditional result was False 2026-07-25 21:10:59.685623 | 2026-07-25 21:10:59.685725 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-07-25 21:10:59.971623 | instance | ok 2026-07-25 21:10:59.979481 | 2026-07-25 21:10:59.979551 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-07-25 21:11:03.277527 | instance | Output suppressed because no_log was given 2026-07-25 21:11:03.292094 | 2026-07-25 21:11:03.292200 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-07-25 21:11:03.484167 | instance | ok: "logs" 2026-07-25 21:11:03.546196 | instance | ok: All items complete 2026-07-25 21:11:03.546403 | 2026-07-25 21:11:03.628767 | instance | ok: "artifacts" 2026-07-25 21:11:03.778859 | instance | ok: "docs" 2026-07-25 21:11:03.912176 | 2026-07-25 21:11:03.912338 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-07-25 21:11:04.095488 | instance | changed: "logs" 2026-07-25 21:11:04.247255 | instance | changed: "artifacts" 2026-07-25 21:11:04.402646 | instance | changed: "docs" 2026-07-25 21:11:04.429755 | 2026-07-25 21:11:04.429862 | PLAY RECAP 2026-07-25 21:11:04.429914 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-07-25 21:11:04.429944 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 21:11:04.429967 | 2026-07-25 21:11:04.550919 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-25 21:11:04.561477 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-25 21:11:05.190514 | 2026-07-25 21:11:05.190684 | PLAY [all] 2026-07-25 21:11:05.202660 | 2026-07-25 21:11:05.202788 | TASK [setup-uv : Extract archive] 2026-07-25 21:11:07.327899 | instance | changed 2026-07-25 21:11:07.335346 | 2026-07-25 21:11:07.335444 | TASK [setup-uv : Print version] 2026-07-25 21:11:07.675370 | instance | uv 0.8.13 2026-07-25 21:11:07.873533 | instance | ok: Runtime: 0:00:00.012195 2026-07-25 21:11:07.888565 | 2026-07-25 21:11:07.888633 | TASK [Install Ansible collection siblings] 2026-07-25 21:11:17.025350 | instance | changed: 2026-07-25 21:11:17.025513 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-07-25 21:11:17.025544 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-07-25 21:11:17.025567 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-07-25 21:11:17.025589 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-07-25 21:11:17.025610 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-07-25 21:11:17.025635 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-07-25 21:11:17.025657 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-07-25 21:11:17.025680 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-07-25 21:11:17.025702 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-07-25 21:11:17.025722 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-07-25 21:11:17.025743 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-07-25 21:11:17.025763 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-07-25 21:11:17.025782 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-07-25 21:11:17.025801 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-07-25 21:11:17.025822 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0 2026-07-25 21:11:17.025842 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-07-25 21:11:17.025862 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-07-25 21:11:17.025882 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-07-25 21:11:17.025902 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-07-25 21:11:17.025921 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-07-25 21:11:17.025940 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0 2026-07-25 21:11:17.025991 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-07-25 21:11:17.026245 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-25 21:11:17.026289 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-07-25 21:11:17.026312 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0 2026-07-25 21:11:17.026332 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-25 21:11:17.026352 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-25 21:11:17.026372 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-25 21:11:17.026392 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-07-25 21:11:17.026412 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-07-25 21:11:17.026432 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-25 21:11:17.026452 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-25 21:11:17.026471 | instance | Checked out ansible.netcommon to 1.2.0 2026-07-25 21:11:17.026491 | 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 21:11:17.026516 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.026536 | instance | Process install dependency map 2026-07-25 21:11:17.026556 | instance | Starting collection install process 2026-07-25 21:11:17.026576 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-07-25 21:11:17.026596 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-07-25 21:11:17.026615 | instance | ansible.netcommon:* was installed successfully 2026-07-25 21:11:17.026635 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-07-25 21:11:17.026655 | instance | Creating virtual environment at: .venv 2026-07-25 21:11:17.026674 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-25 21:11:17.026694 | instance | Downloading ansible-core (2.1MiB) 2026-07-25 21:11:17.026713 | instance | Downloading netaddr (2.2MiB) 2026-07-25 21:11:17.026735 | instance | Downloading rjsonnet (1.2MiB) 2026-07-25 21:11:17.026755 | instance | Downloading pydantic-core (2.0MiB) 2026-07-25 21:11:17.026774 | instance | Downloading kubernetes (1.9MiB) 2026-07-25 21:11:17.026794 | instance | Downloading pygments (1.2MiB) 2026-07-25 21:11:17.026813 | instance | Downloading cryptography (4.2MiB) 2026-07-25 21:11:17.026832 | instance | Downloading openstacksdk (1.7MiB) 2026-07-25 21:11:17.026851 | instance | Downloading setuptools (1.1MiB) 2026-07-25 21:11:17.026870 | instance | Building pyperclip==1.9.0 2026-07-25 21:11:17.026892 | instance | Downloading rjsonnet 2026-07-25 21:11:17.026911 | instance | Downloading pydantic-core 2026-07-25 21:11:17.026931 | instance | Downloading netaddr 2026-07-25 21:11:17.026950 | instance | Downloading pygments 2026-07-25 21:11:17.026970 | instance | Downloading cryptography 2026-07-25 21:11:17.026990 | instance | Downloading setuptools 2026-07-25 21:11:17.027009 | instance | Downloading kubernetes 2026-07-25 21:11:17.027029 | instance | Downloading ansible-core 2026-07-25 21:11:17.027049 | instance | Downloading openstacksdk 2026-07-25 21:11:17.027069 | instance | Built pyperclip==1.9.0 2026-07-25 21:11:17.027089 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-25 21:11:17.027108 | instance | Installed 83 packages in 42ms 2026-07-25 21:11:17.027127 | instance | Checked out ansible.posix to 1.6.0 2026-07-25 21:11:17.027147 | 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 21:11:17.027167 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.027186 | instance | Process install dependency map 2026-07-25 21:11:17.027210 | instance | Starting collection install process 2026-07-25 21:11:17.027229 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-07-25 21:11:17.027248 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-07-25 21:11:17.027267 | instance | ansible.posix:1.6.0 was installed successfully 2026-07-25 21:11:17.027286 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.027305 | instance | 2.17.12 2026-07-25 21:11:17.027325 | instance | Checked out ansible.utils to v6.0.3 2026-07-25 21:11:17.027344 | 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 21:11:17.027363 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.027382 | instance | Process install dependency map 2026-07-25 21:11:17.027401 | instance | Starting collection install process 2026-07-25 21:11:17.027421 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-07-25 21:11:17.027442 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-07-25 21:11:17.027461 | instance | ansible.utils:6.0.3 was installed successfully 2026-07-25 21:11:17.027481 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.027500 | instance | 2.17.12 2026-07-25 21:11:17.027520 | instance | Checked out atmosphere.common to v0.7.0 2026-07-25 21:11:17.027538 | 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 21:11:17.027558 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.027575 | instance | Process install dependency map 2026-07-25 21:11:17.027594 | instance | Starting collection install process 2026-07-25 21:11:17.027613 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-07-25 21:11:17.027632 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-07-25 21:11:17.027651 | instance | atmosphere.common:0.7.0 was installed successfully 2026-07-25 21:11:17.027670 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.027688 | instance | 2.17.12 2026-07-25 21:11:17.027707 | instance | Checked out community.crypto to 2.2.3 2026-07-25 21:11:17.027726 | 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 21:11:17.027745 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.027764 | instance | Process install dependency map 2026-07-25 21:11:17.027782 | instance | Starting collection install process 2026-07-25 21:11:17.027801 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-07-25 21:11:17.027819 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-07-25 21:11:17.027839 | instance | community.crypto:2.2.3 was installed successfully 2026-07-25 21:11:17.027858 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.027876 | instance | 2.17.12 2026-07-25 21:11:17.027896 | instance | Checked out community.general to 7.3.0 2026-07-25 21:11:17.027915 | 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 21:11:17.027941 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.027961 | instance | Process install dependency map 2026-07-25 21:11:17.027980 | instance | Starting collection install process 2026-07-25 21:11:17.027998 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-07-25 21:11:17.028017 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-07-25 21:11:17.028036 | instance | community.general:7.3.0 was installed successfully 2026-07-25 21:11:17.028055 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.028074 | instance | 2.17.12 2026-07-25 21:11:17.028094 | instance | Checked out community.mysql to 3.6.0 2026-07-25 21:11:17.028116 | 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 21:11:17.028136 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.028156 | instance | Process install dependency map 2026-07-25 21:11:17.028175 | instance | Starting collection install process 2026-07-25 21:11:17.028194 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-07-25 21:11:17.028214 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-07-25 21:11:17.028234 | instance | community.mysql:3.6.0 was installed successfully 2026-07-25 21:11:17.028292 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.028319 | instance | 2.17.12 2026-07-25 21:11:17.028341 | instance | Checked out kubernetes.core to 2.4.0 2026-07-25 21:11:17.028363 | 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 21:11:17.028384 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.028405 | instance | Process install dependency map 2026-07-25 21:11:17.028426 | instance | Starting collection install process 2026-07-25 21:11:17.028446 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-07-25 21:11:17.028466 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-07-25 21:11:17.028487 | instance | kubernetes.core:2.4.0 was installed successfully 2026-07-25 21:11:17.028507 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.028526 | instance | 2.17.12 2026-07-25 21:11:17.028546 | instance | Checked out openstack.cloud to 2.6.0 2026-07-25 21:11:17.028565 | 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 21:11:17.028584 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.028602 | instance | Process install dependency map 2026-07-25 21:11:17.028621 | instance | Starting collection install process 2026-07-25 21:11:17.028640 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-07-25 21:11:17.028659 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-07-25 21:11:17.028678 | instance | openstack.cloud:2.6.0 was installed successfully 2026-07-25 21:11:17.028698 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.028717 | instance | 2.17.12 2026-07-25 21:11:17.028742 | instance | Checked out vexxhost.ceph to v4.1.0 2026-07-25 21:11:17.028763 | 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 21:11:17.028783 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.028801 | instance | Process install dependency map 2026-07-25 21:11:17.028820 | instance | Starting collection install process 2026-07-25 21:11:17.028839 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-07-25 21:11:17.028859 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-07-25 21:11:17.028877 | instance | vexxhost.ceph:4.1.0 was installed successfully 2026-07-25 21:11:17.028897 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.028915 | instance | 2.17.12 2026-07-25 21:11:17.028935 | instance | Checked out vexxhost.containers to v1.6.8 2026-07-25 21:11:17.028999 | 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 21:11:17.029026 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.029046 | instance | Process install dependency map 2026-07-25 21:11:17.029065 | instance | Starting collection install process 2026-07-25 21:11:17.029085 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-07-25 21:11:17.029105 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-07-25 21:11:17.029125 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-07-25 21:11:17.029144 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.029163 | instance | 2.17.12 2026-07-25 21:11:17.029182 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-07-25 21:11:17.029201 | 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 21:11:17.029221 | instance | Starting galaxy collection install process 2026-07-25 21:11:17.029240 | instance | Process install dependency map 2026-07-25 21:11:17.029259 | instance | Starting collection install process 2026-07-25 21:11:17.029279 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-07-25 21:11:17.029298 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-07-25 21:11:17.029317 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-07-25 21:11:17.029336 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-25 21:11:17.029356 | instance | 2.17.12 2026-07-25 21:11:17.038283 | 2026-07-25 21:11:17.038481 | PLAY RECAP 2026-07-25 21:11:17.038553 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 21:11:17.038580 | 2026-07-25 21:11:17.164816 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-25 21:11:17.178261 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-25 21:11:17.793236 | 2026-07-25 21:11:17.793354 | PLAY [all] 2026-07-25 21:11:17.804598 | 2026-07-25 21:11:17.804689 | TASK [Install "jq" for log collection] 2026-07-25 21:11:31.874053 | instance | changed 2026-07-25 21:11:31.877474 | 2026-07-25 21:11:31.877554 | PLAY RECAP 2026-07-25 21:11:31.877626 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-25 21:11:31.877718 | 2026-07-25 21:11:32.077547 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-25 21:11:32.089112 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-25 21:11:32.709714 | 2026-07-25 21:11:32.709828 | PLAY [Prepare Molecule dependencies] 2026-07-25 21:11:32.720450 | 2026-07-25 21:11:32.720540 | TASK [Install jq for log collection] 2026-07-25 21:11:35.346918 | instance | ok 2026-07-25 21:11:35.349097 | 2026-07-25 21:11:35.349158 | PLAY [Install Go for the Atmosphere deployment binary] 2026-07-25 21:11:35.356269 | 2026-07-25 21:11:35.356371 | TASK [ensure-go : Check installed go version] 2026-07-25 21:11:35.889645 | instance | ok: ERROR (ignored) 2026-07-25 21:11:35.889883 | instance | { 2026-07-25 21:11:35.889930 | instance | "failed_when_result": false, 2026-07-25 21:11:35.889962 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-07-25 21:11:35.889990 | instance | "rc": 2 2026-07-25 21:11:35.890016 | instance | } 2026-07-25 21:11:35.896259 | 2026-07-25 21:11:35.896323 | TASK [ensure-go : Skip if correct version of go is installed] 2026-07-25 21:11:35.946375 | instance | ok 2026-07-25 21:11:35.957285 | instance | included: /var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-07-25 21:11:35.965015 | 2026-07-25 21:11:35.965099 | TASK [ensure-go : Create temp directory] 2026-07-25 21:11:36.266824 | instance | changed 2026-07-25 21:11:36.275546 | 2026-07-25 21:11:36.275658 | TASK [ensure-go : Get archive checksum] 2026-07-25 21:11:36.924735 | instance | ok: OK (64 bytes) 2026-07-25 21:11:36.930052 | 2026-07-25 21:11:36.930120 | TASK [ensure-go : Download go archive] 2026-07-25 21:11:38.206233 | instance | changed: OK (78559214 bytes) 2026-07-25 21:11:38.213317 | 2026-07-25 21:11:38.213381 | TASK [ensure-go : Install go] 2026-07-25 21:11:44.115684 | instance | changed 2026-07-25 21:11:44.124343 | 2026-07-25 21:11:44.124471 | PLAY [Prepare selective Molecule execution plan] 2026-07-25 21:11:44.131838 | 2026-07-25 21:11:44.131952 | TASK [Build atmosphere binary] 2026-07-25 21:11:44.408981 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-07-25 21:11:44.414773 | instance | go: downloading github.com/goccy/go-yaml v1.18.0 2026-07-25 21:11:44.416847 | instance | go: downloading golang.org/x/sync v0.18.0 2026-07-25 21:11:44.707721 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-07-25 21:11:52.663714 | instance | ok: Runtime: 0:00:07.725044 2026-07-25 21:11:52.689907 | 2026-07-25 21:11:52.690027 | TASK [Generate selective CI plan] 2026-07-25 21:11:53.226503 | instance | ok: Runtime: 0:00:00.029425 2026-07-25 21:11:53.252612 | 2026-07-25 21:11:53.252703 | TASK [Explain selective CI plan] 2026-07-25 21:11:53.482706 | instance | CI plan mode: selective 2026-07-25 21:11:53.482889 | instance | Changed files: 2026-07-25 21:11:53.482895 | instance | A roles/cert_manager/.ci-selective-test 2026-07-25 21:11:53.482900 | instance | Matches: 2026-07-25 21:11:53.482906 | instance | roles/cert_manager/.ci-selective-test: component:cert-manager (targets) -> cert-manager 2026-07-25 21:11:53.482912 | instance | Direct targets: cert-manager 2026-07-25 21:11:53.482918 | instance | Deployment roots: cert-manager 2026-07-25 21:11:53.482923 | instance | Verification profiles: infrastructure 2026-07-25 21:11:53.482928 | instance | Variant openvswitch (2 components): cert-manager, kubernetes 2026-07-25 21:11:53.482935 | instance | Molecule jobs: 2026-07-25 21:11:53.482940 | instance | aio-openvswitch: run (2 components) - executes the openvswitch deployment variant 2026-07-25 21:11:53.482944 | instance | aio-ovn: skip - plan has no ovn deployment variant 2026-07-25 21:11:53.482948 | instance | csi-local-path-provisioner: skip - none of the job's verification profiles were requested 2026-07-25 21:11:53.482952 | instance | csi-rbd: skip - none of the job's verification profiles were requested 2026-07-25 21:11:53.482956 | instance | keycloak: skip - none of the job's verification profiles were requested 2026-07-25 21:11:53.802698 | instance | ok: Runtime: 0:00:00.031003 2026-07-25 21:11:53.811000 | 2026-07-25 21:11:53.811085 | TASK [Print selective CI plan] 2026-07-25 21:11:53.849472 | instance | ok 2026-07-25 21:11:53.855372 | 2026-07-25 21:11:53.855463 | TASK [Report conservative fallback] 2026-07-25 21:11:53.882183 | instance | skipping: Conditional result was False 2026-07-25 21:11:53.894004 | 2026-07-25 21:11:53.894114 | TASK [Create selective CI plan log directory] 2026-07-25 21:11:54.257168 | instance | changed 2026-07-25 21:11:54.263055 | 2026-07-25 21:11:54.263127 | TASK [Publish selective CI plan with job logs] 2026-07-25 21:11:54.665155 | instance | changed 2026-07-25 21:11:54.666635 | 2026-07-25 21:11:54.666679 | PLAY RECAP 2026-07-25 21:11:54.666728 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-25 21:11:54.666750 | 2026-07-25 21:11:54.839312 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-25 21:11:54.850002 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-25 21:11:55.515719 | 2026-07-25 21:11:55.532211 | PLAY [Run selected Molecule deployment and verification] 2026-07-25 21:11:55.543725 | 2026-07-25 21:11:55.543829 | TASK [Check for selective CI plan] 2026-07-25 21:11:55.851107 | instance | ok 2026-07-25 21:11:55.857666 | 2026-07-25 21:11:55.857743 | TASK [Validate selective CI plan] 2026-07-25 21:11:56.398027 | instance | ok: Runtime: 0:00:00.033142 2026-07-25 21:11:56.404381 | 2026-07-25 21:11:56.404460 | TASK [Resolve selective CI plan availability] 2026-07-25 21:11:56.449132 | instance | ok 2026-07-25 21:11:56.453838 | 2026-07-25 21:11:56.453916 | TASK [Read selective CI plan] 2026-07-25 21:11:56.758970 | instance | ok 2026-07-25 21:11:56.765090 | 2026-07-25 21:11:56.765178 | TASK [Load selective CI plan or full fallback] 2026-07-25 21:11:56.826072 | instance | ok 2026-07-25 21:11:56.832477 | 2026-07-25 21:11:56.832545 | TASK [Find this job in the selective CI plan] 2026-07-25 21:11:56.886468 | instance | ok 2026-07-25 21:11:56.891997 | 2026-07-25 21:11:56.892064 | TASK [Resolve this job or use full fallback] 2026-07-25 21:11:56.943081 | instance | ok 2026-07-25 21:11:56.949301 | 2026-07-25 21:11:57.170713 | TASK [Resolve deployment and verification inputs] 2026-07-25 21:11:57.279971 | instance | ok 2026-07-25 21:11:57.317623 | 2026-07-25 21:11:57.317757 | TASK [Resolve deployment tags] 2026-07-25 21:11:57.370439 | instance | ok 2026-07-25 21:11:57.377246 | 2026-07-25 21:11:57.377353 | TASK [Report Molecule job decision] 2026-07-25 21:11:57.420153 | instance | ok: {'job': 'aio-ovn', 'mode': 'selective', 'run': False, 'reason': 'plan has no ovn deployment variant', 'network_backend': 'ovn', 'csi_driver': 'rbd', 'components': [], 'verification_profiles': ['infrastructure'], 'extra_vars': {}} 2026-07-25 21:11:57.426911 | 2026-07-25 21:11:57.426985 | TASK [Copy inventory file for Zuul] 2026-07-25 21:11:57.451294 | instance | skipping: Conditional result was False 2026-07-25 21:11:57.459913 | 2026-07-25 21:11:57.460034 | TASK [Switch ansible_host to private IP] 2026-07-25 21:11:57.484747 | instance | skipping: Conditional result was False 2026-07-25 21:11:57.497199 | 2026-07-25 21:11:57.497319 | TASK [Prepare Molecule scenario] 2026-07-25 21:11:58.027095 | instance | skipping: Conditional result was False 2026-07-25 21:11:58.037246 | 2026-07-25 21:11:58.037348 | TASK [Prepare host for Ceph-backed storage] 2026-07-25 21:11:58.565829 | instance | skipping: Conditional result was False 2026-07-25 21:11:58.774589 | 2026-07-25 21:11:58.774727 | TASK [Build deployment command] 2026-07-25 21:11:58.799799 | instance | skipping: Conditional result was False 2026-07-25 21:11:58.811211 | 2026-07-25 21:11:58.811339 | TASK [Run initial deployment with progress heartbeat] 2026-07-25 21:11:58.837121 | instance | skipping: Conditional result was False 2026-07-25 21:11:58.850119 | 2026-07-25 21:11:58.850323 | TASK [Run idempotence deployment with progress heartbeat] 2026-07-25 21:11:58.876449 | instance | skipping: Conditional result was False 2026-07-25 21:11:58.887457 | 2026-07-25 21:11:58.887583 | TASK [Check for br-ex interface] 2026-07-25 21:11:59.425463 | instance | skipping: Conditional result was False 2026-07-25 21:11:59.439920 | 2026-07-25 21:11:59.439998 | TASK [Add IP address to br-ex] 2026-07-25 21:11:59.971860 | instance | skipping: Conditional result was False 2026-07-25 21:11:59.980883 | 2026-07-25 21:11:59.980965 | TASK [Set br-ex interface up] 2026-07-25 21:12:00.511489 | instance | skipping: Conditional result was False 2026-07-25 21:12:00.522833 | 2026-07-25 21:12:00.522986 | TASK [Resolve Molecule verification command] 2026-07-25 21:12:00.548165 | instance | skipping: Conditional result was False 2026-07-25 21:12:00.558046 | 2026-07-25 21:12:00.558147 | TASK [Run Molecule verification with progress heartbeat] 2026-07-25 21:12:00.582535 | instance | skipping: Conditional result was False 2026-07-25 21:12:00.584430 | 2026-07-25 21:12:00.584524 | PLAY RECAP 2026-07-25 21:12:00.584619 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0 2026-07-25 21:12:00.584667 | 2026-07-25 21:12:00.729762 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-25 21:12:00.742611 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-25 21:12:01.391210 | 2026-07-25 21:12:01.391366 | PLAY [all] 2026-07-25 21:12:01.406952 | 2026-07-25 21:12:01.407084 | TASK [gather-host-logs : creating directory for system status] 2026-07-25 21:12:01.725653 | instance | ok 2026-07-25 21:12:01.731201 | 2026-07-25 21:12:01.731302 | TASK [gather-host-logs : Get logs for each host] 2026-07-25 21:12:02.055009 | instance | + systemd-cgls --full --all --no-pager 2026-07-25 21:12:02.067260 | instance | + ip addr 2026-07-25 21:12:02.070529 | instance | + ip route 2026-07-25 21:12:02.072718 | instance | + lsblk 2026-07-25 21:12:02.077179 | instance | + mount 2026-07-25 21:12:02.080196 | instance | + docker images 2026-07-25 21:12:02.080720 | instance | /bin/bash: line 7: docker: command not found 2026-07-25 21:12:02.080990 | instance | + brctl show 2026-07-25 21:12:02.081483 | instance | /bin/bash: line 8: brctl: command not found 2026-07-25 21:12:02.081799 | instance | + ps aux --sort=-%mem 2026-07-25 21:12:02.097530 | instance | + dpkg -l 2026-07-25 21:12:02.104595 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-07-25 21:12:02.105028 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-07-25 21:12:02.105083 | instance | /bin/bash: line 11: docker: command not found 2026-07-25 21:12:02.105391 | instance | + '[' '!' -z '' ']' 2026-07-25 21:12:02.269274 | instance | ok: Runtime: 0:00:00.055631 2026-07-25 21:12:02.276327 | 2026-07-25 21:12:02.276461 | TASK [gather-host-logs : Downloads logs to executor] 2026-07-25 21:12:02.937912 | instance | ERROR 2026-07-25 21:12:02.938268 | instance | { 2026-07-25 21:12:02.938314 | instance | "msg": "Warning: Permanently added '199.204.45.116' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/logs/instance/system/.ci-plan.json.e8CaAD\" 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 21:12:02.938352 | instance | "rc": 23 2026-07-25 21:12:02.938382 | instance | } 2026-07-25 21:12:02.938423 | instance | ERROR: Ignoring Errors 2026-07-25 21:12:02.948487 | 2026-07-25 21:12:02.948566 | LOOP [helm-release-status : creating directory for helm release status] 2026-07-25 21:12:03.140807 | instance | changed: "values" 2026-07-25 21:12:03.308228 | instance | changed: "releases" 2026-07-25 21:12:03.326613 | 2026-07-25 21:12:03.326804 | TASK [helm-release-status : Gather get release status for helm charts] 2026-07-25 21:12:03.569676 | instance | /bin/bash: line 3: kubectl: command not found 2026-07-25 21:12:03.880206 | instance | ok: Runtime: 0:00:00.006760 2026-07-25 21:12:03.886923 | 2026-07-25 21:12:03.887065 | TASK [helm-release-status : Downloads logs to executor] 2026-07-25 21:12:04.389460 | instance | changed: 2026-07-25 21:12:04.389783 | instance | cd+++++++++ helm/ 2026-07-25 21:12:04.389848 | instance | cd+++++++++ helm/releases/ 2026-07-25 21:12:04.389898 | instance | cd+++++++++ helm/values/ 2026-07-25 21:12:04.399621 | 2026-07-25 21:12:04.399745 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-07-25 21:12:04.609301 | instance | changed 2026-07-25 21:12:04.616004 | 2026-07-25 21:12:04.616101 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-07-25 21:12:04.835726 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 21:12:04.836013 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 21:12:04.840889 | instance | environment: line 1: kubectl: command not found 2026-07-25 21:12:04.842534 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 21:12:04.843709 | instance | environment: line 1: kubectl: command not found 2026-07-25 21:12:04.844692 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 21:12:04.845772 | instance | environment: line 1: kubectl: command not found 2026-07-25 21:12:04.847227 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 21:12:04.848336 | instance | environment: line 1: kubectl: command not found 2026-07-25 21:12:04.849720 | instance | environment: line 1: kubectl: command not found 2026-07-25 21:12:04.849809 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 21:12:04.850716 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-25 21:12:05.481119 | instance | ok: Runtime: 0:00:00.027677 2026-07-25 21:12:05.488644 | 2026-07-25 21:12:05.488718 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-07-25 21:12:05.692445 | instance | changed 2026-07-25 21:12:05.698187 | 2026-07-25 21:12:05.698266 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-07-25 21:12:05.931338 | instance | environment: line 5: kubectl: command not found 2026-07-25 21:12:05.932215 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 21:12:05.932463 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 21:12:05.932647 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-25 21:12:06.250847 | instance | ok: Runtime: 0:00:00.010139 2026-07-25 21:12:06.256892 | 2026-07-25 21:12:06.256969 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-07-25 21:12:06.753060 | instance | changed: 2026-07-25 21:12:06.753246 | instance | cd+++++++++ objects/ 2026-07-25 21:12:06.753288 | instance | cd+++++++++ objects/cluster/ 2026-07-25 21:12:06.753337 | instance | cd+++++++++ objects/namespaced/ 2026-07-25 21:12:06.766782 | 2026-07-25 21:12:06.766904 | TASK [gather-pod-logs : creating directory for pod logs] 2026-07-25 21:12:06.963932 | instance | changed 2026-07-25 21:12:06.971945 | 2026-07-25 21:12:06.972011 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-07-25 21:12:07.175536 | instance | changed 2026-07-25 21:12:07.183770 | 2026-07-25 21:12:07.183901 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-07-25 21:12:07.422699 | instance | environment: line 3: kubectl: command not found 2026-07-25 21:12:07.727281 | instance | ok: Runtime: 0:00:00.009640 2026-07-25 21:12:07.734982 | 2026-07-25 21:12:07.735079 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-07-25 21:12:08.229746 | instance | changed: 2026-07-25 21:12:08.230011 | instance | cd+++++++++ pod-logs/ 2026-07-25 21:12:08.230055 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-07-25 21:12:08.243867 | 2026-07-25 21:12:08.244049 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-07-25 21:12:08.441160 | instance | changed 2026-07-25 21:12:08.446476 | 2026-07-25 21:12:08.446556 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-07-25 21:12:08.666067 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-25 21:12:08.992494 | instance | ok: Runtime: 0:00:00.037360 2026-07-25 21:12:09.000369 | 2026-07-25 21:12:09.000506 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-07-25 21:12:09.241727 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-25 21:12:09.270386 | instance | ceph-mgr endpoints: 2026-07-25 21:12:09.563192 | instance | ok: Runtime: 0:00:00.034667 2026-07-25 21:12:09.569788 | 2026-07-25 21:12:09.569879 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-07-25 21:12:09.819176 | instance | /bin/bash: line 4: kubectl: command not found 2026-07-25 21:12:10.140796 | instance | ok: Runtime: 0:00:00.038064 2026-07-25 21:12:10.147753 | 2026-07-25 21:12:10.147836 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-07-25 21:12:10.678322 | instance | changed: cd+++++++++ prometheus/ 2026-07-25 21:12:10.688980 | 2026-07-25 21:12:10.689050 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-07-25 21:12:10.902939 | instance | changed 2026-07-25 21:12:10.910771 | 2026-07-25 21:12:10.910871 | TASK [gather-selenium-data : Get selenium data] 2026-07-25 21:12:11.130594 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-07-25 21:12:11.132290 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-07-25 21:12:11.457076 | instance | ERROR 2026-07-25 21:12:11.457357 | instance | { 2026-07-25 21:12:11.457393 | instance | "delta": "0:00:00.006834", 2026-07-25 21:12:11.457415 | instance | "end": "2026-07-25 21:12:11.132682", 2026-07-25 21:12:11.457436 | instance | "msg": "non-zero return code", 2026-07-25 21:12:11.457456 | instance | "rc": 1, 2026-07-25 21:12:11.457477 | instance | "start": "2026-07-25 21:12:11.125848" 2026-07-25 21:12:11.457497 | instance | } 2026-07-25 21:12:11.457525 | instance | ERROR: Ignoring Errors 2026-07-25 21:12:11.462595 | 2026-07-25 21:12:11.462665 | TASK [gather-selenium-data : Downloads logs to executor] 2026-07-25 21:12:11.971486 | instance | changed: cd+++++++++ selenium/ 2026-07-25 21:12:11.982824 | 2026-07-25 21:12:11.982989 | PLAY RECAP 2026-07-25 21:12:11.983072 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2 2026-07-25 21:12:11.983108 | 2026-07-25 21:12:12.185486 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-25 21:12:12.198905 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 21:12:12.820998 | 2026-07-25 21:12:12.821119 | PLAY [all] 2026-07-25 21:12:12.832378 | 2026-07-25 21:12:12.832490 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-25 21:12:12.877066 | instance | skipping: Conditional result was False 2026-07-25 21:12:12.887786 | 2026-07-25 21:12:12.887868 | TASK [fetch-output : Set log path for single node] 2026-07-25 21:12:12.928297 | instance | ok 2026-07-25 21:12:12.935389 | 2026-07-25 21:12:12.935466 | LOOP [fetch-output : Ensure local output dirs] 2026-07-25 21:12:13.342230 | instance -> localhost | ok: "/var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/logs" 2026-07-25 21:12:13.547722 | instance -> localhost | changed: "/var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/artifacts" 2026-07-25 21:12:13.762151 | instance -> localhost | changed: "/var/lib/zuul/builds/167b011e62e54934b5a48032445fe017/work/docs" 2026-07-25 21:12:13.782361 | 2026-07-25 21:12:13.782657 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-25 21:12:14.464770 | instance | changed: .d..t...... ./ 2026-07-25 21:12:14.465233 | instance | changed: All items complete 2026-07-25 21:12:14.465284 | 2026-07-25 21:12:14.937882 | instance | changed: .d..t...... ./ 2026-07-25 21:12:15.403985 | instance | changed: .d..t...... ./ 2026-07-25 21:12:15.423740 | 2026-07-25 21:12:15.423910 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-25 21:12:15.846290 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008546 2026-07-25 21:12:16.079289 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006907 2026-07-25 21:12:16.093509 | 2026-07-25 21:12:16.093665 | PLAY [all] 2026-07-25 21:12:16.100237 | 2026-07-25 21:12:16.100343 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-25 21:12:16.525270 | instance | changed 2026-07-25 21:12:16.533033 | 2026-07-25 21:12:16.533090 | PLAY RECAP 2026-07-25 21:12:16.533134 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-25 21:12:16.533156 | 2026-07-25 21:12:16.736742 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-25 21:12:16.745681 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-25 21:12:17.388633 | 2026-07-25 21:12:17.388788 | PLAY [localhost] 2026-07-25 21:12:17.399045 | 2026-07-25 21:12:17.399121 | TASK [Generate Zuul manifest] 2026-07-25 21:12:17.422069 | localhost | ok 2026-07-25 21:12:17.438805 | 2026-07-25 21:12:17.438887 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-25 21:12:17.957161 | localhost | changed 2026-07-25 21:12:17.969061 | 2026-07-25 21:12:17.969142 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-25 21:12:17.998863 | localhost | ok 2026-07-25 21:12:18.008248 | 2026-07-25 21:12:18.008339 | TASK [Upload logs] 2026-07-25 21:12:18.026615 | localhost | ok 2026-07-25 21:12:18.136447 | 2026-07-25 21:12:18.136563 | TASK [Set zuul-log-path fact] 2026-07-25 21:12:18.156407 | localhost | ok 2026-07-25 21:12:18.170024 | 2026-07-25 21:12:18.170099 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-25 21:12:18.200421 | localhost | ok 2026-07-25 21:12:18.209243 | 2026-07-25 21:12:18.209313 | TASK [upload-logs : Create log directories] 2026-07-25 21:12:18.567505 | localhost | changed 2026-07-25 21:12:18.574967 | 2026-07-25 21:12:18.575054 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-25 21:12:18.958917 | localhost -> localhost | ok: Runtime: 0:00:00.005633 2026-07-25 21:12:18.965702 | 2026-07-25 21:12:18.965793 | TASK [upload-logs : Upload logs to log server] 2026-07-25 21:12:19.397237 | localhost | Output suppressed because no_log was given 2026-07-25 21:12:19.401420 | 2026-07-25 21:12:19.401488 | LOOP [upload-logs : Compress console log and json output] 2026-07-25 21:12:19.444817 | localhost | skipping: Conditional result was False 2026-07-25 21:12:19.451428 | localhost | skipping: Conditional result was False 2026-07-25 21:12:19.468156 | 2026-07-25 21:12:19.468437 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-25 21:12:19.510917 | localhost | skipping: Conditional result was False 2026-07-25 21:12:19.511377 | 2026-07-25 21:12:19.514726 | localhost | skipping: Conditional result was False 2026-07-25 21:12:19.534401 | 2026-07-25 21:12:19.534581 | LOOP [upload-logs : Upload console log and json output]