2026-06-08 07:42:34.699827 | Job console starting 2026-06-08 07:42:34.712637 | Updating git repos 2026-06-08 07:42:36.610832 | Cloning repos into workspace 2026-06-08 07:42:50.015709 | Restoring repo states 2026-06-08 07:43:02.228381 | Merging changes 2026-06-08 07:43:04.345339 | Checking out repos 2026-06-08 07:43:07.622557 | Preparing playbooks 2026-06-08 07:43:18.015097 | Running Ansible setup 2026-06-08 07:43:21.568166 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 07:43:22.209009 | 2026-06-08 07:43:22.209219 | PLAY [localhost] 2026-06-08 07:43:22.218333 | 2026-06-08 07:43:22.218482 | TASK [Gathering Facts] 2026-06-08 07:43:23.139530 | localhost | ok 2026-06-08 07:43:23.149526 | 2026-06-08 07:43:23.149655 | TASK [Setup log path fact] 2026-06-08 07:43:23.171148 | localhost | ok 2026-06-08 07:43:23.183936 | 2026-06-08 07:43:23.184020 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 07:43:23.214465 | localhost | ok 2026-06-08 07:43:23.223209 | 2026-06-08 07:43:23.223309 | TASK [emit-job-header : Print job information] 2026-06-08 07:43:23.263773 | # Job Information 2026-06-08 07:43:23.263981 | Ansible Version: 2.16.18 2026-06-08 07:43:23.264027 | Job: atmosphere-molecule-keycloak 2026-06-08 07:43:23.264059 | Pipeline: check 2026-06-08 07:43:23.264087 | Executor: 2d72f0692154 2026-06-08 07:43:23.264114 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4002 2026-06-08 07:43:23.264146 | Event ID: 7407a9e0-630d-11f1-8eff-003ad6dab313 2026-06-08 07:43:23.268201 | 2026-06-08 07:43:23.268293 | LOOP [emit-job-header : Print node information] 2026-06-08 07:43:23.368401 | localhost | ok: 2026-06-08 07:43:23.368809 | localhost | # Node Information 2026-06-08 07:43:23.368883 | localhost | Inventory Hostname: instance 2026-06-08 07:43:23.368933 | localhost | Hostname: np0000178870 2026-06-08 07:43:23.369055 | localhost | Username: zuul 2026-06-08 07:43:23.369110 | localhost | Distro: Ubuntu 22.04 2026-06-08 07:43:23.369154 | localhost | Provider: yul1 2026-06-08 07:43:23.369195 | localhost | Region: ca-ymq-1 2026-06-08 07:43:23.369234 | localhost | Label: ubuntu-jammy 2026-06-08 07:43:23.369274 | localhost | Product Name: OpenStack Nova 2026-06-08 07:43:23.369298 | localhost | Interface IP: 199.19.213.191 2026-06-08 07:43:23.388872 | 2026-06-08 07:43:23.389091 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-08 07:43:23.835497 | localhost -> localhost | changed 2026-06-08 07:43:23.842738 | 2026-06-08 07:43:23.842841 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-08 07:43:24.738353 | localhost -> localhost | changed 2026-06-08 07:43:24.748086 | 2026-06-08 07:43:24.748147 | PLAY [all] 2026-06-08 07:43:24.756168 | 2026-06-08 07:43:24.756246 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-08 07:43:25.005877 | instance -> localhost | ok 2026-06-08 07:43:25.019991 | 2026-06-08 07:43:25.020102 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-08 07:43:25.054131 | instance | ok 2026-06-08 07:43:25.071398 | instance | included: /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-08 07:43:25.076911 | 2026-06-08 07:43:25.077013 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-08 07:43:27.758038 | instance -> localhost | Generating public/private rsa key pair. 2026-06-08 07:43:27.758322 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/0212c33fef334eac90c32f9681584ee1_id_rsa 2026-06-08 07:43:27.758389 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/0212c33fef334eac90c32f9681584ee1_id_rsa.pub 2026-06-08 07:43:27.758474 | instance -> localhost | The key fingerprint is: 2026-06-08 07:43:27.758536 | instance -> localhost | SHA256:n8WmzuAYusxjRArjXIMy0enrT3RlrPa9Qf5+0y8Be9E zuul-build-sshkey 2026-06-08 07:43:27.758604 | instance -> localhost | The key's randomart image is: 2026-06-08 07:43:27.758653 | instance -> localhost | +---[RSA 3072]----+ 2026-06-08 07:43:27.758713 | instance -> localhost | | . . | 2026-06-08 07:43:27.758762 | instance -> localhost | |. o . | 2026-06-08 07:43:27.758807 | instance -> localhost | | o. + . | 2026-06-08 07:43:27.758849 | instance -> localhost | |=..o. + .. . E| 2026-06-08 07:43:27.758891 | instance -> localhost | |++.+o + S . +o . | 2026-06-08 07:43:27.758933 | instance -> localhost | | oo..o . = =. o | 2026-06-08 07:43:27.758982 | instance -> localhost | | . .. . o B . o | 2026-06-08 07:43:27.759031 | instance -> localhost | | .+o. + + + + .| 2026-06-08 07:43:27.759080 | instance -> localhost | | o*o. . +.o. oo| 2026-06-08 07:43:27.759124 | instance -> localhost | +----[SHA256]-----+ 2026-06-08 07:43:27.759330 | instance -> localhost | ok: Runtime: 0:00:02.240776 2026-06-08 07:43:27.766550 | 2026-06-08 07:43:27.766612 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-08 07:43:27.800848 | instance | ok 2026-06-08 07:43:27.812222 | instance | included: /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-08 07:43:27.820569 | 2026-06-08 07:43:27.820634 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-08 07:43:27.844975 | instance | skipping: Conditional result was False 2026-06-08 07:43:27.853722 | 2026-06-08 07:43:27.853792 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-08 07:43:28.302344 | instance | changed 2026-06-08 07:43:28.309928 | 2026-06-08 07:43:28.310038 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-08 07:43:28.482827 | instance | ok 2026-06-08 07:43:28.491073 | 2026-06-08 07:43:28.491182 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-08 07:43:28.955935 | instance | changed 2026-06-08 07:43:28.961277 | 2026-06-08 07:43:28.961345 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-08 07:43:29.453672 | instance | changed 2026-06-08 07:43:29.467319 | 2026-06-08 07:43:29.467475 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-08 07:43:29.493449 | instance | skipping: Conditional result was False 2026-06-08 07:43:29.506481 | 2026-06-08 07:43:29.506602 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-08 07:43:29.907777 | instance -> localhost | changed 2026-06-08 07:43:29.921752 | 2026-06-08 07:43:29.921897 | TASK [add-build-sshkey : Add back temp key] 2026-06-08 07:43:30.199912 | instance -> localhost | Identity added: /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/0212c33fef334eac90c32f9681584ee1_id_rsa (zuul-build-sshkey) 2026-06-08 07:43:30.200170 | instance -> localhost | ok: Runtime: 0:00:00.015172 2026-06-08 07:43:30.207194 | 2026-06-08 07:43:30.207276 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-08 07:43:30.549521 | instance | ok 2026-06-08 07:43:30.556395 | 2026-06-08 07:43:30.556479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-08 07:43:30.581861 | instance | skipping: Conditional result was False 2026-06-08 07:43:30.649996 | 2026-06-08 07:43:30.650313 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-08 07:43:30.978560 | instance | ok 2026-06-08 07:43:30.985818 | 2026-06-08 07:43:30.985912 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-08 07:43:34.503486 | instance | Output suppressed because no_log was given 2026-06-08 07:43:34.513871 | 2026-06-08 07:43:34.513962 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-08 07:43:34.699233 | instance | ok: "logs" 2026-06-08 07:43:34.699501 | instance | ok: All items complete 2026-06-08 07:43:34.699531 | 2026-06-08 07:43:34.845147 | instance | ok: "artifacts" 2026-06-08 07:43:35.024290 | instance | ok: "docs" 2026-06-08 07:43:35.039984 | 2026-06-08 07:43:35.040171 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-08 07:43:35.224882 | instance | changed: "logs" 2026-06-08 07:43:35.379626 | instance | changed: "artifacts" 2026-06-08 07:43:35.550871 | instance | changed: "docs" 2026-06-08 07:43:35.572404 | 2026-06-08 07:43:35.572558 | PLAY RECAP 2026-06-08 07:43:35.572628 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-08 07:43:35.572670 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:43:35.572702 | 2026-06-08 07:43:35.740869 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-08 07:43:35.743706 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-08 07:43:36.373956 | 2026-06-08 07:43:36.374119 | PLAY [all] 2026-06-08 07:43:36.385984 | 2026-06-08 07:43:36.386068 | TASK [setup-uv : Extract archive] 2026-06-08 07:43:40.961197 | instance | changed 2026-06-08 07:43:40.968147 | 2026-06-08 07:43:40.968239 | TASK [setup-uv : Print version] 2026-06-08 07:43:41.311671 | instance | uv 0.8.13 2026-06-08 07:43:41.521628 | instance | ok: Runtime: 0:00:00.012742 2026-06-08 07:43:41.531861 | 2026-06-08 07:43:41.531936 | TASK [Install Ansible collection siblings] 2026-06-08 07:43:50.561152 | instance | changed: 2026-06-08 07:43:50.770359 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-06-08 07:43:50.770603 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-06-08 07:43:50.770668 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-06-08 07:43:50.770715 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-06-08 07:43:50.770760 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-06-08 07:43:50.770816 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-06-08 07:43:50.770864 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-06-08 07:43:50.770916 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-06-08 07:43:50.770961 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-06-08 07:43:50.771005 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-06-08 07:43:50.771049 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-06-08 07:43:50.771092 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-06-08 07:43:50.771134 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-06-08 07:43:50.771177 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-06-08 07:43:50.771220 | instance | Resolved ansible.utils to v6.0.2 for >=2.9.0 2026-06-08 07:43:50.771263 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-06-08 07:43:50.771305 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-06-08 07:43:50.771347 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-06-08 07:43:50.771389 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-06-08 07:43:50.771430 | instance | Resolved openstack.cloud to 2.5.0 for >=2.0.0 2026-06-08 07:43:50.771471 | instance | Resolved vexxhost.ceph to v4.0.0 for >=3.2.0 2026-06-08 07:43:50.771513 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-06-08 07:43:50.771557 | instance | Keeping vexxhost.kubernetes at speculative checkout 2026-06-08 07:43:50.771627 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-06-08 07:43:50.771673 | instance | Resolved ansible.utils to v6.0.2 for >=2.9.0,>=6.0.0 2026-06-08 07:43:50.771715 | instance | Resolved vexxhost.containers to v1.6.7 for >=1.1.1,>=1.6.0 2026-06-08 07:43:50.771756 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-06-08 07:43:50.771797 | instance | Keeping vexxhost.kubernetes at speculative checkout 2026-06-08 07:43:50.771840 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-06-08 07:43:50.771881 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-06-08 07:43:50.771922 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-06-08 07:43:50.771965 | instance | Resolved vexxhost.containers to v1.6.7 for >=1.1.1,>=1.6.0 2026-06-08 07:43:50.772007 | instance | Checked out ansible.netcommon to 1.2.0 2026-06-08 07:43:50.772049 | 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-06-08 07:43:50.772100 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.772141 | instance | Process install dependency map 2026-06-08 07:43:50.772182 | instance | Starting collection install process 2026-06-08 07:43:50.772224 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-06-08 07:43:50.772273 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-06-08 07:43:50.772330 | instance | ansible.netcommon:* was installed successfully 2026-06-08 07:43:50.772373 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-06-08 07:43:50.772414 | instance | Creating virtual environment at: .venv 2026-06-08 07:43:50.772455 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-06-08 07:43:50.772496 | instance | Downloading setuptools (1.1MiB) 2026-06-08 07:43:50.772536 | instance | Downloading rjsonnet (1.2MiB) 2026-06-08 07:43:50.772583 | instance | Downloading pygments (1.2MiB) 2026-06-08 07:43:50.772624 | instance | Downloading cryptography (4.2MiB) 2026-06-08 07:43:50.772666 | instance | Downloading pydantic-core (2.0MiB) 2026-06-08 07:43:50.772708 | instance | Downloading kubernetes (1.9MiB) 2026-06-08 07:43:50.772748 | instance | Downloading openstacksdk (1.7MiB) 2026-06-08 07:43:50.772791 | instance | Downloading ansible-core (2.1MiB) 2026-06-08 07:43:50.772833 | instance | Downloading netaddr (2.2MiB) 2026-06-08 07:43:50.772875 | instance | Building pyperclip==1.9.0 2026-06-08 07:43:50.772922 | instance | Downloading rjsonnet 2026-06-08 07:43:50.773094 | instance | Downloading pydantic-core 2026-06-08 07:43:50.773147 | instance | Downloading pygments 2026-06-08 07:43:50.773191 | instance | Downloading netaddr 2026-06-08 07:43:50.773231 | instance | Downloading cryptography 2026-06-08 07:43:50.773260 | instance | Downloading setuptools 2026-06-08 07:43:50.773285 | instance | Downloading kubernetes 2026-06-08 07:43:50.773311 | instance | Downloading ansible-core 2026-06-08 07:43:50.773337 | instance | Downloading openstacksdk 2026-06-08 07:43:50.773364 | instance | Built pyperclip==1.9.0 2026-06-08 07:43:50.773391 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-06-08 07:43:50.773418 | instance | Installed 83 packages in 42ms 2026-06-08 07:43:50.773444 | instance | Checked out ansible.posix to 1.6.0 2026-06-08 07:43:50.773470 | 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-06-08 07:43:50.773496 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.773522 | instance | Process install dependency map 2026-06-08 07:43:50.773547 | instance | Starting collection install process 2026-06-08 07:43:50.773581 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-06-08 07:43:50.773609 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-06-08 07:43:50.773636 | instance | ansible.posix:1.6.0 was installed successfully 2026-06-08 07:43:50.773664 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.773690 | instance | 2.17.12 2026-06-08 07:43:50.773716 | instance | Checked out ansible.utils to v6.0.2 2026-06-08 07:43:50.773742 | 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-06-08 07:43:50.773768 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.773794 | instance | Process install dependency map 2026-06-08 07:43:50.773819 | instance | Starting collection install process 2026-06-08 07:43:50.773845 | instance | Installing 'ansible.utils:6.0.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-06-08 07:43:50.773872 | instance | Created collection for ansible.utils:6.0.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-06-08 07:43:50.773899 | instance | ansible.utils:6.0.2 was installed successfully 2026-06-08 07:43:50.773925 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.773951 | instance | 2.17.12 2026-06-08 07:43:50.773976 | instance | Checked out atmosphere.common to v0.7.0 2026-06-08 07:43:50.774002 | 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-06-08 07:43:50.774028 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.774054 | instance | Process install dependency map 2026-06-08 07:43:50.774080 | instance | Starting collection install process 2026-06-08 07:43:50.774106 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-06-08 07:43:50.774131 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-06-08 07:43:50.774202 | instance | atmosphere.common:0.7.0 was installed successfully 2026-06-08 07:43:50.774243 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.774269 | instance | 2.17.12 2026-06-08 07:43:50.774296 | instance | Checked out community.crypto to 2.2.3 2026-06-08 07:43:50.774321 | 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-06-08 07:43:50.774347 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.774373 | instance | Process install dependency map 2026-06-08 07:43:50.774399 | instance | Starting collection install process 2026-06-08 07:43:50.774426 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-06-08 07:43:50.774451 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-06-08 07:43:50.774477 | instance | community.crypto:2.2.3 was installed successfully 2026-06-08 07:43:50.774502 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.774528 | instance | 2.17.12 2026-06-08 07:43:50.774553 | instance | Checked out community.general to 7.3.0 2026-06-08 07:43:50.774579 | 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-06-08 07:43:50.774616 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.774643 | instance | Process install dependency map 2026-06-08 07:43:50.774670 | instance | Starting collection install process 2026-06-08 07:43:50.774697 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-06-08 07:43:50.774762 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-06-08 07:43:50.774798 | instance | community.general:7.3.0 was installed successfully 2026-06-08 07:43:50.774828 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.774854 | instance | 2.17.12 2026-06-08 07:43:50.774883 | instance | Checked out community.mysql to 3.6.0 2026-06-08 07:43:50.774913 | 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-06-08 07:43:50.774940 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.774967 | instance | Process install dependency map 2026-06-08 07:43:50.774994 | instance | Starting collection install process 2026-06-08 07:43:50.775019 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-06-08 07:43:50.775045 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-06-08 07:43:50.775071 | instance | community.mysql:3.6.0 was installed successfully 2026-06-08 07:43:50.775098 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.775123 | instance | 2.17.12 2026-06-08 07:43:50.775148 | instance | Checked out kubernetes.core to 2.4.0 2026-06-08 07:43:50.775175 | 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-06-08 07:43:50.775202 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.775232 | instance | Process install dependency map 2026-06-08 07:43:50.775258 | instance | Starting collection install process 2026-06-08 07:43:50.775284 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-06-08 07:43:50.775310 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-06-08 07:43:50.775336 | instance | kubernetes.core:2.4.0 was installed successfully 2026-06-08 07:43:50.775362 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.775388 | instance | 2.17.12 2026-06-08 07:43:50.775414 | instance | Checked out openstack.cloud to 2.5.0 2026-06-08 07:43:50.775440 | 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-06-08 07:43:50.775467 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.775492 | instance | Process install dependency map 2026-06-08 07:43:50.775518 | instance | Starting collection install process 2026-06-08 07:43:50.775543 | instance | Installing 'openstack.cloud:2.5.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-06-08 07:43:50.775569 | instance | Created collection for openstack.cloud:2.5.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-06-08 07:43:50.775594 | instance | openstack.cloud:2.5.0 was installed successfully 2026-06-08 07:43:50.775620 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.775645 | instance | 2.17.12 2026-06-08 07:43:50.775680 | instance | Checked out vexxhost.ceph to v4.0.0 2026-06-08 07:43:50.775707 | 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-06-08 07:43:50.775739 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.775774 | instance | Process install dependency map 2026-06-08 07:43:50.775801 | instance | Starting collection install process 2026-06-08 07:43:50.775828 | instance | Installing 'vexxhost.ceph:4.0.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-06-08 07:43:50.775854 | instance | Created collection for vexxhost.ceph:4.0.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-06-08 07:43:50.775880 | instance | vexxhost.ceph:4.0.0 was installed successfully 2026-06-08 07:43:50.775906 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.775932 | instance | 2.17.12 2026-06-08 07:43:50.775958 | instance | Checked out vexxhost.containers to v1.6.7 2026-06-08 07:43:50.775983 | 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-06-08 07:43:50.776009 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.776035 | instance | Process install dependency map 2026-06-08 07:43:50.776061 | instance | Starting collection install process 2026-06-08 07:43:50.776087 | instance | Installing 'vexxhost.containers:1.6.7' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-06-08 07:43:50.776112 | instance | Created collection for vexxhost.containers:1.6.7 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-06-08 07:43:50.776139 | instance | vexxhost.containers:1.6.7 was installed successfully 2026-06-08 07:43:50.776165 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.776191 | instance | 2.17.12 2026-06-08 07:43:50.776217 | 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-06-08 07:43:50.776248 | instance | Starting galaxy collection install process 2026-06-08 07:43:50.776274 | instance | Process install dependency map 2026-06-08 07:43:50.776300 | instance | Starting collection install process 2026-06-08 07:43:50.776325 | instance | Installing 'vexxhost.kubernetes:3.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-06-08 07:43:50.776350 | instance | Created collection for vexxhost.kubernetes:3.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-06-08 07:43:50.776376 | instance | vexxhost.kubernetes:3.1.0 was installed successfully 2026-06-08 07:43:50.776401 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:43:50.776426 | instance | 2.17.12 2026-06-08 07:43:50.784617 | 2026-06-08 07:43:50.784668 | PLAY RECAP 2026-06-08 07:43:50.784716 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:43:50.784738 | 2026-06-08 07:43:50.941436 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-08 07:43:50.946438 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-06-08 07:43:51.595338 | 2026-06-08 07:43:51.595484 | PLAY [all] 2026-06-08 07:43:51.610082 | 2026-06-08 07:43:51.610243 | TASK [Install "jq" for log collection] 2026-06-08 07:44:00.725666 | instance | changed 2026-06-08 07:44:00.728872 | 2026-06-08 07:44:00.728939 | PLAY RECAP 2026-06-08 07:44:00.729023 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:44:00.729077 | 2026-06-08 07:44:00.910228 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-06-08 07:44:00.914415 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-08 07:44:01.608444 | 2026-06-08 07:44:01.608634 | PLAY [all] 2026-06-08 07:44:01.623734 | 2026-06-08 07:44:01.623903 | TASK [Copy inventory file for Zuul] 2026-06-08 07:44:02.512502 | instance | changed 2026-06-08 07:44:02.520806 | 2026-06-08 07:44:02.520907 | TASK [Switch "ansible_host" to private IP] 2026-06-08 07:44:02.923873 | instance | changed: 1 replacements made 2026-06-08 07:44:02.936574 | 2026-06-08 07:44:02.936830 | TASK [Run Molecule scenario] 2026-06-08 07:44:03.829928 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-06-08 07:44:04.204396 | instance | INFO [keycloak > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-06-08 07:44:04.204477 | instance | INFO [keycloak > prerun] Performing prerun with role_name_check=0... 2026-06-08 07:44:09.940098 | instance | WARNING Retrying execution failure 1 of: ansible-galaxy collection install -vvv vexxhost.kubernetes:>=3.2.0 2026-06-08 07:44:09.940205 | instance | ERROR Command ansible-galaxy collection install -vvv vexxhost.kubernetes:>=3.2.0, returned 1 code: 2026-06-08 07:44:09.940218 | instance | Starting galaxy collection install process 2026-06-08 07:44:09.940228 | instance | Process install dependency map 2026-06-08 07:44:09.940238 | instance | 2026-06-08 07:44:09.940247 | instance | ansible-galaxy 2026-06-08 07:44:09.940257 | instance | config file = None 2026-06-08 07:44:09.940266 | instance | configured module search path = 2026-06-08 07:44:09.940276 | instance | ansible python module location = /home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/ansible 2026-06-08 07:44:09.940305 | instance | ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/local/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages 2026-06-08 07:44:09.940316 | instance | executable location = /home/zuul/src/github.com/vexxhost/atmosphere/.venv/bin/ansible-galaxy 2026-06-08 07:44:09.940325 | instance | python version = 3.10.12 (main, Mar 3 2026, 11:56:32) (/home/zuul/src/github.com/vexxhost/atmosphere/.venv/bin/python) 2026-06-08 07:44:09.940334 | instance | jinja version = 3.1.6 2026-06-08 07:44:09.940343 | instance | libyaml = True 2026-06-08 07:44:09.940352 | instance | No config file found; using defaults 2026-06-08 07:44:09.940361 | instance | Found installed collection kubernetes.core:2.4.0 at '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-06-08 07:44:09.940370 | instance | : Collection ansible.netcommon does not support Ansible version 2026-06-08 07:44:09.940379 | instance | 2.17.12 2026-06-08 07:44:09.940388 | instance | Found installed collection ansible.netcommon:* at '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-06-08 07:44:09.940397 | instance | Found installed collection community.mysql:3.6.0 at '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-06-08 07:44:09.940406 | instance | Found installed collection openstack.cloud:2.5.0 at '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-06-08 07:44:09.940415 | instance | Found installed collection vexxhost.ceph:4.0.0 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-06-08 07:44:09.940424 | instance | Found installed collection atmosphere.common:0.7.0 at '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-06-08 07:44:09.940433 | instance | Found installed collection vexxhost.containers:1.6.7 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-06-08 07:44:09.940442 | instance | Found installed collection ansible.posix:1.6.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-06-08 07:44:09.940451 | instance | Found installed collection community.general:7.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-06-08 07:44:09.940460 | instance | Found installed collection ansible.utils:6.0.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-06-08 07:44:09.940469 | instance | Found installed collection vexxhost.kubernetes:3.1.0 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-06-08 07:44:09.940477 | instance | Found installed collection community.crypto:2.2.3 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-06-08 07:44:09.940486 | instance | Created /home/zuul/.ansible/galaxy_token 2026-06-08 07:44:09.940495 | instance | ERROR! Failed to resolve the requested dependencies map. Could not satisfy the following requirements: 2026-06-08 07:44:09.940578 | instance | * vexxhost.kubernetes:>=3.2.0 (direct request) 2026-06-08 07:44:09.940589 | instance | Hint: Pre-releases hosted on Galaxy or Automation Hub are not installed by default unless a specific version is requested. To enable pre-releases globally, use --pre. 2026-06-08 07:44:09.940598 | instance | 2026-06-08 07:44:09.941059 | instance | Traceback (most recent call last): 2026-06-08 07:44:09.941366 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/bin/molecule", line 10, in 2026-06-08 07:44:09.941868 | instance | sys.exit(main()) 2026-06-08 07:44:09.942152 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/core.py", line 1442, in __call__ 2026-06-08 07:44:09.942872 | instance | return self.main(*args, **kwargs) 2026-06-08 07:44:09.943156 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/core.py", line 1363, in main 2026-06-08 07:44:09.943831 | instance | rv = self.invoke(ctx) 2026-06-08 07:44:09.944108 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/core.py", line 1830, in invoke 2026-06-08 07:44:09.944888 | instance | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-06-08 07:44:09.945173 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/core.py", line 1226, in invoke 2026-06-08 07:44:09.945782 | instance | return ctx.invoke(self.callback, **ctx.params) 2026-06-08 07:44:09.946083 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/core.py", line 794, in invoke 2026-06-08 07:44:09.946630 | instance | return callback(*args, **kwargs) 2026-06-08 07:44:09.946911 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/molecule/click_cfg.py", line 583, in wrapper 2026-06-08 07:44:09.947474 | instance | return func(*args, **kwargs) 2026-06-08 07:44:09.947818 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/click/decorators.py", line 34, in new_func 2026-06-08 07:44:09.948197 | instance | return f(get_current_context(), *args, **kwargs) 2026-06-08 07:44:09.948458 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/molecule/click_cfg.py", line 418, in wrapper 2026-06-08 07:44:09.948832 | instance | return func(ctx) 2026-06-08 07:44:09.948981 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/molecule/command/test.py", line 81, in test 2026-06-08 07:44:09.949139 | instance | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-06-08 07:44:09.949261 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios 2026-06-08 07:44:09.949468 | instance | _run_scenarios(scenarios, command_args, default_config) 2026-06-08 07:44:09.949595 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/molecule/command/base.py", line 240, in _run_scenarios 2026-06-08 07:44:09.949775 | instance | scenario.config.runtime.prepare_environment( 2026-06-08 07:44:09.949898 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/ansible_compat/runtime.py", line 694, in prepare_environment 2026-06-08 07:44:09.950147 | instance | self.install_collection( 2026-06-08 07:44:09.950268 | instance | File "/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/ansible_compat/runtime.py", line 552, in install_collection 2026-06-08 07:44:09.950490 | instance | raise InvalidPrerequisiteError(msg) 2026-06-08 07:44:09.951647 | instance | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv vexxhost.kubernetes:>=3.2.0, returned 1 code: 2026-06-08 07:44:09.951659 | instance | Starting galaxy collection install process 2026-06-08 07:44:09.951665 | instance | Process install dependency map 2026-06-08 07:44:09.951671 | instance | 2026-06-08 07:44:09.951676 | instance | ansible-galaxy [core 2.17.12] 2026-06-08 07:44:09.951688 | instance | config file = None 2026-06-08 07:44:09.951694 | instance | configured module search path = ['/home/zuul/src/github.com/vexxhost/atmosphere/plugins/modules', '/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-06-08 07:44:09.951700 | instance | ansible python module location = /home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages/ansible 2026-06-08 07:44:09.951706 | instance | ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/local/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/atmosphere/.venv/lib/python3.10/site-packages 2026-06-08 07:44:09.951712 | instance | executable location = /home/zuul/src/github.com/vexxhost/atmosphere/.venv/bin/ansible-galaxy 2026-06-08 07:44:09.951718 | instance | python version = 3.10.12 (main, Mar 3 2026, 11:56:32) [GCC 11.4.0] (/home/zuul/src/github.com/vexxhost/atmosphere/.venv/bin/python) 2026-06-08 07:44:09.951724 | instance | jinja version = 3.1.6 2026-06-08 07:44:09.951729 | instance | libyaml = True 2026-06-08 07:44:09.951735 | instance | No config file found; using defaults 2026-06-08 07:44:09.951740 | instance | Found installed collection kubernetes.core:2.4.0 at '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-06-08 07:44:09.951746 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-06-08 07:44:09.951751 | instance | 2.17.12 2026-06-08 07:44:09.951757 | instance | Found installed collection ansible.netcommon:* at '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-06-08 07:44:09.951762 | instance | Found installed collection community.mysql:3.6.0 at '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-06-08 07:44:09.951768 | instance | Found installed collection openstack.cloud:2.5.0 at '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-06-08 07:44:09.951773 | instance | Found installed collection vexxhost.ceph:4.0.0 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-06-08 07:44:09.951779 | instance | Found installed collection atmosphere.common:0.7.0 at '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-06-08 07:44:09.951784 | instance | Found installed collection vexxhost.containers:1.6.7 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-06-08 07:44:09.951789 | instance | Found installed collection ansible.posix:1.6.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-06-08 07:44:09.951795 | instance | Found installed collection community.general:7.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-06-08 07:44:09.951800 | instance | Found installed collection ansible.utils:6.0.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-06-08 07:44:09.951806 | instance | Found installed collection vexxhost.kubernetes:3.1.0 at '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-06-08 07:44:09.951811 | instance | Found installed collection community.crypto:2.2.3 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-06-08 07:44:09.951817 | instance | Created /home/zuul/.ansible/galaxy_token 2026-06-08 07:44:09.951822 | instance | ERROR! Failed to resolve the requested dependencies map. Could not satisfy the following requirements: 2026-06-08 07:44:09.951828 | instance | * vexxhost.kubernetes:>=3.2.0 (direct request) 2026-06-08 07:44:09.951833 | instance | Hint: Pre-releases hosted on Galaxy or Automation Hub are not installed by default unless a specific version is requested. To enable pre-releases globally, use --pre. 2026-06-08 07:44:09.951841 | instance | 2026-06-08 07:44:10.495235 | instance | ERROR 2026-06-08 07:44:10.495449 | instance | { 2026-06-08 07:44:10.495479 | instance | "delta": "0:00:06.742583", 2026-06-08 07:44:10.495501 | instance | "end": "2026-06-08 07:44:10.036786", 2026-06-08 07:44:10.495520 | instance | "msg": "non-zero return code", 2026-06-08 07:44:10.495538 | instance | "rc": 1, 2026-06-08 07:44:10.495558 | instance | "start": "2026-06-08 07:44:03.294203" 2026-06-08 07:44:10.495576 | instance | } failure 2026-06-08 07:44:10.497863 | 2026-06-08 07:44:10.497910 | PLAY RECAP 2026-06-08 07:44:10.497956 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-08 07:44:10.497978 | 2026-06-08 07:44:10.665080 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-08 07:44:10.668945 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-06-08 07:44:11.282414 | 2026-06-08 07:44:11.282533 | PLAY [all] 2026-06-08 07:44:11.296275 | 2026-06-08 07:44:11.296352 | TASK [gather-host-logs : creating directory for system status] 2026-06-08 07:44:11.658349 | instance | changed 2026-06-08 07:44:11.664156 | 2026-06-08 07:44:11.664239 | TASK [gather-host-logs : Get logs for each host] 2026-06-08 07:44:12.028340 | instance | + systemd-cgls --full --all --no-pager 2026-06-08 07:44:12.039564 | instance | + ip addr 2026-06-08 07:44:12.042267 | instance | + ip route 2026-06-08 07:44:12.044704 | instance | + lsblk 2026-06-08 07:44:12.047459 | instance | + mount 2026-06-08 07:44:12.049049 | instance | + docker images 2026-06-08 07:44:12.049415 | instance | /bin/bash: line 7: docker: command not found 2026-06-08 07:44:12.049593 | instance | + brctl show 2026-06-08 07:44:12.049945 | instance | /bin/bash: line 8: brctl: command not found 2026-06-08 07:44:12.050159 | instance | + ps aux --sort=-%mem 2026-06-08 07:44:12.063749 | instance | + dpkg -l 2026-06-08 07:44:12.072599 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-06-08 07:44:12.072950 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-06-08 07:44:12.072971 | instance | /bin/bash: line 11: docker: command not found 2026-06-08 07:44:12.073215 | instance | + '[' '!' -z '' ']' 2026-06-08 07:44:12.207026 | instance | ok: Runtime: 0:00:00.049761 2026-06-08 07:44:12.215860 | 2026-06-08 07:44:12.215970 | TASK [gather-host-logs : Downloads logs to executor] 2026-06-08 07:44:12.905431 | instance | changed: 2026-06-08 07:44:12.905664 | instance | created directory /var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/logs/instance 2026-06-08 07:44:12.905707 | instance | cd+++++++++ system/ 2026-06-08 07:44:12.905740 | instance | >f+++++++++ system/brctl-show.txt 2026-06-08 07:44:12.905770 | instance | >f+++++++++ system/docker-images.txt 2026-06-08 07:44:12.905801 | instance | >f+++++++++ system/ip-addr.txt 2026-06-08 07:44:12.905835 | instance | >f+++++++++ system/ip-route.txt 2026-06-08 07:44:12.905868 | instance | >f+++++++++ system/lsblk.txt 2026-06-08 07:44:12.905899 | instance | >f+++++++++ system/mount.txt 2026-06-08 07:44:12.905930 | instance | >f+++++++++ system/packages.txt 2026-06-08 07:44:12.905960 | instance | >f+++++++++ system/ps.txt 2026-06-08 07:44:12.905992 | instance | >f+++++++++ system/systemd-cgls.txt 2026-06-08 07:44:12.931070 | 2026-06-08 07:44:12.931233 | LOOP [helm-release-status : creating directory for helm release status] 2026-06-08 07:44:13.133059 | instance | changed: "values" 2026-06-08 07:44:13.293789 | instance | changed: "releases" 2026-06-08 07:44:13.355132 | 2026-06-08 07:44:13.355316 | TASK [helm-release-status : Gather get release status for helm charts] 2026-06-08 07:44:13.561881 | instance | /bin/bash: line 3: kubectl: command not found 2026-06-08 07:44:13.889558 | instance | ok: Runtime: 0:00:00.007636 2026-06-08 07:44:13.894622 | 2026-06-08 07:44:13.895120 | TASK [helm-release-status : Downloads logs to executor] 2026-06-08 07:44:14.453315 | instance | changed: 2026-06-08 07:44:14.453602 | instance | cd+++++++++ helm/ 2026-06-08 07:44:14.453650 | instance | cd+++++++++ helm/releases/ 2026-06-08 07:44:14.453683 | instance | cd+++++++++ helm/values/ 2026-06-08 07:44:14.466459 | 2026-06-08 07:44:14.466539 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-06-08 07:44:14.663836 | instance | changed 2026-06-08 07:44:14.671264 | 2026-06-08 07:44:14.671357 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-06-08 07:44:14.917706 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-08 07:44:14.917850 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-08 07:44:14.922893 | instance | environment: line 1: kubectl: command not found 2026-06-08 07:44:14.924398 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-08 07:44:14.925565 | instance | environment: line 1: kubectl: command not found 2026-06-08 07:44:14.926346 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-08 07:44:14.927942 | instance | environment: line 1: kubectl: command not found 2026-06-08 07:44:14.928956 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-08 07:44:14.930822 | instance | environment: line 1: kubectl: command not found 2026-06-08 07:44:14.931727 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-08 07:44:14.933413 | instance | environment: line 1: kubectl: command not found 2026-06-08 07:44:14.934255 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-08 07:44:15.242625 | instance | ok: Runtime: 0:00:00.024774 2026-06-08 07:44:15.249773 | 2026-06-08 07:44:15.249864 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-06-08 07:44:15.463047 | instance | changed 2026-06-08 07:44:15.469058 | 2026-06-08 07:44:15.469134 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-06-08 07:44:15.693525 | instance | environment: line 5: kubectl: command not found 2026-06-08 07:44:15.694250 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-08 07:44:15.694364 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-08 07:44:15.694573 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-08 07:44:16.008715 | instance | ok: Runtime: 0:00:00.009329 2026-06-08 07:44:16.016536 | 2026-06-08 07:44:16.016625 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-06-08 07:44:16.527210 | instance | changed: 2026-06-08 07:44:16.582794 | instance | cd+++++++++ objects/ 2026-06-08 07:44:16.582895 | instance | cd+++++++++ objects/cluster/ 2026-06-08 07:44:16.582951 | instance | cd+++++++++ objects/namespaced/ 2026-06-08 07:44:16.598099 | 2026-06-08 07:44:16.598168 | TASK [gather-pod-logs : creating directory for pod logs] 2026-06-08 07:44:16.795248 | instance | changed 2026-06-08 07:44:16.829834 | 2026-06-08 07:44:16.829956 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-06-08 07:44:17.021152 | instance | changed 2026-06-08 07:44:17.026568 | 2026-06-08 07:44:17.026640 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-06-08 07:44:17.243571 | instance | environment: line 3: kubectl: command not found 2026-06-08 07:44:17.567558 | instance | ok: Runtime: 0:00:00.008046 2026-06-08 07:44:17.575045 | 2026-06-08 07:44:17.575163 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-06-08 07:44:18.096891 | instance | changed: 2026-06-08 07:44:18.097133 | instance | cd+++++++++ pod-logs/ 2026-06-08 07:44:18.097175 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-06-08 07:44:18.108178 | 2026-06-08 07:44:18.108299 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-06-08 07:44:18.306906 | instance | changed 2026-06-08 07:44:18.314389 | 2026-06-08 07:44:18.314488 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-06-08 07:44:18.538914 | instance | /bin/bash: line 2: kubectl: command not found 2026-06-08 07:44:18.852261 | instance | ok: Runtime: 0:00:00.037123 2026-06-08 07:44:18.860725 | 2026-06-08 07:44:18.861022 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-06-08 07:44:19.081817 | instance | /bin/bash: line 2: kubectl: command not found 2026-06-08 07:44:19.112371 | instance | ceph-mgr endpoints: 2026-06-08 07:44:19.397586 | instance | ok: Runtime: 0:00:00.038529 2026-06-08 07:44:19.407568 | 2026-06-08 07:44:19.407641 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-06-08 07:44:19.645143 | instance | /bin/bash: line 4: kubectl: command not found 2026-06-08 07:44:19.940895 | instance | ok: Runtime: 0:00:00.035659 2026-06-08 07:44:19.950254 | 2026-06-08 07:44:19.950337 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-06-08 07:44:20.519144 | instance | changed: cd+++++++++ prometheus/ 2026-06-08 07:44:20.554100 | 2026-06-08 07:44:20.554534 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-06-08 07:44:20.766732 | instance | changed 2026-06-08 07:44:20.809799 | 2026-06-08 07:44:20.809890 | TASK [gather-selenium-data : Get selenium data] 2026-06-08 07:44:21.060222 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-06-08 07:44:21.061778 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-06-08 07:44:21.380326 | instance | ERROR 2026-06-08 07:44:21.380608 | instance | { 2026-06-08 07:44:21.380694 | instance | "delta": "0:00:00.007499", 2026-06-08 07:44:21.380735 | instance | "end": "2026-06-08 07:44:21.062206", 2026-06-08 07:44:21.380766 | instance | "msg": "non-zero return code", 2026-06-08 07:44:21.380795 | instance | "rc": 1, 2026-06-08 07:44:21.380825 | instance | "start": "2026-06-08 07:44:21.054707" 2026-06-08 07:44:21.380853 | instance | } 2026-06-08 07:44:21.380918 | instance | ERROR: Ignoring Errors 2026-06-08 07:44:21.391995 | 2026-06-08 07:44:21.392130 | TASK [gather-selenium-data : Downloads logs to executor] 2026-06-08 07:44:21.913149 | instance | changed: cd+++++++++ selenium/ 2026-06-08 07:44:21.933259 | 2026-06-08 07:44:21.933638 | PLAY RECAP 2026-06-08 07:44:21.933716 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-06-08 07:44:21.933750 | 2026-06-08 07:44:22.103871 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-06-08 07:44:22.110747 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 07:44:22.777662 | 2026-06-08 07:44:22.777832 | PLAY [all] 2026-06-08 07:44:22.790377 | 2026-06-08 07:44:22.790485 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-08 07:44:22.836480 | instance | skipping: Conditional result was False 2026-06-08 07:44:22.845747 | 2026-06-08 07:44:22.845880 | TASK [fetch-output : Set log path for single node] 2026-06-08 07:44:22.891952 | instance | ok 2026-06-08 07:44:22.901383 | 2026-06-08 07:44:22.901476 | LOOP [fetch-output : Ensure local output dirs] 2026-06-08 07:44:23.594368 | instance -> localhost | ok: "/var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/logs" 2026-06-08 07:44:23.845134 | instance -> localhost | changed: "/var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/artifacts" 2026-06-08 07:44:24.053410 | instance -> localhost | changed: "/var/lib/zuul/builds/0212c33fef334eac90c32f9681584ee1/work/docs" 2026-06-08 07:44:24.070653 | 2026-06-08 07:44:24.070867 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-08 07:44:24.692235 | instance | changed: .d..t...... ./ 2026-06-08 07:44:24.692469 | instance | changed: All items complete 2026-06-08 07:44:24.692496 | 2026-06-08 07:44:25.163649 | instance | changed: .d..t...... ./ 2026-06-08 07:44:25.649950 | instance | changed: .d..t...... ./ 2026-06-08 07:44:25.689278 | 2026-06-08 07:44:25.689495 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-08 07:44:26.140458 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007933 2026-06-08 07:44:26.399035 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008443 2026-06-08 07:44:26.424538 | 2026-06-08 07:44:26.424673 | PLAY [all] 2026-06-08 07:44:26.432048 | 2026-06-08 07:44:26.432119 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-08 07:44:26.862512 | instance | changed 2026-06-08 07:44:26.879307 | 2026-06-08 07:44:26.879521 | PLAY RECAP 2026-06-08 07:44:26.879624 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-08 07:44:26.879676 | 2026-06-08 07:44:27.020496 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-08 07:44:27.025999 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-08 07:44:27.693378 | 2026-06-08 07:44:27.693542 | PLAY [localhost] 2026-06-08 07:44:27.704908 | 2026-06-08 07:44:27.705275 | TASK [Generate Zuul manifest] 2026-06-08 07:44:27.737503 | localhost | ok 2026-06-08 07:44:27.755024 | 2026-06-08 07:44:27.755180 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-08 07:44:28.153419 | localhost | changed 2026-06-08 07:44:28.166624 | 2026-06-08 07:44:28.166739 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-08 07:44:28.210443 | localhost | ok 2026-06-08 07:44:28.219978 | 2026-06-08 07:44:28.220058 | TASK [Upload logs] 2026-06-08 07:44:28.240838 | localhost | ok 2026-06-08 07:44:28.304317 | 2026-06-08 07:44:28.304474 | TASK [Set zuul-log-path fact] 2026-06-08 07:44:28.328506 | localhost | ok 2026-06-08 07:44:28.343705 | 2026-06-08 07:44:28.343772 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-08 07:44:28.377910 | localhost | ok 2026-06-08 07:44:28.388238 | 2026-06-08 07:44:28.388431 | TASK [upload-logs : Create log directories] 2026-06-08 07:44:28.859968 | localhost | changed 2026-06-08 07:44:28.901112 | 2026-06-08 07:44:28.901233 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-08 07:44:29.328476 | localhost -> localhost | ok: Runtime: 0:00:00.006442 2026-06-08 07:44:29.336303 | 2026-06-08 07:44:29.336469 | TASK [upload-logs : Upload logs to log server] 2026-06-08 07:44:29.801985 | localhost | Output suppressed because no_log was given 2026-06-08 07:44:29.807054 | 2026-06-08 07:44:29.807143 | LOOP [upload-logs : Compress console log and json output] 2026-06-08 07:44:29.853206 | localhost | skipping: Conditional result was False 2026-06-08 07:44:29.862052 | localhost | skipping: Conditional result was False 2026-06-08 07:44:29.874547 | 2026-06-08 07:44:29.874707 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-08 07:44:29.920603 | localhost | skipping: Conditional result was False 2026-06-08 07:44:29.921379 | 2026-06-08 07:44:29.924236 | localhost | skipping: Conditional result was False 2026-06-08 07:44:29.941325 | 2026-06-08 07:44:29.941506 | LOOP [upload-logs : Upload console log and json output]