2026-07-26 08:44:19.305498 | Job console starting
2026-07-26 08:44:19.315246 | Updating git repos
2026-07-26 08:44:21.671514 | Cloning repos into workspace
2026-07-26 08:44:33.253710 | Restoring repo states
2026-07-26 08:44:43.636186 | Merging changes
2026-07-26 08:44:44.828264 | Checking out repos
2026-07-26 08:44:46.212069 | Preparing playbooks
2026-07-26 08:44:51.203660 | Running Ansible setup
2026-07-26 08:44:57.216377 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 08:44:57.857813 | 
2026-07-26 08:44:57.858508 | PLAY [localhost]
2026-07-26 08:44:57.866873 | 
2026-07-26 08:44:57.866944 | TASK [Gathering Facts]
2026-07-26 08:44:58.780173 | localhost | ok
2026-07-26 08:44:58.790951 | 
2026-07-26 08:44:58.791036 | TASK [Setup log path fact]
2026-07-26 08:44:58.812934 | localhost | ok
2026-07-26 08:44:58.825688 | 
2026-07-26 08:44:58.825780 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 08:44:58.857274 | localhost | ok
2026-07-26 08:44:58.864705 | 
2026-07-26 08:44:58.864770 | TASK [emit-job-header : Print job information]
2026-07-26 08:44:58.908358 | # Job Information
2026-07-26 08:44:58.908602 | Ansible Version: 2.16.18
2026-07-26 08:44:58.908637 | Job: atmosphere-molecule-aio-ovn-selective
2026-07-26 08:44:58.908659 | Pipeline: check
2026-07-26 08:44:58.908679 | Executor: 2d72f0692154
2026-07-26 08:44:58.908698 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163
2026-07-26 08:44:58.908720 | Event ID: e28d72b0-88cd-11f1-88bc-0b8bdb72c956
2026-07-26 08:44:58.911914 | 
2026-07-26 08:44:58.911986 | LOOP [emit-job-header : Print node information]
2026-07-26 08:44:59.006406 | localhost | ok:
2026-07-26 08:44:59.006679 | localhost | # Node Information
2026-07-26 08:44:59.006742 | localhost | Inventory Hostname: instance
2026-07-26 08:44:59.006792 | localhost | Hostname: np0000186937
2026-07-26 08:44:59.006836 | localhost | Username: zuul
2026-07-26 08:44:59.006887 | localhost | Distro: Ubuntu 22.04
2026-07-26 08:44:59.006932 | localhost | Provider: yul1
2026-07-26 08:44:59.006975 | localhost | Region: ca-ymq-1
2026-07-26 08:44:59.007017 | localhost | Label: ubuntu-jammy-16
2026-07-26 08:44:59.007059 | localhost | Product Name: OpenStack Nova
2026-07-26 08:44:59.007101 | localhost | Interface IP: 162.253.55.222
2026-07-26 08:44:59.024225 | 
2026-07-26 08:44:59.024384 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-26 08:44:59.395384 | localhost -> localhost | changed
2026-07-26 08:44:59.405777 | 
2026-07-26 08:44:59.405907 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-26 08:45:00.363654 | localhost -> localhost | changed
2026-07-26 08:45:00.374686 | 
2026-07-26 08:45:00.374747 | PLAY [all]
2026-07-26 08:45:00.382384 | 
2026-07-26 08:45:00.382451 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-26 08:45:00.639839 | instance -> localhost | ok
2026-07-26 08:45:00.649193 | 
2026-07-26 08:45:00.649286 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-26 08:45:00.680162 | instance | ok
2026-07-26 08:45:00.693460 | instance | included: /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-26 08:45:00.698938 | 
2026-07-26 08:45:00.698997 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-26 08:45:03.330571 | instance -> localhost | Generating public/private rsa key pair.
2026-07-26 08:45:03.330769 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/0ec5b3ee7ca348419c559741442e522d_id_rsa
2026-07-26 08:45:03.330813 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/0ec5b3ee7ca348419c559741442e522d_id_rsa.pub
2026-07-26 08:45:03.330847 | instance -> localhost | The key fingerprint is:
2026-07-26 08:45:03.330879 | instance -> localhost | SHA256:VGcj4GHbvj2DIC30QzjGCbu7dihkuZA8Qftzd4iORU8 zuul-build-sshkey
2026-07-26 08:45:03.330935 | instance -> localhost | The key's randomart image is:
2026-07-26 08:45:03.330967 | instance -> localhost | +---[RSA 3072]----+
2026-07-26 08:45:03.331005 | instance -> localhost | |    .   +.o +    |
2026-07-26 08:45:03.331037 | instance -> localhost | | .   + = = + .   |
2026-07-26 08:45:03.331068 | instance -> localhost | |. . . B = .      |
2026-07-26 08:45:03.331098 | instance -> localhost | | o   = E .       |
2026-07-26 08:45:03.331128 | instance -> localhost | |..o.o * S .      |
2026-07-26 08:45:03.331157 | instance -> localhost | |oo+o = * + +     |
2026-07-26 08:45:03.331186 | instance -> localhost | | +..B.. . o +    |
2026-07-26 08:45:03.331219 | instance -> localhost | |  o.oo.      o   |
2026-07-26 08:45:03.331252 | instance -> localhost | |   o..           |
2026-07-26 08:45:03.331282 | instance -> localhost | +----[SHA256]-----+
2026-07-26 08:45:03.331350 | instance -> localhost | ok: Runtime: 0:00:02.207230
2026-07-26 08:45:03.347536 | 
2026-07-26 08:45:03.347734 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-26 08:45:03.387396 | instance | ok
2026-07-26 08:45:03.396508 | instance | included: /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-26 08:45:03.404530 | 
2026-07-26 08:45:03.404592 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-26 08:45:03.419228 | instance | skipping: Conditional result was False
2026-07-26 08:45:03.427959 | 
2026-07-26 08:45:03.428047 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-26 08:45:03.861968 | instance | changed
2026-07-26 08:45:03.869394 | 
2026-07-26 08:45:03.869456 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-26 08:45:04.081287 | instance | ok
2026-07-26 08:45:04.086057 | 
2026-07-26 08:45:04.086117 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-26 08:45:04.602171 | instance | changed
2026-07-26 08:45:04.607623 | 
2026-07-26 08:45:04.607691 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-26 08:45:05.076118 | instance | changed
2026-07-26 08:45:05.082463 | 
2026-07-26 08:45:05.082529 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-26 08:45:05.107936 | instance | skipping: Conditional result was False
2026-07-26 08:45:05.118076 | 
2026-07-26 08:45:05.118161 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-26 08:45:05.427116 | instance -> localhost | changed
2026-07-26 08:45:05.443069 | 
2026-07-26 08:45:05.443159 | TASK [add-build-sshkey : Add back temp key]
2026-07-26 08:45:05.737763 | instance -> localhost | Identity added: /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/0ec5b3ee7ca348419c559741442e522d_id_rsa (zuul-build-sshkey)
2026-07-26 08:45:05.737947 | instance -> localhost | ok: Runtime: 0:00:00.014027
2026-07-26 08:45:05.742970 | 
2026-07-26 08:45:05.743032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-26 08:45:06.005070 | instance | ok
2026-07-26 08:45:06.011542 | 
2026-07-26 08:45:06.011612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-26 08:45:06.035432 | instance | skipping: Conditional result was False
2026-07-26 08:45:06.050110 | 
2026-07-26 08:45:06.050185 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-26 08:45:06.337022 | instance | ok
2026-07-26 08:45:06.342657 | 
2026-07-26 08:45:06.342723 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-26 08:45:09.583533 | instance | Output suppressed because no_log was given
2026-07-26 08:45:09.593636 | 
2026-07-26 08:45:09.593698 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-26 08:45:09.779492 | instance | ok: "logs"
2026-07-26 08:45:09.779744 | instance | ok: All items complete
2026-07-26 08:45:09.779773 | 
2026-07-26 08:45:09.926499 | instance | ok: "artifacts"
2026-07-26 08:45:10.069699 | instance | ok: "docs"
2026-07-26 08:45:10.090612 | 
2026-07-26 08:45:10.090756 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-26 08:45:10.261112 | instance | changed: "logs"
2026-07-26 08:45:10.414762 | instance | changed: "artifacts"
2026-07-26 08:45:10.564921 | instance | changed: "docs"
2026-07-26 08:45:10.588625 | 
2026-07-26 08:45:10.588744 | PLAY RECAP
2026-07-26 08:45:10.588805 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-26 08:45:10.588844 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 08:45:10.588875 | 
2026-07-26 08:45:10.708080 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 08:45:10.717294 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 08:45:11.329401 | 
2026-07-26 08:45:11.329509 | PLAY [all]
2026-07-26 08:45:11.341219 | 
2026-07-26 08:45:11.341300 | TASK [setup-uv : Extract archive]
2026-07-26 08:45:13.633173 | instance | changed
2026-07-26 08:45:13.641640 | 
2026-07-26 08:45:13.641753 | TASK [setup-uv : Print version]
2026-07-26 08:45:14.033515 | instance | uv 0.8.13
2026-07-26 08:45:14.177195 | instance | ok: Runtime: 0:00:00.012954
2026-07-26 08:45:14.189212 | 
2026-07-26 08:45:14.189283 | TASK [Install Ansible collection siblings]
2026-07-26 08:45:22.912853 | instance | changed:
2026-07-26 08:45:22.913513 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-26 08:45:22.913595 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-26 08:45:22.913646 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-26 08:45:22.913691 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-26 08:45:22.913734 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-26 08:45:22.913785 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-26 08:45:22.913833 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-26 08:45:22.913890 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-26 08:45:22.913941 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-26 08:45:22.913988 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-26 08:45:22.914014 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-26 08:45:22.914037 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-26 08:45:22.914060 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-26 08:45:22.914083 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-26 08:45:22.914102 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-26 08:45:22.914121 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-26 08:45:22.914140 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-26 08:45:22.914158 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-26 08:45:22.914177 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-26 08:45:22.914195 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-26 08:45:22.914213 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-26 08:45:22.914231 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-26 08:45:22.914251 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-26 08:45:22.914281 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-26 08:45:22.914300 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-26 08:45:22.914318 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-26 08:45:22.914336 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-26 08:45:22.914354 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-26 08:45:22.914372 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-26 08:45:22.914391 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-26 08:45:22.914408 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-26 08:45:22.914427 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-26 08:45:22.914445 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-26 08:45:22.914464 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-26 08:45:22.914487 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.914505 | instance | Process install dependency map
2026-07-26 08:45:22.914524 | instance | Starting collection install process
2026-07-26 08:45:22.914542 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-26 08:45:22.914561 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-26 08:45:22.914579 | instance | ansible.netcommon:* was installed successfully
2026-07-26 08:45:22.914597 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-26 08:45:22.914615 | instance | Creating virtual environment at: .venv
2026-07-26 08:45:22.914633 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-26 08:45:22.914651 | instance | Downloading pydantic-core (2.0MiB)
2026-07-26 08:45:22.914669 | instance | Downloading setuptools (1.1MiB)
2026-07-26 08:45:22.914691 | instance | Downloading pygments (1.2MiB)
2026-07-26 08:45:22.914709 | instance | Downloading ansible-core (2.1MiB)
2026-07-26 08:45:22.914728 | instance | Downloading openstacksdk (1.7MiB)
2026-07-26 08:45:22.914746 | instance | Downloading kubernetes (1.9MiB)
2026-07-26 08:45:22.914765 | instance | Downloading netaddr (2.2MiB)
2026-07-26 08:45:22.914783 | instance | Downloading rjsonnet (1.2MiB)
2026-07-26 08:45:22.914801 | instance | Downloading cryptography (4.2MiB)
2026-07-26 08:45:22.914820 | instance |    Building pyperclip==1.9.0
2026-07-26 08:45:22.914839 | instance |  Downloading rjsonnet
2026-07-26 08:45:22.914858 | instance |  Downloading pydantic-core
2026-07-26 08:45:22.914877 | instance |  Downloading netaddr
2026-07-26 08:45:22.914896 | instance |  Downloading pygments
2026-07-26 08:45:22.914914 | instance |  Downloading cryptography
2026-07-26 08:45:22.914932 | instance |  Downloading setuptools
2026-07-26 08:45:22.914949 | instance |  Downloading kubernetes
2026-07-26 08:45:22.914967 | instance |  Downloading openstacksdk
2026-07-26 08:45:22.914986 | instance |       Built pyperclip==1.9.0
2026-07-26 08:45:22.915004 | instance |  Downloading ansible-core
2026-07-26 08:45:22.915022 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-26 08:45:22.915040 | instance | Installed 83 packages in 36ms
2026-07-26 08:45:22.915058 | instance | Checked out ansible.posix to 1.6.0
2026-07-26 08:45:22.915076 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-26 08:45:22.915095 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.915114 | instance | Process install dependency map
2026-07-26 08:45:22.915136 | instance | Starting collection install process
2026-07-26 08:45:22.915155 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-26 08:45:22.915174 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-26 08:45:22.915192 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-26 08:45:22.915210 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.915228 | instance | 2.17.12
2026-07-26 08:45:22.915246 | instance | Checked out ansible.utils to v6.0.3
2026-07-26 08:45:22.915264 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-26 08:45:22.915282 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.915300 | instance | Process install dependency map
2026-07-26 08:45:22.915318 | instance | Starting collection install process
2026-07-26 08:45:22.915336 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-26 08:45:22.915355 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-26 08:45:22.915374 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-26 08:45:22.915393 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.915411 | instance | 2.17.12
2026-07-26 08:45:22.915429 | instance | Checked out atmosphere.common to v0.7.0
2026-07-26 08:45:22.915448 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-26 08:45:22.915466 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.915484 | instance | Process install dependency map
2026-07-26 08:45:22.915502 | instance | Starting collection install process
2026-07-26 08:45:22.915520 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-26 08:45:22.915538 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-26 08:45:22.915556 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-26 08:45:22.915574 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.915592 | instance | 2.17.12
2026-07-26 08:45:22.915610 | instance | Checked out community.crypto to 2.2.3
2026-07-26 08:45:22.915627 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-26 08:45:22.915646 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.915663 | instance | Process install dependency map
2026-07-26 08:45:22.915681 | instance | Starting collection install process
2026-07-26 08:45:22.915699 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-26 08:45:22.915716 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-26 08:45:22.915735 | instance | community.crypto:2.2.3 was installed successfully
2026-07-26 08:45:22.915752 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.915770 | instance | 2.17.12
2026-07-26 08:45:22.915787 | instance | Checked out community.general to 7.3.0
2026-07-26 08:45:22.915805 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-07-26 08:45:22.915827 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.915845 | instance | Process install dependency map
2026-07-26 08:45:22.915863 | instance | Starting collection install process
2026-07-26 08:45:22.915880 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-26 08:45:22.915898 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-26 08:45:22.915916 | instance | community.general:7.3.0 was installed successfully
2026-07-26 08:45:22.915935 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.915953 | instance | 2.17.12
2026-07-26 08:45:22.915971 | instance | Checked out community.mysql to 3.6.0
2026-07-26 08:45:22.915991 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-26 08:45:22.916011 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916029 | instance | Process install dependency map
2026-07-26 08:45:22.916048 | instance | Starting collection install process
2026-07-26 08:45:22.916066 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-26 08:45:22.916084 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-26 08:45:22.916102 | instance | community.mysql:3.6.0 was installed successfully
2026-07-26 08:45:22.916121 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.916139 | instance | 2.17.12
2026-07-26 08:45:22.916157 | instance | Checked out kubernetes.core to 2.4.0
2026-07-26 08:45:22.916176 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-26 08:45:22.916194 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916212 | instance | Process install dependency map
2026-07-26 08:45:22.916231 | instance | Starting collection install process
2026-07-26 08:45:22.916249 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-26 08:45:22.916268 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-26 08:45:22.916286 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-26 08:45:22.916304 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.916322 | instance | 2.17.12
2026-07-26 08:45:22.916340 | instance | Checked out openstack.cloud to 2.6.0
2026-07-26 08:45:22.916358 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-26 08:45:22.916376 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916394 | instance | Process install dependency map
2026-07-26 08:45:22.916412 | instance | Starting collection install process
2026-07-26 08:45:22.916430 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-26 08:45:22.916449 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-26 08:45:22.916467 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-26 08:45:22.916485 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.916503 | instance | 2.17.12
2026-07-26 08:45:22.916525 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-26 08:45:22.916543 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-26 08:45:22.916561 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916579 | instance | Process install dependency map
2026-07-26 08:45:22.916596 | instance | Starting collection install process
2026-07-26 08:45:22.916615 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-26 08:45:22.916633 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-26 08:45:22.916651 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-26 08:45:22.916681 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.916700 | instance | 2.17.12
2026-07-26 08:45:22.916718 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-26 08:45:22.916736 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-26 08:45:22.916754 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916773 | instance | Process install dependency map
2026-07-26 08:45:22.916791 | instance | Starting collection install process
2026-07-26 08:45:22.916809 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-26 08:45:22.916828 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-26 08:45:22.916846 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-26 08:45:22.916864 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.916883 | instance | 2.17.12
2026-07-26 08:45:22.916901 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-26 08:45:22.916920 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-26 08:45:22.916938 | instance | Starting galaxy collection install process
2026-07-26 08:45:22.916972 | instance | Process install dependency map
2026-07-26 08:45:22.916993 | instance | Starting collection install process
2026-07-26 08:45:22.917013 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-26 08:45:22.917032 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-26 08:45:22.917051 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-26 08:45:22.917069 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 08:45:22.917087 | instance | 2.17.12
2026-07-26 08:45:22.923182 | 
2026-07-26 08:45:22.923232 | PLAY RECAP
2026-07-26 08:45:22.923277 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 08:45:22.923298 | 
2026-07-26 08:45:23.037505 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 08:45:23.107481 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-26 08:45:23.938542 | 
2026-07-26 08:45:23.938666 | PLAY [all]
2026-07-26 08:45:23.950316 | 
2026-07-26 08:45:23.950393 | TASK [Install "jq" for log collection]
2026-07-26 08:45:35.288875 | instance | changed
2026-07-26 08:45:35.292898 | 
2026-07-26 08:45:35.292976 | PLAY RECAP
2026-07-26 08:45:35.293037 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 08:45:35.293099 | 
2026-07-26 08:45:35.407401 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-26 08:45:35.420540 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-26 08:45:36.032993 | 
2026-07-26 08:45:36.033111 | PLAY [Prepare Molecule dependencies]
2026-07-26 08:45:36.044767 | 
2026-07-26 08:45:36.044857 | TASK [Install jq for log collection]
2026-07-26 08:45:38.390010 | instance | ok
2026-07-26 08:45:38.393386 | 
2026-07-26 08:45:38.393476 | PLAY [Install Go for the Atmosphere deployment binary]
2026-07-26 08:45:38.401209 | 
2026-07-26 08:45:38.401296 | TASK [ensure-go : Check installed go version]
2026-07-26 08:45:38.937268 | instance | ok: ERROR (ignored)
2026-07-26 08:45:38.948145 | instance | {
2026-07-26 08:45:38.948205 | instance |   "failed_when_result": false,
2026-07-26 08:45:38.948242 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-07-26 08:45:38.948274 | instance |   "rc": 2
2026-07-26 08:45:38.948305 | instance | }
2026-07-26 08:45:38.957985 | 
2026-07-26 08:45:38.958059 | TASK [ensure-go : Skip if correct version of go is installed]
2026-07-26 08:45:39.012417 | instance | ok
2026-07-26 08:45:39.021812 | instance | included: /var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-07-26 08:45:39.026666 | 
2026-07-26 08:45:39.026728 | TASK [ensure-go : Create temp directory]
2026-07-26 08:45:39.323793 | instance | changed
2026-07-26 08:45:39.394517 | 
2026-07-26 08:45:39.394698 | TASK [ensure-go : Get archive checksum]
2026-07-26 08:45:40.022762 | instance | ok: OK (64 bytes)
2026-07-26 08:45:40.028094 | 
2026-07-26 08:45:40.028161 | TASK [ensure-go : Download go archive]
2026-07-26 08:45:41.472072 | instance | changed: OK (78559214 bytes)
2026-07-26 08:45:41.477582 | 
2026-07-26 08:45:41.477650 | TASK [ensure-go : Install go]
2026-07-26 08:45:47.354999 | instance | changed
2026-07-26 08:45:47.363519 | 
2026-07-26 08:45:47.363573 | PLAY [Prepare selective Molecule execution plan]
2026-07-26 08:45:47.369936 | 
2026-07-26 08:45:47.370002 | TASK [Build atmosphere binary]
2026-07-26 08:45:47.620498 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-07-26 08:45:47.623742 | instance | go: downloading golang.org/x/sync v0.18.0
2026-07-26 08:45:47.626770 | instance | go: downloading github.com/goccy/go-yaml v1.18.0
2026-07-26 08:45:47.912264 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-07-26 08:45:54.946020 | instance | ok: Runtime: 0:00:07.048359
2026-07-26 08:45:55.350771 | 
2026-07-26 08:45:55.350933 | TASK [Generate selective CI plan]
2026-07-26 08:45:55.889255 | instance | ok: Runtime: 0:00:00.033810
2026-07-26 08:45:55.895784 | 
2026-07-26 08:45:55.895853 | TASK [Explain selective CI plan]
2026-07-26 08:45:56.127574 | instance | CI plan mode: selective
2026-07-26 08:45:56.127854 | instance | Changed files:
2026-07-26 08:45:56.127873 | instance |   A	roles/placement/.ci-selective-test
2026-07-26 08:45:56.127883 | instance | Matches:
2026-07-26 08:45:56.127895 | instance |   roles/placement/.ci-selective-test: component:placement (targets) -> placement
2026-07-26 08:45:56.127909 | instance | Direct targets: placement
2026-07-26 08:45:56.127921 | instance | Deployment roots: placement
2026-07-26 08:45:56.127932 | instance | Verification profiles: placement
2026-07-26 08:45:56.127945 | instance | Variant openvswitch (13 components): ceph, cert-manager, cluster-issuer, csi, ingress-nginx, keycloak, keystone, kubernetes, memcached, percona-xtradb-cluster, percona-xtradb-cluster-operator, placement, rabbitmq-cluster-operator
2026-07-26 08:45:56.127955 | instance | Molecule jobs:
2026-07-26 08:45:56.127964 | instance |   aio-openvswitch: run (13 components) - executes the openvswitch deployment variant
2026-07-26 08:45:56.127974 | instance |   aio-ovn: skip - plan has no ovn deployment variant
2026-07-26 08:45:56.127983 | instance |   csi-local-path-provisioner: skip - none of the job's verification profiles were requested
2026-07-26 08:45:56.127991 | instance |   csi-rbd: skip - none of the job's verification profiles were requested
2026-07-26 08:45:56.128001 | instance |   keycloak: skip - none of the job's verification profiles were requested
2026-07-26 08:45:56.434087 | instance | ok: Runtime: 0:00:00.028824
2026-07-26 08:45:56.441221 | 
2026-07-26 08:45:56.441318 | TASK [Print selective CI plan]
2026-07-26 08:45:56.475897 | instance | ok
2026-07-26 08:45:56.480438 | 
2026-07-26 08:45:56.480508 | TASK [Report conservative fallback]
2026-07-26 08:45:56.508439 | instance | skipping: Conditional result was False
2026-07-26 08:45:56.517028 | 
2026-07-26 08:45:56.517124 | TASK [Create selective CI plan log directory]
2026-07-26 08:45:56.881557 | instance | changed
2026-07-26 08:45:57.012673 | 
2026-07-26 08:45:57.012764 | TASK [Publish selective CI plan with job logs]
2026-07-26 08:45:57.413489 | instance | changed
2026-07-26 08:45:58.179763 | 
2026-07-26 08:45:58.179922 | PLAY RECAP
2026-07-26 08:45:58.180023 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-26 08:45:58.180077 | 
2026-07-26 08:45:58.302479 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-26 08:45:58.314167 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-26 08:45:58.914920 | 
2026-07-26 08:45:59.182057 | PLAY [Run selected Molecule deployment and verification]
2026-07-26 08:45:59.200331 | 
2026-07-26 08:45:59.200449 | TASK [Check for selective CI plan]
2026-07-26 08:45:59.549758 | instance | ok
2026-07-26 08:45:59.557785 | 
2026-07-26 08:45:59.557863 | TASK [Validate selective CI plan]
2026-07-26 08:46:00.098142 | instance | ok: Runtime: 0:00:00.031941
2026-07-26 08:46:00.106318 | 
2026-07-26 08:46:00.106396 | TASK [Resolve selective CI plan availability]
2026-07-26 08:46:00.157888 | instance | ok
2026-07-26 08:46:00.164885 | 
2026-07-26 08:46:00.164962 | TASK [Read selective CI plan]
2026-07-26 08:46:00.503192 | instance | ok
2026-07-26 08:46:00.509183 | 
2026-07-26 08:46:00.509279 | TASK [Load selective CI plan or full fallback]
2026-07-26 08:46:00.551361 | instance | ok
2026-07-26 08:46:00.559528 | 
2026-07-26 08:46:00.559636 | TASK [Find this job in the selective CI plan]
2026-07-26 08:46:00.613732 | instance | ok
2026-07-26 08:46:00.619785 | 
2026-07-26 08:46:00.619854 | TASK [Resolve this job or use full fallback]
2026-07-26 08:46:00.696210 | instance | ok
2026-07-26 08:46:00.701002 | 
2026-07-26 08:46:00.701076 | TASK [Resolve deployment and verification inputs]
2026-07-26 08:46:00.801131 | instance | ok
2026-07-26 08:46:00.850577 | 
2026-07-26 08:46:00.850701 | TASK [Resolve deployment tags]
2026-07-26 08:46:00.902958 | instance | ok
2026-07-26 08:46:00.908301 | 
2026-07-26 08:46:00.908376 | TASK [Report Molecule job decision]
2026-07-26 08:46:00.948619 | 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': ['placement'], 'extra_vars': {}}
2026-07-26 08:46:00.955012 | 
2026-07-26 08:46:00.955076 | TASK [Copy inventory file for Zuul]
2026-07-26 08:46:00.979699 | instance | skipping: Conditional result was False
2026-07-26 08:46:00.988034 | 
2026-07-26 08:46:00.988205 | TASK [Switch ansible_host to private IP]
2026-07-26 08:46:01.005226 | instance | skipping: Conditional result was False
2026-07-26 08:46:01.014019 | 
2026-07-26 08:46:01.014099 | TASK [Prepare Molecule scenario]
2026-07-26 08:46:01.542907 | instance | skipping: Conditional result was False
2026-07-26 08:46:01.553559 | 
2026-07-26 08:46:01.865929 | TASK [Prepare host for Ceph-backed storage]
2026-07-26 08:46:02.404637 | instance | skipping: Conditional result was False
2026-07-26 08:46:02.416064 | 
2026-07-26 08:46:02.416145 | TASK [Build deployment command]
2026-07-26 08:46:02.443491 | instance | skipping: Conditional result was False
2026-07-26 08:46:02.451088 | 
2026-07-26 08:46:02.451168 | TASK [Run initial deployment with progress heartbeat]
2026-07-26 08:46:02.476331 | instance | skipping: Conditional result was False
2026-07-26 08:46:02.481924 | 
2026-07-26 08:46:02.481992 | TASK [Run idempotence deployment with progress heartbeat]
2026-07-26 08:46:02.507008 | instance | skipping: Conditional result was False
2026-07-26 08:46:02.512573 | 
2026-07-26 08:46:02.512653 | TASK [Check for br-ex interface]
2026-07-26 08:46:03.043656 | instance | skipping: Conditional result was False
2026-07-26 08:46:03.055353 | 
2026-07-26 08:46:03.055440 | TASK [Add IP address to br-ex]
2026-07-26 08:46:03.585377 | instance | skipping: Conditional result was False
2026-07-26 08:46:03.595898 | 
2026-07-26 08:46:03.595991 | TASK [Set br-ex interface up]
2026-07-26 08:46:04.124213 | instance | skipping: Conditional result was False
2026-07-26 08:46:04.137040 | 
2026-07-26 08:46:04.137125 | TASK [Resolve Molecule verification command]
2026-07-26 08:46:04.163458 | instance | skipping: Conditional result was False
2026-07-26 08:46:04.173858 | 
2026-07-26 08:46:04.173959 | TASK [Run Molecule verification with progress heartbeat]
2026-07-26 08:46:04.199787 | instance | skipping: Conditional result was False
2026-07-26 08:46:04.202115 | 
2026-07-26 08:46:04.202222 | PLAY RECAP
2026-07-26 08:46:04.202384 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0
2026-07-26 08:46:04.202439 | 
2026-07-26 08:46:04.414336 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-26 08:46:04.427232 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-26 08:46:05.164671 | 
2026-07-26 08:46:05.196177 | PLAY [all]
2026-07-26 08:46:05.214561 | 
2026-07-26 08:46:05.214648 | TASK [gather-host-logs : creating directory for system status]
2026-07-26 08:46:05.536345 | instance | ok
2026-07-26 08:46:05.552526 | 
2026-07-26 08:46:05.552709 | TASK [gather-host-logs : Get logs for each host]
2026-07-26 08:46:05.894106 | instance | + systemd-cgls --full --all --no-pager
2026-07-26 08:46:05.907116 | instance | + ip addr
2026-07-26 08:46:05.909839 | instance | + ip route
2026-07-26 08:46:05.912214 | instance | + lsblk
2026-07-26 08:46:05.916327 | instance | + mount
2026-07-26 08:46:05.919034 | instance | + docker images
2026-07-26 08:46:05.919535 | instance | /bin/bash: line 7: docker: command not found
2026-07-26 08:46:05.919859 | instance | + brctl show
2026-07-26 08:46:05.920364 | instance | /bin/bash: line 8: brctl: command not found
2026-07-26 08:46:05.920599 | instance | + ps aux --sort=-%mem
2026-07-26 08:46:05.935875 | instance | + dpkg -l
2026-07-26 08:46:05.945673 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-26 08:46:05.946123 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-26 08:46:05.946182 | instance | /bin/bash: line 11: docker: command not found
2026-07-26 08:46:05.946447 | instance | + '[' '!' -z '' ']'
2026-07-26 08:46:06.086935 | instance | ok: Runtime: 0:00:00.057985
2026-07-26 08:46:06.094604 | 
2026-07-26 08:46:06.094692 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-26 08:46:06.720778 | instance | ERROR
2026-07-26 08:46:06.720976 | instance | {
2026-07-26 08:46:06.721012 | instance |   "msg": "Warning: Permanently added '162.253.55.222' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/logs/instance/system/.ci-plan.json.hGQHrY\" failed: Invalid argument (22)\nrsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [generator=3.2.7]\n",
2026-07-26 08:46:06.721064 | instance |   "rc": 23
2026-07-26 08:46:06.721088 | instance | }
2026-07-26 08:46:06.721115 | instance | ERROR: Ignoring Errors
2026-07-26 08:46:06.729888 | 
2026-07-26 08:46:06.729958 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-26 08:46:06.928650 | instance | changed: "values"
2026-07-26 08:46:07.087850 | instance | changed: "releases"
2026-07-26 08:46:07.095199 | 
2026-07-26 08:46:07.095322 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-26 08:46:07.332669 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-26 08:46:07.632652 | instance | ok: Runtime: 0:00:00.006436
2026-07-26 08:46:07.639029 | 
2026-07-26 08:46:07.639098 | TASK [helm-release-status : Downloads logs to executor]
2026-07-26 08:46:08.143708 | instance | changed:
2026-07-26 08:46:08.143876 | instance | cd+++++++++ helm/
2026-07-26 08:46:08.143915 | instance | cd+++++++++ helm/releases/
2026-07-26 08:46:08.143945 | instance | cd+++++++++ helm/values/
2026-07-26 08:46:08.154745 | 
2026-07-26 08:46:08.154811 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-26 08:46:08.352700 | instance | changed
2026-07-26 08:46:08.359128 | 
2026-07-26 08:46:08.359216 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-26 08:46:08.566962 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 08:46:08.567208 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 08:46:08.572439 | instance | environment: line 1: kubectl: command not found
2026-07-26 08:46:08.573802 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 08:46:08.574348 | instance | environment: line 1: kubectl: command not found
2026-07-26 08:46:08.575332 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 08:46:08.577502 | instance | environment: line 1: kubectl: command not found
2026-07-26 08:46:08.578028 | instance | environment: line 1: kubectl: command not found
2026-07-26 08:46:08.578351 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 08:46:08.579492 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 08:46:08.580944 | instance | environment: line 1: kubectl: command not found
2026-07-26 08:46:08.581999 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 08:46:09.614502 | instance | ok: Runtime: 0:00:00.025864
2026-07-26 08:46:09.621187 | 
2026-07-26 08:46:09.621259 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-26 08:46:09.838219 | instance | changed
2026-07-26 08:46:09.844853 | 
2026-07-26 08:46:09.844932 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-26 08:46:10.050346 | instance | environment: line 5: kubectl: command not found
2026-07-26 08:46:10.051581 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 08:46:10.051784 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 08:46:10.051964 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 08:46:10.382247 | instance | ok: Runtime: 0:00:00.009202
2026-07-26 08:46:10.387655 | 
2026-07-26 08:46:10.387724 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-26 08:46:11.010025 | instance | changed:
2026-07-26 08:46:11.010178 | instance | cd+++++++++ objects/
2026-07-26 08:46:11.010207 | instance | cd+++++++++ objects/cluster/
2026-07-26 08:46:11.010229 | instance | cd+++++++++ objects/namespaced/
2026-07-26 08:46:11.018817 | 
2026-07-26 08:46:11.018878 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-26 08:46:11.213019 | instance | changed
2026-07-26 08:46:11.219121 | 
2026-07-26 08:46:11.219184 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-26 08:46:11.409952 | instance | changed
2026-07-26 08:46:11.414913 | 
2026-07-26 08:46:11.414979 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-26 08:46:11.632912 | instance | environment: line 3: kubectl: command not found
2026-07-26 08:46:11.952711 | instance | ok: Runtime: 0:00:00.008882
2026-07-26 08:46:11.959197 | 
2026-07-26 08:46:11.959260 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-26 08:46:12.459313 | instance | changed:
2026-07-26 08:46:12.459489 | instance | cd+++++++++ pod-logs/
2026-07-26 08:46:12.459528 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-26 08:46:12.469926 | 
2026-07-26 08:46:12.469983 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-26 08:46:12.674928 | instance | changed
2026-07-26 08:46:12.680835 | 
2026-07-26 08:46:12.680895 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-26 08:46:12.902838 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-26 08:46:13.221628 | instance | ok: Runtime: 0:00:00.037491
2026-07-26 08:46:13.227112 | 
2026-07-26 08:46:13.227179 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-26 08:46:13.445435 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-26 08:46:13.478671 | instance | ceph-mgr endpoints:
2026-07-26 08:46:13.769109 | instance | ok: Runtime: 0:00:00.040468
2026-07-26 08:46:13.782256 | 
2026-07-26 08:46:13.782356 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-26 08:46:14.063046 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-26 08:46:14.389813 | instance | ok: Runtime: 0:00:00.037976
2026-07-26 08:46:14.396461 | 
2026-07-26 08:46:14.396561 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-26 08:46:14.916383 | instance | changed: cd+++++++++ prometheus/
2026-07-26 08:46:14.926390 | 
2026-07-26 08:46:14.926453 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-26 08:46:15.122673 | instance | changed
2026-07-26 08:46:15.127629 | 
2026-07-26 08:46:15.127698 | TASK [gather-selenium-data : Get selenium data]
2026-07-26 08:46:15.347775 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-26 08:46:15.349377 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-26 08:46:15.661413 | instance | ERROR
2026-07-26 08:46:15.703048 | instance | {
2026-07-26 08:46:15.703200 | instance |   "delta": "0:00:00.007439",
2026-07-26 08:46:15.703902 | instance |   "end": "2026-07-26 08:46:15.349806",
2026-07-26 08:46:15.703984 | instance |   "msg": "non-zero return code",
2026-07-26 08:46:15.704052 | instance |   "rc": 1,
2026-07-26 08:46:15.704109 | instance |   "start": "2026-07-26 08:46:15.342367"
2026-07-26 08:46:15.704175 | instance | }
2026-07-26 08:46:15.704267 | instance | ERROR: Ignoring Errors
2026-07-26 08:46:15.720679 | 
2026-07-26 08:46:15.720821 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-26 08:46:16.214993 | instance | changed: cd+++++++++ selenium/
2026-07-26 08:46:16.223146 | 
2026-07-26 08:46:16.223194 | PLAY RECAP
2026-07-26 08:46:16.223237 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2
2026-07-26 08:46:16.223258 | 
2026-07-26 08:46:16.330926 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-26 08:46:16.339309 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 08:46:17.321979 | 
2026-07-26 08:46:17.322088 | PLAY [all]
2026-07-26 08:46:17.332882 | 
2026-07-26 08:46:17.332960 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-26 08:46:17.377740 | instance | skipping: Conditional result was False
2026-07-26 08:46:17.388147 | 
2026-07-26 08:46:17.388226 | TASK [fetch-output : Set log path for single node]
2026-07-26 08:46:17.433001 | instance | ok
2026-07-26 08:46:17.440287 | 
2026-07-26 08:46:17.440359 | LOOP [fetch-output : Ensure local output dirs]
2026-07-26 08:46:17.823568 | instance -> localhost | ok: "/var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/logs"
2026-07-26 08:46:18.035015 | instance -> localhost | changed: "/var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/artifacts"
2026-07-26 08:46:18.249289 | instance -> localhost | changed: "/var/lib/zuul/builds/0ec5b3ee7ca348419c559741442e522d/work/docs"
2026-07-26 08:46:18.263813 | 
2026-07-26 08:46:18.263928 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-26 08:46:18.916449 | instance | changed: .d..t...... ./
2026-07-26 08:46:18.916764 | instance | changed: All items complete
2026-07-26 08:46:18.916811 | 
2026-07-26 08:46:19.399979 | instance | changed: .d..t...... ./
2026-07-26 08:46:19.877428 | instance | changed: .d..t...... ./
2026-07-26 08:46:19.899920 | 
2026-07-26 08:46:19.900034 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-26 08:46:20.418169 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.043778
2026-07-26 08:46:20.644815 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007653
2026-07-26 08:46:20.664748 | 
2026-07-26 08:46:20.676613 | PLAY [all]
2026-07-26 08:46:20.686602 | 
2026-07-26 08:46:20.686696 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-26 08:46:21.102742 | instance | changed
2026-07-26 08:46:21.109844 | 
2026-07-26 08:46:21.109909 | PLAY RECAP
2026-07-26 08:46:21.109969 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-26 08:46:21.109998 | 
2026-07-26 08:46:21.219215 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 08:46:21.231429 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-26 08:46:21.843447 | 
2026-07-26 08:46:21.843550 | PLAY [localhost]
2026-07-26 08:46:21.853138 | 
2026-07-26 08:46:21.853209 | TASK [Generate Zuul manifest]
2026-07-26 08:46:21.873787 | localhost | ok
2026-07-26 08:46:21.890811 | 
2026-07-26 08:46:21.890888 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-26 08:46:22.598667 | localhost | changed
2026-07-26 08:46:22.764856 | 
2026-07-26 08:46:22.765001 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-26 08:46:23.029603 | localhost | ok
2026-07-26 08:46:23.037798 | 
2026-07-26 08:46:23.037860 | TASK [Upload logs]
2026-07-26 08:46:23.057434 | localhost | ok
2026-07-26 08:46:23.215164 | 
2026-07-26 08:46:23.215288 | TASK [Set zuul-log-path fact]
2026-07-26 08:46:23.237016 | localhost | ok
2026-07-26 08:46:23.250535 | 
2026-07-26 08:46:23.250605 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 08:46:23.279793 | localhost | ok
2026-07-26 08:46:23.289563 | 
2026-07-26 08:46:23.289631 | TASK [upload-logs : Create log directories]
2026-07-26 08:46:23.634349 | localhost | changed
2026-07-26 08:46:23.639600 | 
2026-07-26 08:46:23.639687 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-26 08:46:23.991364 | localhost -> localhost | ok: Runtime: 0:00:00.006678
2026-07-26 08:46:23.999910 | 
2026-07-26 08:46:23.999983 | TASK [upload-logs : Upload logs to log server]
2026-07-26 08:46:24.565572 | localhost | Output suppressed because no_log was given
2026-07-26 08:46:24.570686 | 
2026-07-26 08:46:24.570782 | LOOP [upload-logs : Compress console log and json output]
2026-07-26 08:46:24.619493 | localhost | skipping: Conditional result was False
2026-07-26 08:46:24.625913 | localhost | skipping: Conditional result was False
2026-07-26 08:46:24.645548 | 
2026-07-26 08:46:24.645656 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-26 08:46:24.691320 | localhost | skipping: Conditional result was False
2026-07-26 08:46:24.691760 | 
2026-07-26 08:46:24.695527 | localhost | skipping: Conditional result was False
2026-07-26 08:46:24.710311 | 
2026-07-26 08:46:24.710432 | LOOP [upload-logs : Upload console log and json output]