2026-07-26 15:42:20.471836 | Job console starting
2026-07-26 15:42:20.489065 | Updating git repos
2026-07-26 15:42:22.224232 | Cloning repos into workspace
2026-07-26 15:42:34.304699 | Restoring repo states
2026-07-26 15:42:45.346215 | Merging changes
2026-07-26 15:42:47.017066 | Checking out repos
2026-07-26 15:42:48.371151 | Preparing playbooks
2026-07-26 15:42:50.537105 | Running Ansible setup
2026-07-26 15:42:53.961297 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 15:42:54.606325 | 
2026-07-26 15:42:54.606472 | PLAY [localhost]
2026-07-26 15:42:54.613815 | 
2026-07-26 15:42:54.613886 | TASK [Gathering Facts]
2026-07-26 15:42:55.517207 | localhost | ok
2026-07-26 15:42:55.528343 | 
2026-07-26 15:42:55.528455 | TASK [Setup log path fact]
2026-07-26 15:42:55.550238 | localhost | ok
2026-07-26 15:42:55.568410 | 
2026-07-26 15:42:55.568522 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 15:42:55.599887 | localhost | ok
2026-07-26 15:42:55.608109 | 
2026-07-26 15:42:55.608199 | TASK [emit-job-header : Print job information]
2026-07-26 15:42:55.649637 | # Job Information
2026-07-26 15:42:55.649790 | Ansible Version: 2.16.18
2026-07-26 15:42:55.649834 | Job: atmosphere-molecule-keycloak-selective
2026-07-26 15:42:55.649864 | Pipeline: check
2026-07-26 15:42:55.649891 | Executor: 2d72f0692154
2026-07-26 15:42:55.649918 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4163
2026-07-26 15:42:55.649949 | Event ID: 0d497e60-8908-11f1-8bf4-7b5c6963f0a7
2026-07-26 15:42:55.653654 | 
2026-07-26 15:42:55.653741 | LOOP [emit-job-header : Print node information]
2026-07-26 15:42:55.748721 | localhost | ok:
2026-07-26 15:42:55.748975 | localhost | # Node Information
2026-07-26 15:42:55.749707 | localhost | Inventory Hostname: instance
2026-07-26 15:42:55.749754 | localhost | Hostname: np0000186975
2026-07-26 15:42:55.749784 | localhost | Username: zuul
2026-07-26 15:42:55.749815 | localhost | Distro: Ubuntu 22.04
2026-07-26 15:42:55.749843 | localhost | Provider: yul1
2026-07-26 15:42:55.749869 | localhost | Region: ca-ymq-1
2026-07-26 15:42:55.749895 | localhost | Label: ubuntu-jammy
2026-07-26 15:42:55.749921 | localhost | Product Name: OpenStack Nova
2026-07-26 15:42:55.749947 | localhost | Interface IP: 199.204.45.70
2026-07-26 15:42:55.760906 | 
2026-07-26 15:42:55.761091 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-26 15:42:56.141965 | localhost -> localhost | changed
2026-07-26 15:42:56.149416 | 
2026-07-26 15:42:56.149556 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-26 15:42:56.953611 | localhost -> localhost | changed
2026-07-26 15:42:56.964936 | 
2026-07-26 15:42:56.965012 | PLAY [all]
2026-07-26 15:42:56.972935 | 
2026-07-26 15:42:56.973029 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-26 15:42:57.200271 | instance -> localhost | ok
2026-07-26 15:42:57.206670 | 
2026-07-26 15:42:57.206734 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-26 15:42:57.241359 | instance | ok
2026-07-26 15:42:57.258987 | instance | included: /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-26 15:42:57.264428 | 
2026-07-26 15:42:57.264487 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-26 15:42:58.639091 | instance -> localhost | Generating public/private rsa key pair.
2026-07-26 15:42:58.639301 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/f1184bd5873349b98b74ba86009baf14_id_rsa
2026-07-26 15:42:58.639345 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/f1184bd5873349b98b74ba86009baf14_id_rsa.pub
2026-07-26 15:42:58.639379 | instance -> localhost | The key fingerprint is:
2026-07-26 15:42:58.639411 | instance -> localhost | SHA256:6ITHh1C9s3NzVTgrBVGGBOOXIVH0gMU2QOS4Z3ncMz0 zuul-build-sshkey
2026-07-26 15:42:58.639460 | instance -> localhost | The key's randomart image is:
2026-07-26 15:42:58.639492 | instance -> localhost | +---[RSA 3072]----+
2026-07-26 15:42:58.639531 | instance -> localhost | |      .. oO@X=o. |
2026-07-26 15:42:58.639564 | instance -> localhost | |     .  .+.o=*+ .|
2026-07-26 15:42:58.639596 | instance -> localhost | |    .   ..o.oo.+ |
2026-07-26 15:42:58.639626 | instance -> localhost | |     + oo. +..o. |
2026-07-26 15:42:58.639657 | instance -> localhost | |    . * So+ oo+E.|
2026-07-26 15:42:58.639687 | instance -> localhost | |     + .ooo..  o.|
2026-07-26 15:42:58.639717 | instance -> localhost | |      .  o o     |
2026-07-26 15:42:58.639746 | instance -> localhost | |                 |
2026-07-26 15:42:58.639780 | instance -> localhost | |                 |
2026-07-26 15:42:58.639810 | instance -> localhost | +----[SHA256]-----+
2026-07-26 15:42:58.639879 | instance -> localhost | ok: Runtime: 0:00:00.995933
2026-07-26 15:42:58.647459 | 
2026-07-26 15:42:58.647574 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-26 15:42:58.680363 | instance | ok
2026-07-26 15:42:58.691913 | instance | included: /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-26 15:42:58.699586 | 
2026-07-26 15:42:58.699644 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-26 15:42:58.723482 | instance | skipping: Conditional result was False
2026-07-26 15:42:58.730464 | 
2026-07-26 15:42:58.730549 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-26 15:42:59.138153 | instance | changed
2026-07-26 15:42:59.143838 | 
2026-07-26 15:42:59.143931 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-26 15:42:59.318847 | instance | ok
2026-07-26 15:42:59.327416 | 
2026-07-26 15:42:59.327529 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-26 15:42:59.775556 | instance | changed
2026-07-26 15:42:59.782141 | 
2026-07-26 15:42:59.782232 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-26 15:43:00.230841 | instance | changed
2026-07-26 15:43:00.236866 | 
2026-07-26 15:43:00.236939 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-26 15:43:00.261100 | instance | skipping: Conditional result was False
2026-07-26 15:43:00.271457 | 
2026-07-26 15:43:00.271565 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-26 15:43:00.619638 | instance -> localhost | changed
2026-07-26 15:43:00.636640 | 
2026-07-26 15:43:00.636777 | TASK [add-build-sshkey : Add back temp key]
2026-07-26 15:43:00.913011 | instance -> localhost | Identity added: /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/f1184bd5873349b98b74ba86009baf14_id_rsa (zuul-build-sshkey)
2026-07-26 15:43:00.913267 | instance -> localhost | ok: Runtime: 0:00:00.011803
2026-07-26 15:43:00.920290 | 
2026-07-26 15:43:00.920378 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-26 15:43:01.235163 | instance | ok
2026-07-26 15:43:01.241624 | 
2026-07-26 15:43:01.241709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-26 15:43:01.266638 | instance | skipping: Conditional result was False
2026-07-26 15:43:01.319434 | 
2026-07-26 15:43:01.319585 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-26 15:43:01.616466 | instance | ok
2026-07-26 15:43:01.624784 | 
2026-07-26 15:43:01.624879 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-26 15:43:05.048172 | instance | Output suppressed because no_log was given
2026-07-26 15:43:05.057761 | 
2026-07-26 15:43:05.057865 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-26 15:43:05.256593 | instance | ok: "logs"
2026-07-26 15:43:05.256823 | instance | ok: All items complete
2026-07-26 15:43:05.256852 | 
2026-07-26 15:43:05.405909 | instance | ok: "artifacts"
2026-07-26 15:43:05.567444 | instance | ok: "docs"
2026-07-26 15:43:05.586347 | 
2026-07-26 15:43:05.586557 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-26 15:43:05.785099 | instance | changed: "logs"
2026-07-26 15:43:05.933253 | instance | changed: "artifacts"
2026-07-26 15:43:06.089433 | instance | changed: "docs"
2026-07-26 15:43:06.109632 | 
2026-07-26 15:43:06.109807 | PLAY RECAP
2026-07-26 15:43:06.109877 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-26 15:43:06.109918 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 15:43:06.109949 | 
2026-07-26 15:43:06.318962 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 15:43:06.325340 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 15:43:07.049986 | 
2026-07-26 15:43:07.050118 | PLAY [all]
2026-07-26 15:43:07.062089 | 
2026-07-26 15:43:07.062186 | TASK [setup-uv : Extract archive]
2026-07-26 15:43:09.252541 | instance | changed
2026-07-26 15:43:09.258793 | 
2026-07-26 15:43:09.258878 | TASK [setup-uv : Print version]
2026-07-26 15:43:09.612942 | instance | uv 0.8.13
2026-07-26 15:43:09.799578 | instance | ok: Runtime: 0:00:00.013829
2026-07-26 15:43:09.813304 | 
2026-07-26 15:43:09.813388 | TASK [Install Ansible collection siblings]
2026-07-26 15:43:18.839191 | instance | changed:
2026-07-26 15:43:18.839421 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-07-26 15:43:18.839461 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-07-26 15:43:18.839491 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-07-26 15:43:18.839518 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-07-26 15:43:18.839545 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-07-26 15:43:18.839578 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-07-26 15:43:18.839607 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-07-26 15:43:18.839636 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-07-26 15:43:18.839663 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-07-26 15:43:18.839690 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-07-26 15:43:18.839717 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-07-26 15:43:18.839742 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-07-26 15:43:18.839768 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-07-26 15:43:18.839793 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-07-26 15:43:18.839818 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0
2026-07-26 15:43:18.839844 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-07-26 15:43:18.839869 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-07-26 15:43:18.839895 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-07-26 15:43:18.839935 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-07-26 15:43:18.839963 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-07-26 15:43:18.839988 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0
2026-07-26 15:43:18.840014 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-07-26 15:43:18.840042 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-26 15:43:18.840082 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-07-26 15:43:18.840110 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0
2026-07-26 15:43:18.840135 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-26 15:43:18.840159 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-26 15:43:18.840183 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-07-26 15:43:18.840208 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-07-26 15:43:18.840232 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-07-26 15:43:18.840257 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-07-26 15:43:18.840283 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-07-26 15:43:18.840308 | instance | Checked out ansible.netcommon to 1.2.0
2026-07-26 15:43:18.840333 | 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 15:43:18.840366 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.840391 | instance | Process install dependency map
2026-07-26 15:43:18.840417 | instance | Starting collection install process
2026-07-26 15:43:18.840442 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-07-26 15:43:18.840467 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-07-26 15:43:18.840492 | instance | ansible.netcommon:* was installed successfully
2026-07-26 15:43:18.840518 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-07-26 15:43:18.840543 | instance | Creating virtual environment at: .venv
2026-07-26 15:43:18.840568 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-26 15:43:18.840593 | instance | Downloading pygments (1.2MiB)
2026-07-26 15:43:18.840618 | instance | Downloading rjsonnet (1.2MiB)
2026-07-26 15:43:18.840648 | instance | Downloading cryptography (4.2MiB)
2026-07-26 15:43:18.840673 | instance | Downloading netaddr (2.2MiB)
2026-07-26 15:43:18.840698 | instance | Downloading openstacksdk (1.7MiB)
2026-07-26 15:43:18.840727 | instance | Downloading setuptools (1.1MiB)
2026-07-26 15:43:18.840754 | instance | Downloading pydantic-core (2.0MiB)
2026-07-26 15:43:18.840779 | instance | Downloading ansible-core (2.1MiB)
2026-07-26 15:43:18.840805 | instance | Downloading kubernetes (1.9MiB)
2026-07-26 15:43:18.840831 | instance |    Building pyperclip==1.9.0
2026-07-26 15:43:18.840858 | instance |  Downloading rjsonnet
2026-07-26 15:43:18.840884 | instance |  Downloading pydantic-core
2026-07-26 15:43:18.840909 | instance |  Downloading netaddr
2026-07-26 15:43:18.840949 | instance |  Downloading pygments
2026-07-26 15:43:18.840992 | instance |  Downloading cryptography
2026-07-26 15:43:18.841018 | instance |  Downloading setuptools
2026-07-26 15:43:18.841043 | instance |  Downloading kubernetes
2026-07-26 15:43:18.841069 | instance |  Downloading ansible-core
2026-07-26 15:43:18.841094 | instance |  Downloading openstacksdk
2026-07-26 15:43:18.841119 | instance |       Built pyperclip==1.9.0
2026-07-26 15:43:18.841145 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-07-26 15:43:18.841170 | instance | Installed 83 packages in 45ms
2026-07-26 15:43:18.841196 | instance | Checked out ansible.posix to 1.6.0
2026-07-26 15:43:18.841221 | 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 15:43:18.841247 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.841272 | instance | Process install dependency map
2026-07-26 15:43:18.841304 | instance | Starting collection install process
2026-07-26 15:43:18.841330 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-26 15:43:18.841355 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-07-26 15:43:18.841380 | instance | ansible.posix:1.6.0 was installed successfully
2026-07-26 15:43:18.841405 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.841431 | instance | 2.17.12
2026-07-26 15:43:18.841456 | instance | Checked out ansible.utils to v6.0.3
2026-07-26 15:43:18.841481 | 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 15:43:18.841506 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.841531 | instance | Process install dependency map
2026-07-26 15:43:18.841556 | instance | Starting collection install process
2026-07-26 15:43:18.841581 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-07-26 15:43:18.841607 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-07-26 15:43:18.841633 | instance | ansible.utils:6.0.3 was installed successfully
2026-07-26 15:43:18.841658 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.841683 | instance | 2.17.12
2026-07-26 15:43:18.841708 | instance | Checked out atmosphere.common to v0.7.0
2026-07-26 15:43:18.841733 | 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 15:43:18.841758 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.841783 | instance | Process install dependency map
2026-07-26 15:43:18.841808 | instance | Starting collection install process
2026-07-26 15:43:18.841832 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-07-26 15:43:18.841857 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-07-26 15:43:18.841882 | instance | atmosphere.common:0.7.0 was installed successfully
2026-07-26 15:43:18.841907 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.841932 | instance | 2.17.12
2026-07-26 15:43:18.841956 | instance | Checked out community.crypto to 2.2.3
2026-07-26 15:43:18.841981 | 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 15:43:18.842006 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.842031 | instance | Process install dependency map
2026-07-26 15:43:18.842056 | instance | Starting collection install process
2026-07-26 15:43:18.842080 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-07-26 15:43:18.842106 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-07-26 15:43:18.842131 | instance | community.crypto:2.2.3 was installed successfully
2026-07-26 15:43:18.842155 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.842180 | instance | 2.17.12
2026-07-26 15:43:18.842205 | instance | Checked out community.general to 7.3.0
2026-07-26 15:43:18.842230 | 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 15:43:18.842262 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.842289 | instance | Process install dependency map
2026-07-26 15:43:18.842315 | instance | Starting collection install process
2026-07-26 15:43:18.842340 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-26 15:43:18.842364 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-07-26 15:43:18.842389 | instance | community.general:7.3.0 was installed successfully
2026-07-26 15:43:18.842414 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.842439 | instance | 2.17.12
2026-07-26 15:43:18.842464 | instance | Checked out community.mysql to 3.6.0
2026-07-26 15:43:18.842491 | 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 15:43:18.842518 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.842544 | instance | Process install dependency map
2026-07-26 15:43:18.842569 | instance | Starting collection install process
2026-07-26 15:43:18.842594 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-07-26 15:43:18.842619 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-07-26 15:43:18.842644 | instance | community.mysql:3.6.0 was installed successfully
2026-07-26 15:43:18.842669 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.842694 | instance | 2.17.12
2026-07-26 15:43:18.842719 | instance | Checked out kubernetes.core to 2.4.0
2026-07-26 15:43:18.842744 | 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 15:43:18.842769 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.842794 | instance | Process install dependency map
2026-07-26 15:43:18.842820 | instance | Starting collection install process
2026-07-26 15:43:18.842845 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-07-26 15:43:18.842870 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-07-26 15:43:18.842895 | instance | kubernetes.core:2.4.0 was installed successfully
2026-07-26 15:43:18.842920 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.842945 | instance | 2.17.12
2026-07-26 15:43:18.842970 | instance | Checked out openstack.cloud to 2.6.0
2026-07-26 15:43:18.842994 | 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 15:43:18.843019 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.843044 | instance | Process install dependency map
2026-07-26 15:43:18.843069 | instance | Starting collection install process
2026-07-26 15:43:18.843093 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-07-26 15:43:18.843118 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-07-26 15:43:18.843142 | instance | openstack.cloud:2.6.0 was installed successfully
2026-07-26 15:43:18.843167 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.843192 | instance | 2.17.12
2026-07-26 15:43:18.843225 | instance | Checked out vexxhost.ceph to v4.1.0
2026-07-26 15:43:18.843251 | 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 15:43:18.843276 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.843301 | instance | Process install dependency map
2026-07-26 15:43:18.843325 | instance | Starting collection install process
2026-07-26 15:43:18.843350 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-07-26 15:43:18.843375 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-07-26 15:43:18.843400 | instance | vexxhost.ceph:4.1.0 was installed successfully
2026-07-26 15:43:18.843425 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.843449 | instance | 2.17.12
2026-07-26 15:43:18.843474 | instance | Checked out vexxhost.containers to v1.6.8
2026-07-26 15:43:18.843499 | 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 15:43:18.843523 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.843548 | instance | Process install dependency map
2026-07-26 15:43:18.843573 | instance | Starting collection install process
2026-07-26 15:43:18.843597 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-07-26 15:43:18.843622 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-07-26 15:43:18.843647 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-07-26 15:43:18.843672 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.843699 | instance | 2.17.12
2026-07-26 15:43:18.843726 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-07-26 15:43:18.843751 | 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 15:43:18.843776 | instance | Starting galaxy collection install process
2026-07-26 15:43:18.843801 | instance | Process install dependency map
2026-07-26 15:43:18.843826 | instance | Starting collection install process
2026-07-26 15:43:18.843851 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-07-26 15:43:18.843889 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-07-26 15:43:18.843916 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-07-26 15:43:18.843941 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-07-26 15:43:18.843966 | instance | 2.17.12
2026-07-26 15:43:18.851199 | 
2026-07-26 15:43:18.851247 | PLAY RECAP
2026-07-26 15:43:18.851291 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 15:43:18.851312 | 
2026-07-26 15:43:18.987074 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 15:43:18.992478 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-26 15:43:19.614271 | 
2026-07-26 15:43:19.614388 | PLAY [all]
2026-07-26 15:43:19.625843 | 
2026-07-26 15:43:19.626147 | TASK [Install "jq" for log collection]
2026-07-26 15:43:30.196300 | instance | changed
2026-07-26 15:43:30.198813 | 
2026-07-26 15:43:30.198892 | PLAY RECAP
2026-07-26 15:43:30.198974 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 15:43:30.199055 | 
2026-07-26 15:43:30.323281 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-07-26 15:43:30.387186 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-26 15:43:31.194653 | 
2026-07-26 15:43:31.194783 | PLAY [Prepare Molecule dependencies]
2026-07-26 15:43:31.205011 | 
2026-07-26 15:43:31.205083 | TASK [Install jq for log collection]
2026-07-26 15:43:33.786145 | instance | ok
2026-07-26 15:43:33.789448 | 
2026-07-26 15:43:33.789533 | PLAY [Install Go for the Atmosphere deployment binary]
2026-07-26 15:43:33.797547 | 
2026-07-26 15:43:33.797637 | TASK [ensure-go : Check installed go version]
2026-07-26 15:43:34.335919 | instance | ok: ERROR (ignored)
2026-07-26 15:43:34.336258 | instance | {
2026-07-26 15:43:34.336302 | instance |   "failed_when_result": false,
2026-07-26 15:43:34.336335 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-07-26 15:43:34.336363 | instance |   "rc": 2
2026-07-26 15:43:34.336389 | instance | }
2026-07-26 15:43:34.343250 | 
2026-07-26 15:43:34.343372 | TASK [ensure-go : Skip if correct version of go is installed]
2026-07-26 15:43:34.400481 | instance | ok
2026-07-26 15:43:34.411078 | instance | included: /var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-07-26 15:43:34.415916 | 
2026-07-26 15:43:34.415989 | TASK [ensure-go : Create temp directory]
2026-07-26 15:43:34.717049 | instance | changed
2026-07-26 15:43:34.725462 | 
2026-07-26 15:43:34.725539 | TASK [ensure-go : Get archive checksum]
2026-07-26 15:43:35.338194 | instance | ok: OK (64 bytes)
2026-07-26 15:43:35.346557 | 
2026-07-26 15:43:35.346656 | TASK [ensure-go : Download go archive]
2026-07-26 15:43:36.613289 | instance | changed: OK (78559214 bytes)
2026-07-26 15:43:36.621941 | 
2026-07-26 15:43:36.622016 | TASK [ensure-go : Install go]
2026-07-26 15:43:42.483937 | instance | changed
2026-07-26 15:43:42.493874 | 
2026-07-26 15:43:42.494477 | PLAY [Prepare selective Molecule execution plan]
2026-07-26 15:43:42.501834 | 
2026-07-26 15:43:42.501953 | TASK [Build atmosphere binary]
2026-07-26 15:43:42.728063 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-07-26 15:43:42.733908 | instance | go: downloading golang.org/x/sync v0.18.0
2026-07-26 15:43:42.738433 | instance | go: downloading github.com/goccy/go-yaml v1.18.0
2026-07-26 15:43:43.022041 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-07-26 15:43:50.554915 | instance | ok: Runtime: 0:00:07.371760
2026-07-26 15:43:50.559798 | 
2026-07-26 15:43:50.559880 | TASK [Generate selective CI plan]
2026-07-26 15:43:51.146355 | instance | ok: Runtime: 0:00:00.031336
2026-07-26 15:43:51.152154 | 
2026-07-26 15:43:51.152228 | TASK [Explain selective CI plan]
2026-07-26 15:43:51.384169 | instance | CI plan mode: selective
2026-07-26 15:43:51.384356 | instance | Changed files:
2026-07-26 15:43:51.384372 | instance |   A	roles/heat/.ci-selective-test
2026-07-26 15:43:51.384383 | instance | Matches:
2026-07-26 15:43:51.384395 | instance |   roles/heat/.ci-selective-test: component:heat (targets) -> heat
2026-07-26 15:43:51.384406 | instance | Direct targets: heat
2026-07-26 15:43:51.384420 | instance | Deployment roots: glance-images, heat, neutron
2026-07-26 15:43:51.384435 | instance | Verification profiles: orchestration
2026-07-26 15:43:51.384449 | instance | Variant openvswitch (22 components): ceph, ceph-provisioners, cert-manager, cluster-issuer, coredns, csi, glance, glance-images, heat, ingress-nginx, keycloak, keystone, kubernetes, libvirt, memcached, neutron, nova, openvswitch, percona-xtradb-cluster, percona-xtradb-cluster-operator, placement, rabbitmq-cluster-operator
2026-07-26 15:43:51.384460 | instance | Molecule jobs:
2026-07-26 15:43:51.384470 | instance |   aio-openvswitch: run (22 components) - executes the openvswitch deployment variant
2026-07-26 15:43:51.384480 | instance |   aio-ovn: skip - plan has no ovn deployment variant
2026-07-26 15:43:51.384489 | instance |   csi-local-path-provisioner: skip - none of the job's verification profiles were requested
2026-07-26 15:43:51.384498 | instance |   csi-rbd: skip - none of the job's verification profiles were requested
2026-07-26 15:43:51.384513 | instance |   keycloak: skip - none of the job's verification profiles were requested
2026-07-26 15:43:51.690023 | instance | ok: Runtime: 0:00:00.030005
2026-07-26 15:43:51.698151 | 
2026-07-26 15:43:51.698255 | TASK [Print selective CI plan]
2026-07-26 15:43:51.734228 | instance | ok
2026-07-26 15:43:51.748786 | 
2026-07-26 15:43:51.812075 | TASK [Report conservative fallback]
2026-07-26 15:43:51.838648 | instance | skipping: Conditional result was False
2026-07-26 15:43:51.848046 | 
2026-07-26 15:43:51.848105 | TASK [Create selective CI plan log directory]
2026-07-26 15:43:52.125554 | instance | changed
2026-07-26 15:43:52.143478 | 
2026-07-26 15:43:52.143575 | TASK [Publish selective CI plan with job logs]
2026-07-26 15:43:52.498947 | instance | changed
2026-07-26 15:43:52.500550 | 
2026-07-26 15:43:52.500599 | PLAY RECAP
2026-07-26 15:43:52.500645 | instance | ok: 13 changed: 5 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-26 15:43:52.500667 | 
2026-07-26 15:43:52.614738 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main]
2026-07-26 15:43:52.621145 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-26 15:43:53.232563 | 
2026-07-26 15:43:53.232715 | PLAY [Run selected Molecule deployment and verification]
2026-07-26 15:43:53.244523 | 
2026-07-26 15:43:53.244603 | TASK [Check for selective CI plan]
2026-07-26 15:43:53.594298 | instance | ok
2026-07-26 15:43:53.601757 | 
2026-07-26 15:43:53.601841 | TASK [Validate selective CI plan]
2026-07-26 15:43:54.139821 | instance | ok: Runtime: 0:00:00.033248
2026-07-26 15:43:54.146564 | 
2026-07-26 15:43:54.146650 | TASK [Resolve selective CI plan availability]
2026-07-26 15:43:54.202422 | instance | ok
2026-07-26 15:43:54.207030 | 
2026-07-26 15:43:54.207101 | TASK [Read selective CI plan]
2026-07-26 15:43:54.534155 | instance | ok
2026-07-26 15:43:54.542241 | 
2026-07-26 15:43:54.542336 | TASK [Load selective CI plan or full fallback]
2026-07-26 15:43:54.598932 | instance | ok
2026-07-26 15:43:54.607811 | 
2026-07-26 15:43:54.607878 | TASK [Find this job in the selective CI plan]
2026-07-26 15:43:54.663537 | instance | ok
2026-07-26 15:43:54.668793 | 
2026-07-26 15:43:54.668864 | TASK [Resolve this job or use full fallback]
2026-07-26 15:43:54.725553 | instance | ok
2026-07-26 15:43:54.733894 | 
2026-07-26 15:43:54.733990 | TASK [Resolve deployment and verification inputs]
2026-07-26 15:43:54.789565 | instance | ok
2026-07-26 15:43:54.796443 | 
2026-07-26 15:43:54.796627 | TASK [Resolve deployment tags]
2026-07-26 15:43:54.849677 | instance | ok
2026-07-26 15:43:54.855348 | 
2026-07-26 15:43:54.855433 | TASK [Report Molecule job decision]
2026-07-26 15:43:54.904869 | instance | ok: {'job': 'keycloak', 'mode': 'selective', 'run': False, 'reason': "none of the job's verification profiles were requested", 'network_backend': 'openvswitch', 'csi_driver': 'rbd', 'components': [], 'verification_profiles': ['orchestration'], 'extra_vars': {}}
2026-07-26 15:43:54.912937 | 
2026-07-26 15:43:54.913052 | TASK [Copy inventory file for Zuul]
2026-07-26 15:43:54.939800 | instance | skipping: Conditional result was False
2026-07-26 15:43:54.950149 | 
2026-07-26 15:43:54.950216 | TASK [Switch ansible_host to private IP]
2026-07-26 15:43:54.972926 | instance | skipping: Conditional result was False
2026-07-26 15:43:54.981467 | 
2026-07-26 15:43:54.981554 | TASK [Prepare Molecule scenario]
2026-07-26 15:43:55.548123 | instance | skipping: Conditional result was False
2026-07-26 15:43:55.558134 | 
2026-07-26 15:43:55.558239 | TASK [Prepare host for Ceph-backed storage]
2026-07-26 15:43:56.087949 | instance | skipping: Conditional result was False
2026-07-26 15:43:56.097956 | 
2026-07-26 15:43:56.098021 | TASK [Build deployment command]
2026-07-26 15:43:56.123913 | instance | skipping: Conditional result was False
2026-07-26 15:43:56.134127 | 
2026-07-26 15:43:56.134222 | TASK [Run initial deployment with progress heartbeat]
2026-07-26 15:43:56.160162 | instance | skipping: Conditional result was False
2026-07-26 15:43:56.170081 | 
2026-07-26 15:43:56.170161 | TASK [Run idempotence deployment with progress heartbeat]
2026-07-26 15:43:56.196039 | instance | skipping: Conditional result was False
2026-07-26 15:43:56.205637 | 
2026-07-26 15:43:56.205725 | TASK [Check for br-ex interface]
2026-07-26 15:43:56.736719 | instance | skipping: Conditional result was False
2026-07-26 15:43:56.746486 | 
2026-07-26 15:43:56.746582 | TASK [Add IP address to br-ex]
2026-07-26 15:43:57.279736 | instance | skipping: Conditional result was False
2026-07-26 15:43:57.289811 | 
2026-07-26 15:43:57.289885 | TASK [Set br-ex interface up]
2026-07-26 15:43:57.817378 | instance | skipping: Conditional result was False
2026-07-26 15:43:57.828887 | 
2026-07-26 15:43:57.828978 | TASK [Resolve Molecule verification command]
2026-07-26 15:43:57.855426 | instance | skipping: Conditional result was False
2026-07-26 15:43:57.866293 | 
2026-07-26 15:43:57.866383 | TASK [Run Molecule verification with progress heartbeat]
2026-07-26 15:43:57.892935 | instance | skipping: Conditional result was False
2026-07-26 15:43:57.895061 | 
2026-07-26 15:43:57.895166 | PLAY RECAP
2026-07-26 15:43:57.895268 | instance | ok: 10 changed: 0 unreachable: 0 failed: 0 skipped: 12 rescued: 0 ignored: 0
2026-07-26 15:43:57.895315 | 
2026-07-26 15:43:58.065950 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main]
2026-07-26 15:43:58.070445 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-26 15:43:58.689741 | 
2026-07-26 15:43:58.689864 | PLAY [all]
2026-07-26 15:43:58.703880 | 
2026-07-26 15:43:58.703973 | TASK [gather-host-logs : creating directory for system status]
2026-07-26 15:43:59.051285 | instance | ok
2026-07-26 15:43:59.060375 | 
2026-07-26 15:43:59.060469 | TASK [gather-host-logs : Get logs for each host]
2026-07-26 15:43:59.407439 | instance | + systemd-cgls --full --all --no-pager
2026-07-26 15:43:59.419198 | instance | + ip addr
2026-07-26 15:43:59.421940 | instance | + ip route
2026-07-26 15:43:59.423576 | instance | + lsblk
2026-07-26 15:43:59.426274 | instance | + mount
2026-07-26 15:43:59.428845 | instance | + docker images
2026-07-26 15:43:59.429276 | instance | /bin/bash: line 7: docker: command not found
2026-07-26 15:43:59.429441 | instance | + brctl show
2026-07-26 15:43:59.430110 | instance | /bin/bash: line 8: brctl: command not found
2026-07-26 15:43:59.430422 | instance | + ps aux --sort=-%mem
2026-07-26 15:43:59.442420 | instance | + dpkg -l
2026-07-26 15:43:59.453347 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-07-26 15:43:59.453609 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-07-26 15:43:59.453666 | instance | /bin/bash: line 11: docker: command not found
2026-07-26 15:43:59.453830 | instance | + '[' '!' -z '' ']'
2026-07-26 15:43:59.603336 | instance | ok: Runtime: 0:00:00.050159
2026-07-26 15:43:59.609809 | 
2026-07-26 15:43:59.609883 | TASK [gather-host-logs : Downloads logs to executor]
2026-07-26 15:44:00.250623 | instance | ERROR
2026-07-26 15:44:00.250840 | instance | {
2026-07-26 15:44:00.250872 | instance |   "msg": "Warning: Permanently added '199.204.45.70' (ED25519) to the list of known hosts.\r\nrsync: [generator] chown \"/var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/logs/instance/system\" failed: Invalid argument (22)\nrsync: [receiver] chown \"/var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/logs/instance/system/.ci-plan.json.iLEqlv\" 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 15:44:00.250908 | instance |   "rc": 23
2026-07-26 15:44:00.250930 | instance | }
2026-07-26 15:44:00.250958 | instance | ERROR: Ignoring Errors
2026-07-26 15:44:00.259983 | 
2026-07-26 15:44:00.260052 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-26 15:44:00.464665 | instance | changed: "values"
2026-07-26 15:44:00.620266 | instance | changed: "releases"
2026-07-26 15:44:00.639696 | 
2026-07-26 15:44:00.639888 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-26 15:44:00.853533 | instance | /bin/bash: line 3: kubectl: command not found
2026-07-26 15:44:01.177622 | instance | ok: Runtime: 0:00:00.006852
2026-07-26 15:44:01.185021 | 
2026-07-26 15:44:01.185122 | TASK [helm-release-status : Downloads logs to executor]
2026-07-26 15:44:01.677664 | instance | changed:
2026-07-26 15:44:01.677873 | instance | cd+++++++++ helm/
2026-07-26 15:44:01.677903 | instance | cd+++++++++ helm/releases/
2026-07-26 15:44:01.677926 | instance | cd+++++++++ helm/values/
2026-07-26 15:44:01.687784 | 
2026-07-26 15:44:01.687858 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-26 15:44:01.886964 | instance | changed
2026-07-26 15:44:01.893079 | 
2026-07-26 15:44:01.893166 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-26 15:44:02.169839 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 15:44:02.170055 | instance |
2026-07-26 15:44:02.174025 | instance | environment: line 1: kubectl: command not found
2026-07-26 15:44:02.175551 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 15:44:02.177738 | instance | environment: line 1: kubectl: command not found
2026-07-26 15:44:02.178684 | instance | environment: line 1: kubectl: command not found
2026-07-26 15:44:02.179383 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 15:44:02.180267 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 15:44:02.182366 | instance | environment: line 1: kubectl: command not found
2026-07-26 15:44:02.182846 | instance | environment: line 1: kubectl: command not found
2026-07-26 15:44:02.183087 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 15:44:02.183852 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-26 15:44:02.481095 | instance | ok: Runtime: 0:00:00.024945
2026-07-26 15:44:02.486207 | 
2026-07-26 15:44:02.486273 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-26 15:44:02.682095 | instance | changed
2026-07-26 15:44:02.689100 | 
2026-07-26 15:44:02.689199 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-26 15:44:02.898622 | instance | environment: line 5: kubectl: command not found
2026-07-26 15:44:02.900081 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 15:44:02.900117 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 15:44:02.900360 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-26 15:44:03.224509 | instance | ok: Runtime: 0:00:00.008417
2026-07-26 15:44:03.231422 | 
2026-07-26 15:44:03.231527 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-26 15:44:03.712420 | instance | changed:
2026-07-26 15:44:03.712734 | instance | cd+++++++++ objects/
2026-07-26 15:44:03.712797 | instance | cd+++++++++ objects/cluster/
2026-07-26 15:44:03.712846 | instance | cd+++++++++ objects/namespaced/
2026-07-26 15:44:03.723442 | 
2026-07-26 15:44:03.723518 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-26 15:44:03.920498 | instance | changed
2026-07-26 15:44:03.929568 | 
2026-07-26 15:44:03.929713 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-26 15:44:04.127447 | instance | changed
2026-07-26 15:44:04.134807 | 
2026-07-26 15:44:04.134923 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-26 15:44:04.349838 | instance | environment: line 3: kubectl: command not found
2026-07-26 15:44:04.676095 | instance | ok: Runtime: 0:00:00.008500
2026-07-26 15:44:04.682410 | 
2026-07-26 15:44:04.682524 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-26 15:44:05.175504 | instance | changed:
2026-07-26 15:44:05.175797 | instance | cd+++++++++ pod-logs/
2026-07-26 15:44:05.175861 | instance | cd+++++++++ pod-logs/failed-pods/
2026-07-26 15:44:05.185609 | 
2026-07-26 15:44:05.185681 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-07-26 15:44:05.384582 | instance | changed
2026-07-26 15:44:05.391607 | 
2026-07-26 15:44:05.391705 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-07-26 15:44:05.601012 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-26 15:44:05.931840 | instance | ok: Runtime: 0:00:00.039594
2026-07-26 15:44:05.939441 | 
2026-07-26 15:44:05.939574 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-07-26 15:44:06.151020 | instance | /bin/bash: line 2: kubectl: command not found
2026-07-26 15:44:06.178845 | instance | ceph-mgr endpoints:
2026-07-26 15:44:06.480440 | instance | ok: Runtime: 0:00:00.034222
2026-07-26 15:44:06.488013 | 
2026-07-26 15:44:06.488106 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-07-26 15:44:06.713073 | instance | /bin/bash: line 4: kubectl: command not found
2026-07-26 15:44:07.031860 | instance | ok: Runtime: 0:00:00.037076
2026-07-26 15:44:07.041334 | 
2026-07-26 15:44:07.041423 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-07-26 15:44:07.543751 | instance | changed: cd+++++++++ prometheus/
2026-07-26 15:44:07.552466 | 
2026-07-26 15:44:07.552531 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-07-26 15:44:07.747748 | instance | changed
2026-07-26 15:44:07.966550 | 
2026-07-26 15:44:07.966652 | TASK [gather-selenium-data : Get selenium data]
2026-07-26 15:44:08.217436 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-07-26 15:44:08.218994 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-07-26 15:44:08.539169 | instance | ERROR
2026-07-26 15:44:08.539375 | instance | {
2026-07-26 15:44:08.539411 | instance |   "delta": "0:00:00.006896",
2026-07-26 15:44:08.539433 | instance |   "end": "2026-07-26 15:44:08.219319",
2026-07-26 15:44:08.539634 | instance |   "msg": "non-zero return code",
2026-07-26 15:44:08.539654 | instance |   "rc": 1,
2026-07-26 15:44:08.539674 | instance |   "start": "2026-07-26 15:44:08.212423"
2026-07-26 15:44:08.539693 | instance | }
2026-07-26 15:44:08.539720 | instance | ERROR: Ignoring Errors
2026-07-26 15:44:08.544666 | 
2026-07-26 15:44:08.544732 | TASK [gather-selenium-data : Downloads logs to executor]
2026-07-26 15:44:09.024742 | instance | changed: cd+++++++++ selenium/
2026-07-26 15:44:09.033501 | 
2026-07-26 15:44:09.033554 | PLAY RECAP
2026-07-26 15:44:09.033620 | instance | ok: 23 changed: 21 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 2
2026-07-26 15:44:09.033645 | 
2026-07-26 15:44:17.494264 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-07-26 15:44:17.497327 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 15:44:18.113258 | 
2026-07-26 15:44:18.113390 | PLAY [all]
2026-07-26 15:44:18.124719 | 
2026-07-26 15:44:18.124798 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-26 15:44:18.169490 | instance | skipping: Conditional result was False
2026-07-26 15:44:18.176643 | 
2026-07-26 15:44:18.176747 | TASK [fetch-output : Set log path for single node]
2026-07-26 15:44:18.219365 | instance | ok
2026-07-26 15:44:18.225582 | 
2026-07-26 15:44:18.225664 | LOOP [fetch-output : Ensure local output dirs]
2026-07-26 15:44:18.629513 | instance -> localhost | ok: "/var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/logs"
2026-07-26 15:44:18.830959 | instance -> localhost | changed: "/var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/artifacts"
2026-07-26 15:44:19.034717 | instance -> localhost | changed: "/var/lib/zuul/builds/f1184bd5873349b98b74ba86009baf14/work/docs"
2026-07-26 15:44:19.051167 | 
2026-07-26 15:44:19.051405 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-26 15:44:19.675241 | instance | changed: .d..t...... ./
2026-07-26 15:44:19.675442 | instance | changed: All items complete
2026-07-26 15:44:19.675470 | 
2026-07-26 15:44:20.101496 | instance | changed: .d..t...... ./
2026-07-26 15:44:20.541982 | instance | changed: .d..t...... ./
2026-07-26 15:44:20.564467 | 
2026-07-26 15:44:20.564805 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-26 15:44:20.955100 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006828
2026-07-26 15:44:21.160169 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006463
2026-07-26 15:44:21.169680 | 
2026-07-26 15:44:21.169785 | PLAY [all]
2026-07-26 15:44:21.176496 | 
2026-07-26 15:44:21.176559 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-26 15:44:21.568911 | instance | changed
2026-07-26 15:44:21.574286 | 
2026-07-26 15:44:21.574395 | PLAY RECAP
2026-07-26 15:44:21.574727 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-26 15:44:21.574759 | 
2026-07-26 15:44:21.697321 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 15:44:21.703466 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-26 15:44:22.259351 | 
2026-07-26 15:44:22.259473 | PLAY [localhost]
2026-07-26 15:44:22.268846 | 
2026-07-26 15:44:22.268918 | TASK [Generate Zuul manifest]
2026-07-26 15:44:22.289559 | localhost | ok
2026-07-26 15:44:22.303639 | 
2026-07-26 15:44:22.303717 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-26 15:44:22.685243 | localhost | changed
2026-07-26 15:44:22.695662 | 
2026-07-26 15:44:22.695736 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-26 15:44:22.726390 | localhost | ok
2026-07-26 15:44:22.735137 | 
2026-07-26 15:44:22.735258 | TASK [Upload logs]
2026-07-26 15:44:22.755538 | localhost | ok
2026-07-26 15:44:22.813907 | 
2026-07-26 15:44:22.813993 | TASK [Set zuul-log-path fact]
2026-07-26 15:44:22.834173 | localhost | ok
2026-07-26 15:44:22.848712 | 
2026-07-26 15:44:22.848778 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 15:44:22.879659 | localhost | ok
2026-07-26 15:44:22.890816 | 
2026-07-26 15:44:22.890877 | TASK [upload-logs : Create log directories]
2026-07-26 15:44:23.300870 | localhost | changed
2026-07-26 15:44:23.305265 | 
2026-07-26 15:44:23.305332 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-26 15:44:23.669588 | localhost -> localhost | ok: Runtime: 0:00:00.004750
2026-07-26 15:44:23.676365 | 
2026-07-26 15:44:23.676461 | TASK [upload-logs : Upload logs to log server]
2026-07-26 15:44:24.119510 | localhost | Output suppressed because no_log was given
2026-07-26 15:44:24.124575 | 
2026-07-26 15:44:24.124657 | LOOP [upload-logs : Compress console log and json output]
2026-07-26 15:44:24.172093 | localhost | skipping: Conditional result was False
2026-07-26 15:44:24.178918 | localhost | skipping: Conditional result was False
2026-07-26 15:44:24.190253 | 
2026-07-26 15:44:24.190462 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-26 15:44:24.270444 | localhost | skipping: Conditional result was False
2026-07-26 15:44:24.270812 | 
2026-07-26 15:44:24.274955 | localhost | skipping: Conditional result was False
2026-07-26 15:44:24.286946 | 
2026-07-26 15:44:24.287094 | LOOP [upload-logs : Upload console log and json output]