2026-10-28 14:52:06.764476 | Job console starting
2026-10-28 14:52:06.780690 | Updating git repos
2026-10-28 14:52:12.271507 | Cloning repos into workspace
2026-10-28 14:52:29.269746 | Restoring repo states
2026-10-28 14:52:40.675011 | Merging changes
2026-10-28 14:52:41.345343 | Checking out repos
2026-10-28 14:52:42.299621 | Preparing playbooks
2026-10-28 14:52:45.260889 | Running Ansible setup
2026-10-28 14:52:49.047310 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-28 14:52:49.671730 | 
2026-10-28 14:52:49.671904 | PLAY [localhost]
2026-10-28 14:52:49.679643 | 
2026-10-28 14:52:49.679731 | TASK [Gathering Facts]
2026-10-28 14:52:50.556690 | localhost | ok
2026-10-28 14:52:50.570287 | 
2026-10-28 14:52:50.570472 | TASK [Setup log path fact]
2026-10-28 14:52:50.594573 | localhost | ok
2026-10-28 14:52:50.613376 | 
2026-10-28 14:52:50.613891 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-28 14:52:50.654193 | localhost | ok
2026-10-28 14:52:50.665229 | 
2026-10-28 14:52:50.665394 | TASK [emit-job-header : Print job information]
2026-10-28 14:52:50.718787 | # Job Information
2026-10-28 14:52:50.719050 | Ansible Version: 2.16.18
2026-10-28 14:52:50.719116 | Job: ansible-collection-kubernetes-molecule-helm
2026-10-28 14:52:50.719162 | Pipeline: check
2026-10-28 14:52:50.719201 | Executor: 2d72f0692154
2026-10-28 14:52:50.719241 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/324
2026-10-28 14:52:50.719287 | Event ID: cd3bf4e0-d2dd-11f1-9639-0e24cdfb40cf
2026-10-28 14:52:50.727599 | 
2026-10-28 14:52:50.727797 | LOOP [emit-job-header : Print node information]
2026-10-28 14:52:50.817954 | localhost | ok:
2026-10-28 14:52:50.818429 | localhost | # Node Information
2026-10-28 14:52:50.818468 | localhost | Inventory Hostname: controller
2026-10-28 14:52:50.818493 | localhost | Hostname: np0000198271
2026-10-28 14:52:50.818515 | localhost | Username: zuul
2026-10-28 14:52:50.818540 | localhost | Distro: Debian 13.7
2026-10-28 14:52:50.818562 | localhost | Provider: yul1
2026-10-28 14:52:50.818582 | localhost | Region: ca-ymq-1
2026-10-28 14:52:50.818602 | localhost | Label: debian-trixie
2026-10-28 14:52:50.818623 | localhost | Product Name: OpenStack Nova
2026-10-28 14:52:50.818643 | localhost | Interface IP: 199.204.45.131
2026-10-28 14:52:50.836651 | 
2026-10-28 14:52:50.836863 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-10-28 14:52:51.218041 | localhost -> localhost | changed
2026-10-28 14:52:51.229161 | 
2026-10-28 14:52:51.229351 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-10-28 14:52:52.121862 | localhost -> localhost | changed
2026-10-28 14:52:52.132914 | 
2026-10-28 14:52:52.133003 | PLAY [all]
2026-10-28 14:52:52.142426 | 
2026-10-28 14:52:52.142527 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-10-28 14:52:52.401756 | controller -> localhost | ok
2026-10-28 14:52:52.414400 | 
2026-10-28 14:52:52.414579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-10-28 14:52:52.450764 | controller | ok
2026-10-28 14:52:52.473288 | controller | included: /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-10-28 14:52:52.477863 | 
2026-10-28 14:52:52.477977 | TASK [add-build-sshkey : Create Temp SSH key]
2026-10-28 14:52:53.232982 | controller -> localhost | Generating public/private rsa key pair.
2026-10-28 14:52:53.233231 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/1d4e8c03bfae480fbaed3cc4e830fab4_id_rsa
2026-10-28 14:52:53.233290 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/1d4e8c03bfae480fbaed3cc4e830fab4_id_rsa.pub
2026-10-28 14:52:53.233335 | controller -> localhost | The key fingerprint is:
2026-10-28 14:52:53.233376 | controller -> localhost | SHA256:RyazufwTwTx3gesWfiSzT5kSThMi9Wry/dEzgGWg1Dw zuul-build-sshkey
2026-10-28 14:52:53.233434 | controller -> localhost | The key's randomart image is:
2026-10-28 14:52:53.233476 | controller -> localhost | +---[RSA 3072]----+
2026-10-28 14:52:53.233529 | controller -> localhost | |         o+. .   |
2026-10-28 14:52:53.233573 | controller -> localhost | |        o oE+ .  |
2026-10-28 14:52:53.233613 | controller -> localhost | |        o=o.o= . |
2026-10-28 14:52:53.233654 | controller -> localhost | |         B=.& o  |
2026-10-28 14:52:53.233692 | controller -> localhost | |        S +X @ o |
2026-10-28 14:52:53.233758 | controller -> localhost | |       . *..B *. |
2026-10-28 14:52:53.233798 | controller -> localhost | |        o .o.=.o.|
2026-10-28 14:52:53.233837 | controller -> localhost | |         ..  ...o|
2026-10-28 14:52:53.233880 | controller -> localhost | |          ..  .  |
2026-10-28 14:52:53.233919 | controller -> localhost | +----[SHA256]-----+
2026-10-28 14:52:53.234010 | controller -> localhost | ok: Runtime: 0:00:00.308024
2026-10-28 14:52:53.244185 | 
2026-10-28 14:52:53.244333 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-10-28 14:52:53.279718 | controller | ok
2026-10-28 14:52:53.295269 | controller | included: /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-10-28 14:52:53.307606 | 
2026-10-28 14:52:53.307866 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-10-28 14:52:53.331817 | controller | skipping: Conditional result was False
2026-10-28 14:52:53.343584 | 
2026-10-28 14:52:53.343854 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-10-28 14:52:53.888723 | controller | changed
2026-10-28 14:52:53.896208 | 
2026-10-28 14:52:53.896347 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-10-28 14:52:54.111793 | controller | ok
2026-10-28 14:52:54.119603 | 
2026-10-28 14:52:54.119757 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-10-28 14:52:54.741557 | controller | changed
2026-10-28 14:52:54.750806 | 
2026-10-28 14:52:54.750968 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-10-28 14:52:55.346155 | controller | changed
2026-10-28 14:52:55.354835 | 
2026-10-28 14:52:55.354964 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-10-28 14:52:55.380528 | controller | skipping: Conditional result was False
2026-10-28 14:52:55.390265 | 
2026-10-28 14:52:55.390417 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-10-28 14:52:55.802340 | controller -> localhost | changed
2026-10-28 14:52:55.820552 | 
2026-10-28 14:52:55.820694 | TASK [add-build-sshkey : Add back temp key]
2026-10-28 14:52:56.175097 | controller -> localhost | Identity added: /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/1d4e8c03bfae480fbaed3cc4e830fab4_id_rsa (zuul-build-sshkey)
2026-10-28 14:52:56.175444 | controller -> localhost | ok: Runtime: 0:00:00.014123
2026-10-28 14:52:56.185056 | 
2026-10-28 14:52:56.185212 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-10-28 14:52:56.558938 | controller | ok
2026-10-28 14:52:56.564658 | 
2026-10-28 14:52:56.564801 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-10-28 14:52:56.600902 | controller | skipping: Conditional result was False
2026-10-28 14:52:56.617549 | 
2026-10-28 14:52:56.617771 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-10-28 14:52:56.980072 | controller | ok
2026-10-28 14:52:56.995550 | 
2026-10-28 14:52:56.995815 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-10-28 14:53:01.759984 | controller | Output suppressed because no_log was given
2026-10-28 14:53:01.768903 | 
2026-10-28 14:53:01.769023 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-10-28 14:53:01.990027 | controller | ok: "logs"
2026-10-28 14:53:01.990477 | controller | ok: All items complete
2026-10-28 14:53:01.990557 | 
2026-10-28 14:53:02.153048 | controller | ok: "artifacts"
2026-10-28 14:53:02.337940 | controller | ok: "docs"
2026-10-28 14:53:02.352121 | 
2026-10-28 14:53:02.352360 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-10-28 14:53:02.557988 | controller | changed: "logs"
2026-10-28 14:53:02.784006 | controller | changed: "artifacts"
2026-10-28 14:53:02.976272 | controller | changed: "docs"
2026-10-28 14:53:03.005173 | 
2026-10-28 14:53:03.005345 | PLAY RECAP
2026-10-28 14:53:03.005428 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-10-28 14:53:03.005478 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-28 14:53:03.005516 | 
2026-10-28 14:53:03.216466 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-28 14:53:03.218024 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-28 14:53:03.804690 | 
2026-10-28 14:53:03.804830 | PLAY [all]
2026-10-28 14:53:03.814267 | 
2026-10-28 14:53:03.814349 | TASK [setup-uv : Extract archive]
2026-10-28 14:53:06.497317 | controller | changed
2026-10-28 14:53:06.501920 | 
2026-10-28 14:53:06.502003 | TASK [setup-uv : Print version]
2026-10-28 14:53:06.917976 | controller | uv 0.8.13
2026-10-28 14:53:07.027688 | controller | ok: Runtime: 0:00:00.016990
2026-10-28 14:53:07.042118 | 
2026-10-28 14:53:07.042249 | TASK [Install Ansible collection siblings]
2026-10-28 14:53:13.385053 | controller | changed:
2026-10-28 14:53:13.385256 | controller | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-10-28 14:53:13.385282 | controller | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-10-28 14:53:13.385301 | controller | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-10-28 14:53:13.385319 | controller | Sibling collection community.library_inventory_filtering_v1 at /home/zuul/src/github.com/ansible-collections/community.library_inventory_filtering
2026-10-28 14:53:13.385336 | controller | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-10-28 14:53:13.385358 | controller | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-10-28 14:53:13.385376 | controller | Resolved ansible.posix to 2.2.2 for >=1.6.0
2026-10-28 14:53:13.385394 | controller | Resolved community.crypto to 3.5.1 for >=2.2.3
2026-10-28 14:53:13.385412 | controller | Resolved community.general to 13.5.0 for >=4.5.0
2026-10-28 14:53:13.385428 | controller | Resolved kubernetes.core to 6.6.0 for >=2.3.2
2026-10-28 14:53:13.385445 | controller | Resolved vexxhost.containers to v1.6.8 for >=1.6.0
2026-10-28 14:53:13.385461 | controller | Resolved community.library_inventory_filtering_v1 to 1.1.5 for >=1.0.0
2026-10-28 14:53:13.385478 | controller | Checked out ansible.posix to 2.2.2
2026-10-28 14:53:13.385494 | controller | 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-10-28 14:53:13.385515 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.385532 | controller | Process install dependency map
2026-10-28 14:53:13.385549 | controller | Starting collection install process
2026-10-28 14:53:13.385565 | controller | Installing 'ansible.posix:2.2.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-10-28 14:53:13.385581 | controller | Created collection for ansible.posix:2.2.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-10-28 14:53:13.385597 | controller | ansible.posix:2.2.2 was installed successfully
2026-10-28 14:53:13.385613 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-10-28 14:53:13.385629 | controller | Creating virtual environment at: .venv
2026-10-28 14:53:13.385663 | controller | Downloading ansible-core (2.3MiB)
2026-10-28 14:53:13.385681 | controller | Downloading cryptography (4.3MiB)
2026-10-28 14:53:13.385713 | controller | Downloading pygments (1.2MiB)
2026-10-28 14:53:13.385732 | controller |  Downloading cryptography
2026-10-28 14:53:13.385748 | controller |  Downloading pygments
2026-10-28 14:53:13.385763 | controller |  Downloading ansible-core
2026-10-28 14:53:13.385779 | controller | Installed 36 packages in 61ms
2026-10-28 14:53:13.385795 | controller | Checked out community.crypto to 3.5.1
2026-10-28 14:53:13.385810 | controller | 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-10-28 14:53:13.385827 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.385843 | controller | Process install dependency map
2026-10-28 14:53:13.385859 | controller | Starting collection install process
2026-10-28 14:53:13.385874 | controller | Installing 'community.crypto:3.5.1' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-10-28 14:53:13.385890 | controller | Created collection for community.crypto:3.5.1 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-10-28 14:53:13.385906 | controller | community.crypto:3.5.1 was installed successfully
2026-10-28 14:53:13.385921 | controller | Checked out community.general to 13.5.0
2026-10-28 14:53:13.385937 | controller | 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-10-28 14:53:13.385952 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.385968 | controller | Process install dependency map
2026-10-28 14:53:13.385983 | controller | Starting collection install process
2026-10-28 14:53:13.385999 | controller | Installing 'community.general:13.5.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-10-28 14:53:13.386014 | controller | Created collection for community.general:13.5.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-10-28 14:53:13.386030 | controller | community.general:13.5.0 was installed successfully
2026-10-28 14:53:13.386047 | controller | Checked out community.library_inventory_filtering_v1 to 1.1.5
2026-10-28 14:53:13.386063 | controller | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.library_inventory_filtering
2026-10-28 14:53:13.386081 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.386097 | controller | Process install dependency map
2026-10-28 14:53:13.386114 | controller | Starting collection install process
2026-10-28 14:53:13.386130 | controller | Installing 'community.library_inventory_filtering_v1:1.1.5' to '/home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1'
2026-10-28 14:53:13.386146 | controller | Created collection for community.library_inventory_filtering_v1:1.1.5 at /home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1
2026-10-28 14:53:13.386162 | controller | community.library_inventory_filtering_v1:1.1.5 was installed successfully
2026-10-28 14:53:13.386179 | controller | Checked out kubernetes.core to 6.6.0
2026-10-28 14:53:13.386195 | controller | 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-10-28 14:53:13.386211 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.386227 | controller | Process install dependency map
2026-10-28 14:53:13.386242 | controller | Starting collection install process
2026-10-28 14:53:13.386263 | controller | Installing 'kubernetes.core:6.6.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-10-28 14:53:13.386279 | controller | Created collection for kubernetes.core:6.6.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-10-28 14:53:13.386295 | controller | kubernetes.core:6.6.0 was installed successfully
2026-10-28 14:53:13.386311 | controller | Checked out vexxhost.containers to v1.6.8
2026-10-28 14:53:13.386327 | controller | 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-10-28 14:53:13.386342 | controller | Starting galaxy collection install process
2026-10-28 14:53:13.386359 | controller | Process install dependency map
2026-10-28 14:53:13.386376 | controller | Starting collection install process
2026-10-28 14:53:13.386394 | controller | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-10-28 14:53:13.386409 | controller | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-10-28 14:53:13.386425 | controller | vexxhost.containers:1.6.8 was installed successfully
2026-10-28 14:53:13.395465 | 
2026-10-28 14:53:13.395916 | PLAY RECAP
2026-10-28 14:53:13.396279 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-28 14:53:13.396330 | 
2026-10-28 14:53:13.540948 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-28 14:53:13.543601 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-10-28 14:53:14.106409 | 
2026-10-28 14:53:14.106548 | PLAY [all]
2026-10-28 14:53:14.117025 | 
2026-10-28 14:53:14.117161 | TASK [Update apt cache]
2026-10-28 14:53:19.887609 | controller | ok
2026-10-28 14:53:19.895428 | 
2026-10-28 14:53:19.895578 | TASK [Disable firewalld]
2026-10-28 14:53:19.913590 | controller | skipping: Conditional result was False
2026-10-28 14:53:19.921979 | 
2026-10-28 14:53:19.922143 | TASK [Install "jq" for log collection]
2026-10-28 14:53:22.439365 | controller | changed
2026-10-28 14:53:22.441504 | 
2026-10-28 14:53:22.441578 | PLAY RECAP
2026-10-28 14:53:22.441640 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-28 14:53:22.441671 | 
2026-10-28 14:53:22.639776 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-10-28 14:53:22.643458 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-10-28 14:53:23.170785 | 
2026-10-28 14:53:23.170915 | PLAY [all]
2026-10-28 14:53:23.180474 | 
2026-10-28 14:53:23.180670 | LOOP [Check inventory directories]
2026-10-28 14:53:23.606387 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-10-28 14:53:23.811684 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory"
2026-10-28 14:53:24.005573 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory"
2026-10-28 14:53:24.020025 | 
2026-10-28 14:53:24.020307 | LOOP [Copy inventory file for Zuul]
2026-10-28 14:53:24.940387 | controller | changed:
2026-10-28 14:53:24.940769 | controller | {
2026-10-28 14:53:24.940808 | controller |   "ansible_loop_var": "item",
2026-10-28 14:53:24.940835 | controller |   "changed": false,
2026-10-28 14:53:24.940859 | controller |   "failed": false,
2026-10-28 14:53:24.940888 | controller |   "invocation": {
2026-10-28 14:53:24.940914 | controller |     "module_args": {
2026-10-28 14:53:24.940979 | controller |       "checksum_algorithm": "sha1",
2026-10-28 14:53:24.941009 | controller |       "follow": true,
2026-10-28 14:53:24.941032 | controller |       "get_attributes": true,
2026-10-28 14:53:24.941074 | controller |       "get_checksum": true,
2026-10-28 14:53:24.941099 | controller |       "get_mime": true,
2026-10-28 14:53:24.941122 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-10-28 14:53:24.941145 | controller |     }
2026-10-28 14:53:24.941167 | controller |   },
2026-10-28 14:53:24.941189 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-10-28 14:53:24.941212 | controller |   "stat": {
2026-10-28 14:53:24.941235 | controller |     "atime": 1793199181.3942173,
2026-10-28 14:53:24.941258 | controller |     "attr_flags": "e",
2026-10-28 14:53:24.941280 | controller |     "attributes": [
2026-10-28 14:53:24.941302 | controller |       "extents"
2026-10-28 14:53:24.941324 | controller |     ],
2026-10-28 14:53:24.941346 | controller |     "block_size": 4096,
2026-10-28 14:53:24.941368 | controller |     "blocks": 8,
2026-10-28 14:53:24.941390 | controller |     "charset": "unknown",
2026-10-28 14:53:24.941414 | controller |     "ctime": 1793199187.7987723,
2026-10-28 14:53:24.941436 | controller |     "dev": 65025,
2026-10-28 14:53:24.941458 | controller |     "device_type": 0,
2026-10-28 14:53:24.941480 | controller |     "executable": true,
2026-10-28 14:53:24.941501 | controller |     "exists": true,
2026-10-28 14:53:24.941522 | controller |     "gid": 1000,
2026-10-28 14:53:24.941544 | controller |     "gr_name": "zuul",
2026-10-28 14:53:24.941567 | controller |     "inode": 525891,
2026-10-28 14:53:24.941589 | controller |     "isblk": false,
2026-10-28 14:53:24.941656 | controller |     "ischr": false,
2026-10-28 14:53:24.941681 | controller |     "isdir": true,
2026-10-28 14:53:24.941722 | controller |     "isfifo": false,
2026-10-28 14:53:24.941746 | controller |     "isgid": false,
2026-10-28 14:53:24.941767 | controller |     "islnk": false,
2026-10-28 14:53:24.941790 | controller |     "isreg": false,
2026-10-28 14:53:24.941812 | controller |     "issock": false,
2026-10-28 14:53:24.941833 | controller |     "isuid": false,
2026-10-28 14:53:24.941854 | controller |     "mimetype": "unknown",
2026-10-28 14:53:24.941876 | controller |     "mode": "0755",
2026-10-28 14:53:24.941897 | controller |     "mtime": 1793199187.7987723,
2026-10-28 14:53:24.941918 | controller |     "nlink": 15,
2026-10-28 14:53:24.941940 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-10-28 14:53:24.941962 | controller |     "pw_name": "zuul",
2026-10-28 14:53:24.941987 | controller |     "readable": true,
2026-10-28 14:53:24.942010 | controller |     "rgrp": true,
2026-10-28 14:53:24.942033 | controller |     "roth": true,
2026-10-28 14:53:24.942055 | controller |     "rusr": true,
2026-10-28 14:53:24.942075 | controller |     "size": 4096,
2026-10-28 14:53:24.942094 | controller |     "uid": 1000,
2026-10-28 14:53:24.942112 | controller |     "version": "4110834737",
2026-10-28 14:53:24.942133 | controller |     "wgrp": false,
2026-10-28 14:53:24.942155 | controller |     "woth": false,
2026-10-28 14:53:24.942176 | controller |     "writeable": true,
2026-10-28 14:53:24.942198 | controller |     "wusr": true,
2026-10-28 14:53:24.942218 | controller |     "xgrp": true,
2026-10-28 14:53:24.942238 | controller |     "xoth": true,
2026-10-28 14:53:24.942257 | controller |     "xusr": true
2026-10-28 14:53:24.942277 | controller |   }
2026-10-28 14:53:24.942297 | controller | }
2026-10-28 14:53:24.942349 | controller | ok: All items complete
2026-10-28 14:53:24.942376 | 
2026-10-28 14:53:24.944645 | controller | skipping: Conditional result was False
2026-10-28 14:53:24.953268 | controller | skipping: Conditional result was False
2026-10-28 14:53:24.963856 | 
2026-10-28 14:53:24.964003 | LOOP [Switch "ansible_host" to private IP]
2026-10-28 14:53:25.386645 | controller | changed: 1 replacements made
2026-10-28 14:53:25.388797 | controller | skipping: Conditional result was False
2026-10-28 14:53:25.393717 | controller | skipping: Conditional result was False
2026-10-28 14:53:25.410409 | 
2026-10-28 14:53:25.410658 | TASK [Run Molecule scenario]
2026-10-28 14:53:26.466001 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-10-28 14:53:26.466075 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-10-28 14:53:26.971109 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-10-28 14:53:26.971163 | controller | INFO     default scenario not found, disabling shared state.
2026-10-28 14:53:26.971332 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-10-28 14:53:26.971420 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-10-28 14:53:30.458316 | controller | INFO     [helm > dependency] Executing
2026-10-28 14:53:30.458807 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-10-28 14:53:30.459247 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-10-28 14:53:30.459443 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-10-28 14:53:30.470862 | controller | INFO     [helm > cleanup] Executing
2026-10-28 14:53:30.471520 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-28 14:53:30.482750 | controller | INFO     [helm > destroy] Executing
2026-10-28 14:53:30.482848 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-10-28 14:53:30.483126 | controller | INFO     [helm > destroy] Executed: Successful
2026-10-28 14:53:30.493823 | controller | INFO     [helm > syntax] Executing
2026-10-28 14:53:31.383250 | controller |
2026-10-28 14:53:31.383519 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-10-28 14:53:31.453698 | controller | INFO     [helm > syntax] Executed: Successful
2026-10-28 14:53:31.465700 | controller | INFO     [helm > create] Executing
2026-10-28 14:53:31.468690 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-28 14:53:31.479497 | controller | INFO     [helm > prepare] Executing
2026-10-28 14:53:32.286080 | controller |
2026-10-28 14:53:32.286346 | controller | PLAY [Prepare] *****************************************************************
2026-10-28 14:53:32.286558 | controller |
2026-10-28 14:53:32.286780 | controller | TASK [Gathering Facts] *********************************************************
2026-10-28 14:53:32.287005 | controller | Wednesday 28 October 2026  14:53:32 +0000 (0:00:00.029)       0:00:00.029 *****
2026-10-28 14:53:34.589116 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-28 14:53:34.597053 | controller | ok: [controller]
2026-10-28 14:53:34.597194 | controller |
2026-10-28 14:53:34.597430 | controller | TASK [Install Debian packages] *************************************************
2026-10-28 14:53:34.597657 | controller | Wednesday 28 October 2026  14:53:34 +0000 (0:00:02.311)       0:00:02.340 *****
2026-10-28 14:53:36.100011 | controller | ok: [controller]
2026-10-28 14:53:36.100067 | controller |
2026-10-28 14:53:36.100266 | controller | PLAY RECAP *********************************************************************
2026-10-28 14:53:36.100406 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-28 14:53:36.100534 | controller |
2026-10-28 14:53:36.100661 | controller |
2026-10-28 14:53:36.100945 | controller | TASKS RECAP ********************************************************************
2026-10-28 14:53:36.101137 | controller | Wednesday 28 October 2026  14:53:36 +0000 (0:00:01.503)       0:00:03.844 *****
2026-10-28 14:53:36.101273 | controller | ===============================================================================
2026-10-28 14:53:36.101464 | controller | Gathering Facts --------------------------------------------------------- 2.31s
2026-10-28 14:53:36.101641 | controller | Install Debian packages ------------------------------------------------- 1.50s
2026-10-28 14:53:36.249799 | controller | INFO     [helm > prepare] Executed: Successful
2026-10-28 14:53:36.261377 | controller | INFO     [helm > converge] Executing
2026-10-28 14:53:37.110856 | controller |
2026-10-28 14:53:37.110978 | controller | PLAY [Converge] ****************************************************************
2026-10-28 14:53:37.111326 | controller |
2026-10-28 14:53:37.111508 | controller | TASK [Gathering Facts] *********************************************************
2026-10-28 14:53:37.111711 | controller | Wednesday 28 October 2026  14:53:37 +0000 (0:00:00.017)       0:00:00.017 *****
2026-10-28 14:53:38.236423 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-28 14:53:38.241628 | controller | ok: [controller]
2026-10-28 14:53:38.241820 | controller |
2026-10-28 14:53:38.242001 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-10-28 14:53:38.242178 | controller | Wednesday 28 October 2026  14:53:38 +0000 (0:00:01.130)       0:00:01.147 *****
2026-10-28 14:53:38.810839 | controller | ok: [controller]
2026-10-28 14:53:38.810916 | controller |
2026-10-28 14:53:38.811104 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-10-28 14:53:38.811274 | controller | Wednesday 28 October 2026  14:53:38 +0000 (0:00:00.568)       0:00:01.716 *****
2026-10-28 14:53:39.996019 | controller | ok: [controller]
2026-10-28 14:53:39.996063 | controller |
2026-10-28 14:53:39.996080 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-10-28 14:53:39.996173 | controller | Wednesday 28 October 2026  14:53:39 +0000 (0:00:01.184)       0:00:02.901 *****
2026-10-28 14:53:40.444337 | controller | changed: [controller]
2026-10-28 14:53:40.444437 | controller |
2026-10-28 14:53:40.444682 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-10-28 14:53:40.444829 | controller | Wednesday 28 October 2026  14:53:40 +0000 (0:00:00.448)       0:00:03.349 *****
2026-10-28 14:53:40.511353 | controller | ok: [controller] => {
2026-10-28 14:53:40.512118 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-10-28 14:53:40.512143 | controller | }
2026-10-28 14:53:40.512153 | controller |
2026-10-28 14:53:40.512589 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-10-28 14:53:40.512634 | controller | Wednesday 28 October 2026  14:53:40 +0000 (0:00:00.064)       0:00:03.414 *****
2026-10-28 14:53:41.416686 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually
2026-10-28 14:53:41.428548 | controller | changed: [controller]
2026-10-28 14:53:41.428722 | controller |
2026-10-28 14:53:41.428916 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-10-28 14:53:41.429227 | controller | Wednesday 28 October 2026  14:53:41 +0000 (0:00:00.919)       0:00:04.333 *****
2026-10-28 14:53:44.653096 | controller | changed: [controller]
2026-10-28 14:53:44.653152 | controller |
2026-10-28 14:53:44.653161 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-10-28 14:53:44.653182 | controller | Wednesday 28 October 2026  14:53:44 +0000 (0:00:03.221)       0:00:07.555 *****
2026-10-28 14:53:45.240630 | controller | ok: [controller]
2026-10-28 14:53:45.240939 | controller |
2026-10-28 14:53:45.241228 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-10-28 14:53:45.241480 | controller | Wednesday 28 October 2026  14:53:45 +0000 (0:00:00.588)       0:00:08.144 *****
2026-10-28 14:53:45.680556 | controller | changed: [controller]
2026-10-28 14:53:45.680819 | controller |
2026-10-28 14:53:45.681076 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-10-28 14:53:45.681337 | controller | Wednesday 28 October 2026  14:53:45 +0000 (0:00:00.439)       0:00:08.583 *****
2026-10-28 14:53:46.032529 | controller | changed: [controller]
2026-10-28 14:53:46.032662 | controller |
2026-10-28 14:53:46.032857 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-10-28 14:53:46.033036 | controller | Wednesday 28 October 2026  14:53:46 +0000 (0:00:00.352)       0:00:08.936 *****
2026-10-28 14:53:46.385017 | controller | ok: [controller]
2026-10-28 14:53:46.385164 | controller |
2026-10-28 14:53:46.385365 | controller | TASK [Install plugin] **********************************************************
2026-10-28 14:53:46.385541 | controller | Wednesday 28 October 2026  14:53:46 +0000 (0:00:00.354)       0:00:09.290 *****
2026-10-28 14:53:46.468278 | controller | included: vexxhost.containers.download_artifact for controller
2026-10-28 14:53:46.468366 | controller |
2026-10-28 14:53:46.468487 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-10-28 14:53:46.468605 | controller | Wednesday 28 October 2026  14:53:46 +0000 (0:00:00.082)       0:00:09.372 *****
2026-10-28 14:53:46.530977 | controller | ok: [controller] => {
2026-10-28 14:53:46.531171 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-10-28 14:53:46.531373 | controller | }
2026-10-28 14:53:46.531540 | controller |
2026-10-28 14:53:46.531728 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-10-28 14:53:46.531905 | controller | Wednesday 28 October 2026  14:53:46 +0000 (0:00:00.063)       0:00:09.436 *****
2026-10-28 14:53:47.363784 | controller | changed: [controller]
2026-10-28 14:53:47.364490 | controller |
2026-10-28 14:53:47.364509 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-10-28 14:53:47.364520 | controller | Wednesday 28 October 2026  14:53:47 +0000 (0:00:00.832)       0:00:10.269 *****
2026-10-28 14:53:49.496685 | controller | changed: [controller]
2026-10-28 14:53:49.496951 | controller |
2026-10-28 14:53:49.497182 | controller | PLAY RECAP *********************************************************************
2026-10-28 14:53:49.497424 | controller | controller                 : ok=15   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-28 14:53:49.497658 | controller |
2026-10-28 14:53:49.497860 | controller |
2026-10-28 14:53:49.498080 | controller | TASKS RECAP ********************************************************************
2026-10-28 14:53:49.498304 | controller | Wednesday 28 October 2026  14:53:49 +0000 (0:00:02.128)       0:00:12.398 *****
2026-10-28 14:53:49.498532 | controller | ===============================================================================
2026-10-28 14:53:49.498756 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.22s
2026-10-28 14:53:49.498984 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.13s
2026-10-28 14:53:49.499208 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.18s
2026-10-28 14:53:49.499431 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-10-28 14:53:49.499680 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.92s
2026-10-28 14:53:49.499901 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-10-28 14:53:49.500168 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.59s
2026-10-28 14:53:49.500390 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.57s
2026-10-28 14:53:49.500640 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s
2026-10-28 14:53:49.500864 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s
2026-10-28 14:53:49.501094 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.35s
2026-10-28 14:53:49.501325 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.35s
2026-10-28 14:53:49.501567 | controller | Install plugin ---------------------------------------------------------- 0.08s
2026-10-28 14:53:49.501793 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-10-28 14:53:49.502014 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-10-28 14:53:49.631087 | controller | INFO     [helm > converge] Executed: Successful
2026-10-28 14:53:49.642608 | controller | INFO     [helm > idempotence] Executing
2026-10-28 14:53:50.467144 | controller |
2026-10-28 14:53:50.467335 | controller | PLAY [Converge] ****************************************************************
2026-10-28 14:53:50.467487 | controller |
2026-10-28 14:53:50.467684 | controller | TASK [Gathering Facts] *********************************************************
2026-10-28 14:53:50.467858 | controller | Wednesday 28 October 2026  14:53:50 +0000 (0:00:00.013)       0:00:00.013 *****
2026-10-28 14:53:51.548909 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-28 14:53:51.556244 | controller | ok: [controller]
2026-10-28 14:53:51.556424 | controller |
2026-10-28 14:53:51.556622 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-10-28 14:53:51.556850 | controller | Wednesday 28 October 2026  14:53:51 +0000 (0:00:01.088)       0:00:01.102 *****
2026-10-28 14:53:52.020943 | controller | ok: [controller]
2026-10-28 14:53:52.021033 | controller |
2026-10-28 14:53:52.021324 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-10-28 14:53:52.021525 | controller | Wednesday 28 October 2026  14:53:52 +0000 (0:00:00.464)       0:00:01.567 *****
2026-10-28 14:53:53.195748 | controller | ok: [controller]
2026-10-28 14:53:53.195907 | controller |
2026-10-28 14:53:53.196142 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-10-28 14:53:53.196321 | controller | Wednesday 28 October 2026  14:53:53 +0000 (0:00:01.174)       0:00:02.741 *****
2026-10-28 14:53:53.641146 | controller | ok: [controller]
2026-10-28 14:53:53.641219 | controller |
2026-10-28 14:53:53.641370 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-10-28 14:53:53.641507 | controller | Wednesday 28 October 2026  14:53:53 +0000 (0:00:00.445)       0:00:03.187 *****
2026-10-28 14:53:53.701214 | controller | ok: [controller] => {
2026-10-28 14:53:53.701365 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-10-28 14:53:53.701640 | controller | }
2026-10-28 14:53:53.701768 | controller |
2026-10-28 14:53:53.702024 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-10-28 14:53:53.702241 | controller | Wednesday 28 October 2026  14:53:53 +0000 (0:00:00.059)       0:00:03.247 *****
2026-10-28 14:53:54.238705 | controller | ok: [controller]
2026-10-28 14:53:54.238746 | controller |
2026-10-28 14:53:54.238756 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-10-28 14:53:54.238764 | controller | Wednesday 28 October 2026  14:53:54 +0000 (0:00:00.536)       0:00:03.783 *****
2026-10-28 14:53:56.025068 | controller | ok: [controller]
2026-10-28 14:53:56.025104 | controller |
2026-10-28 14:53:56.025113 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-10-28 14:53:56.025121 | controller | Wednesday 28 October 2026  14:53:56 +0000 (0:00:01.785)       0:00:05.568 *****
2026-10-28 14:53:56.558653 | controller | ok: [controller]
2026-10-28 14:53:56.560476 | controller |
2026-10-28 14:53:56.560801 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-10-28 14:53:56.561041 | controller | Wednesday 28 October 2026  14:53:56 +0000 (0:00:00.533)       0:00:06.101 *****
2026-10-28 14:53:56.991767 | controller | ok: [controller]
2026-10-28 14:53:56.991819 | controller |
2026-10-28 14:53:56.991971 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-10-28 14:53:56.992110 | controller | Wednesday 28 October 2026  14:53:56 +0000 (0:00:00.433)       0:00:06.535 *****
2026-10-28 14:53:57.317402 | controller | ok: [controller]
2026-10-28 14:53:57.317451 | controller |
2026-10-28 14:53:57.317460 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-10-28 14:53:57.317470 | controller | Wednesday 28 October 2026  14:53:57 +0000 (0:00:00.327)       0:00:06.862 *****
2026-10-28 14:53:57.623379 | controller | ok: [controller]
2026-10-28 14:53:57.623477 | controller |
2026-10-28 14:53:57.623661 | controller | TASK [Install plugin] **********************************************************
2026-10-28 14:53:57.623838 | controller | Wednesday 28 October 2026  14:53:57 +0000 (0:00:00.306)       0:00:07.169 *****
2026-10-28 14:53:57.699842 | controller | included: vexxhost.containers.download_artifact for controller
2026-10-28 14:53:57.699968 | controller |
2026-10-28 14:53:57.700112 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-10-28 14:53:57.700205 | controller | Wednesday 28 October 2026  14:53:57 +0000 (0:00:00.077)       0:00:07.246 *****
2026-10-28 14:53:57.764482 | controller | ok: [controller] => {
2026-10-28 14:53:57.764697 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-10-28 14:53:57.764887 | controller | }
2026-10-28 14:53:57.765059 | controller |
2026-10-28 14:53:57.765239 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-10-28 14:53:57.765417 | controller | Wednesday 28 October 2026  14:53:57 +0000 (0:00:00.062)       0:00:07.308 *****
2026-10-28 14:53:58.225341 | controller | ok: [controller]
2026-10-28 14:53:58.225453 | controller |
2026-10-28 14:53:58.225659 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-10-28 14:53:58.225845 | controller | Wednesday 28 October 2026  14:53:58 +0000 (0:00:00.462)       0:00:07.771 *****
2026-10-28 14:54:00.944051 | controller | ok: [controller]
2026-10-28 14:54:00.944116 | controller |
2026-10-28 14:54:00.944125 | controller | PLAY RECAP *********************************************************************
2026-10-28 14:54:00.944134 | controller | controller                 : ok=15   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-28 14:54:00.944142 | controller |
2026-10-28 14:54:00.944150 | controller |
2026-10-28 14:54:00.944190 | controller | TASKS RECAP ********************************************************************
2026-10-28 14:54:00.944198 | controller | Wednesday 28 October 2026  14:54:00 +0000 (0:00:02.718)       0:00:10.489 *****
2026-10-28 14:54:00.944205 | controller | ===============================================================================
2026-10-28 14:54:00.944243 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.72s
2026-10-28 14:54:00.946689 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.79s
2026-10-28 14:54:00.946735 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.17s
2026-10-28 14:54:00.946743 | controller | Gathering Facts --------------------------------------------------------- 1.09s
2026-10-28 14:54:00.946750 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.54s
2026-10-28 14:54:00.946757 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s
2026-10-28 14:54:00.946764 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s
2026-10-28 14:54:00.946772 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.46s
2026-10-28 14:54:00.946780 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s
2026-10-28 14:54:00.946789 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s
2026-10-28 14:54:00.946796 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s
2026-10-28 14:54:00.946804 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s
2026-10-28 14:54:00.946811 | controller | Install plugin ---------------------------------------------------------- 0.08s
2026-10-28 14:54:00.946818 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-10-28 14:54:00.946824 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-10-28 14:54:01.050780 | controller | INFO     [helm > idempotence] Executed: Successful
2026-10-28 14:54:01.063059 | controller | INFO     [helm > side_effect] Executing
2026-10-28 14:54:01.063778 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-28 14:54:01.075293 | controller | INFO     [helm > verify] Executing
2026-10-28 14:54:01.909509 | controller |
2026-10-28 14:54:01.909714 | controller | PLAY [Verify] ******************************************************************
2026-10-28 14:54:01.909855 | controller |
2026-10-28 14:54:01.910010 | controller | TASK [Gathering Facts] *********************************************************
2026-10-28 14:54:01.910184 | controller | Wednesday 28 October 2026  14:54:01 +0000 (0:00:00.009)       0:00:00.009 *****
2026-10-28 14:54:03.033779 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-28 14:54:03.041507 | controller | ok: [controller]
2026-10-28 14:54:03.041661 | controller |
2026-10-28 14:54:03.041930 | controller | TASK [Get the current Helm version] ********************************************
2026-10-28 14:54:03.042163 | controller | Wednesday 28 October 2026  14:54:03 +0000 (0:00:01.131)       0:00:01.141 *****
2026-10-28 14:54:03.539418 | controller | changed: [controller]
2026-10-28 14:54:03.539554 | controller |
2026-10-28 14:54:03.539742 | controller | TASK [Assert Helm version] *****************************************************
2026-10-28 14:54:03.539994 | controller | Wednesday 28 October 2026  14:54:03 +0000 (0:00:00.497)       0:00:01.638 *****
2026-10-28 14:54:03.584626 | controller | ok: [controller] => {
2026-10-28 14:54:03.584807 | controller |     "changed": false,
2026-10-28 14:54:03.585004 | controller |     "msg": "All assertions passed"
2026-10-28 14:54:03.585174 | controller | }
2026-10-28 14:54:03.585329 | controller |
2026-10-28 14:54:03.585500 | controller | PLAY RECAP *********************************************************************
2026-10-28 14:54:03.585675 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-28 14:54:03.585823 | controller |
2026-10-28 14:54:03.585991 | controller |
2026-10-28 14:54:03.586156 | controller | TASKS RECAP ********************************************************************
2026-10-28 14:54:03.586328 | controller | Wednesday 28 October 2026  14:54:03 +0000 (0:00:00.044)       0:00:01.682 *****
2026-10-28 14:54:03.586484 | controller | ===============================================================================
2026-10-28 14:54:03.586647 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-10-28 14:54:03.586811 | controller | Get the current Helm version -------------------------------------------- 0.50s
2026-10-28 14:54:03.586998 | controller | Assert Helm version ----------------------------------------------------- 0.04s
2026-10-28 14:54:03.750874 | controller | INFO     [helm > verify] Executed: Successful
2026-10-28 14:54:03.763110 | controller | INFO     [helm > cleanup] Executing
2026-10-28 14:54:03.763677 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-28 14:54:03.775443 | controller | INFO     [helm > destroy] Executing
2026-10-28 14:54:03.775555 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-10-28 14:54:03.775691 | controller | INFO     [helm > destroy] Executed: Successful
2026-10-28 14:54:03.776235 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-10-28 14:54:03.979947 | controller | ok: Runtime: 0:00:38.029351
2026-10-28 14:54:03.984359 | 
2026-10-28 14:54:03.984439 | PLAY RECAP
2026-10-28 14:54:03.984518 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-28 14:54:03.984552 | 
2026-10-28 14:54:04.140323 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-10-28 14:54:04.142377 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-10-28 14:54:04.754308 | 
2026-10-28 14:54:04.754470 | PLAY [all]
2026-10-28 14:54:04.765210 | 
2026-10-28 14:54:04.765329 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-10-28 14:54:05.196187 | controller | changed
2026-10-28 14:54:05.204986 | 
2026-10-28 14:54:05.205215 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-10-28 14:54:05.632132 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-28 14:54:05.632210 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-28 14:54:05.639129 | controller | environment: line 1: kubectl: command not found
2026-10-28 14:54:05.641216 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-28 14:54:05.642480 | controller | environment: line 1: kubectl: command not found
2026-10-28 14:54:05.644687 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-28 14:54:05.645479 | controller | environment: line 1: kubectl: command not found
2026-10-28 14:54:05.647966 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-28 14:54:05.650381 | controller | environment: line 1: kubectl: command not found
2026-10-28 14:54:05.652188 | controller | environment: line 1: kubectl: command not found
2026-10-28 14:54:05.652564 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-28 14:54:05.654464 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-28 14:54:05.750028 | controller | ok: Runtime: 0:00:00.038138
2026-10-28 14:54:05.760039 | 
2026-10-28 14:54:05.760204 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-10-28 14:54:06.012406 | controller | changed
2026-10-28 14:54:06.017865 | 
2026-10-28 14:54:06.018006 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-10-28 14:54:06.290481 | controller | environment: line 5: kubectl: command not found
2026-10-28 14:54:06.290590 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-28 14:54:06.290606 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-28 14:54:06.290623 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-28 14:54:06.543799 | controller | ok: Runtime: 0:00:00.014675
2026-10-28 14:54:06.548328 | 
2026-10-28 14:54:06.548394 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-10-28 14:54:07.321986 | controller | changed:
2026-10-28 14:54:07.322242 | controller | created directory /var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/logs/controller
2026-10-28 14:54:07.322303 | controller | cd+++++++++ objects/
2026-10-28 14:54:07.322348 | controller | cd+++++++++ objects/cluster/
2026-10-28 14:54:07.322396 | controller | cd+++++++++ objects/namespaced/
2026-10-28 14:54:07.344416 | 
2026-10-28 14:54:07.344667 | TASK [gather-pod-logs : creating directory for pod logs]
2026-10-28 14:54:07.609867 | controller | changed
2026-10-28 14:54:07.617403 | 
2026-10-28 14:54:07.617861 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-10-28 14:54:07.892530 | controller | changed
2026-10-28 14:54:07.897844 | 
2026-10-28 14:54:07.897960 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-10-28 14:54:08.188375 | controller | environment: line 3: kubectl: command not found
2026-10-28 14:54:08.428366 | controller | ok: Runtime: 0:00:00.011982
2026-10-28 14:54:08.438146 | 
2026-10-28 14:54:08.438310 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-10-28 14:54:08.955012 | controller | changed:
2026-10-28 14:54:08.955233 | controller | cd+++++++++ pod-logs/
2026-10-28 14:54:08.955282 | controller | cd+++++++++ pod-logs/failed-pods/
2026-10-28 14:54:08.965376 | 
2026-10-28 14:54:08.965511 | LOOP [helm-release-status : creating directory for helm release status]
2026-10-28 14:54:09.232940 | controller | changed: "values"
2026-10-28 14:54:09.463641 | controller | changed: "releases"
2026-10-28 14:54:09.474165 | 
2026-10-28 14:54:09.474313 | TASK [helm-release-status : Gather get release status for helm charts]
2026-10-28 14:54:09.825701 | controller | /bin/bash: line 11: kubectl: command not found
2026-10-28 14:54:10.007163 | controller | ok: Runtime: 0:00:00.081168
2026-10-28 14:54:10.014287 | 
2026-10-28 14:54:10.014551 | TASK [helm-release-status : Downloads logs to executor]
2026-10-28 14:54:10.577605 | controller | changed:
2026-10-28 14:54:10.577949 | controller | cd+++++++++ helm/
2026-10-28 14:54:10.578013 | controller | cd+++++++++ helm/releases/
2026-10-28 14:54:10.578067 | controller | cd+++++++++ helm/values/
2026-10-28 14:54:10.591088 | 
2026-10-28 14:54:10.591267 | PLAY RECAP
2026-10-28 14:54:10.591395 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-28 14:54:10.591450 | 
2026-10-28 14:54:10.775612 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-10-28 14:54:10.778242 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-28 14:54:11.352524 | 
2026-10-28 14:54:11.352723 | PLAY [all]
2026-10-28 14:54:11.364410 | 
2026-10-28 14:54:11.364561 | TASK [fetch-output : Set log path for multiple nodes]
2026-10-28 14:54:11.408739 | controller | skipping: Conditional result was False
2026-10-28 14:54:11.412847 | 
2026-10-28 14:54:11.412936 | TASK [fetch-output : Set log path for single node]
2026-10-28 14:54:11.454026 | controller | ok
2026-10-28 14:54:11.462667 | 
2026-10-28 14:54:11.462807 | LOOP [fetch-output : Ensure local output dirs]
2026-10-28 14:54:11.918811 | controller -> localhost | ok: "/var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/logs"
2026-10-28 14:54:12.151152 | controller -> localhost | changed: "/var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/artifacts"
2026-10-28 14:54:12.389332 | controller -> localhost | changed: "/var/lib/zuul/builds/1d4e8c03bfae480fbaed3cc4e830fab4/work/docs"
2026-10-28 14:54:12.403748 | 
2026-10-28 14:54:12.403966 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-10-28 14:54:13.115253 | controller | changed: .d..t...... ./
2026-10-28 14:54:13.115476 | controller | changed: All items complete
2026-10-28 14:54:13.115503 | 
2026-10-28 14:54:13.577198 | controller | changed: .d..t...... ./
2026-10-28 14:54:14.085919 | controller | changed: .d..t...... ./
2026-10-28 14:54:14.106327 | 
2026-10-28 14:54:14.106453 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-10-28 14:54:14.587840 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006549
2026-10-28 14:54:14.830710 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.004653
2026-10-28 14:54:14.839426 | 
2026-10-28 14:54:14.839519 | PLAY [all]
2026-10-28 14:54:14.845595 | 
2026-10-28 14:54:14.845715 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-10-28 14:54:15.302829 | controller | changed
2026-10-28 14:54:15.311386 | 
2026-10-28 14:54:15.311486 | PLAY RECAP
2026-10-28 14:54:15.311573 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-28 14:54:15.311636 | 
2026-10-28 14:54:15.500872 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-28 14:54:15.503356 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-10-28 14:54:16.075881 | 
2026-10-28 14:54:16.076043 | PLAY [localhost]
2026-10-28 14:54:16.085679 | 
2026-10-28 14:54:16.085868 | TASK [Generate Zuul manifest]
2026-10-28 14:54:16.103404 | localhost | ok
2026-10-28 14:54:16.116863 | 
2026-10-28 14:54:16.117001 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-10-28 14:54:16.556021 | localhost | changed
2026-10-28 14:54:16.575215 | 
2026-10-28 14:54:16.575469 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-10-28 14:54:16.608093 | localhost | ok
2026-10-28 14:54:16.622386 | 
2026-10-28 14:54:16.622610 | TASK [Upload logs]
2026-10-28 14:54:16.645034 | localhost | ok
2026-10-28 14:54:16.714196 | 
2026-10-28 14:54:16.714372 | TASK [Set zuul-log-path fact]
2026-10-28 14:54:16.733105 | localhost | ok
2026-10-28 14:54:16.743863 | 
2026-10-28 14:54:16.743961 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-28 14:54:16.783183 | localhost | ok
2026-10-28 14:54:16.792894 | 
2026-10-28 14:54:16.793012 | TASK [upload-logs : Create log directories]
2026-10-28 14:54:17.330089 | localhost | changed
2026-10-28 14:54:17.337243 | 
2026-10-28 14:54:17.337418 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-10-28 14:54:17.786090 | localhost -> localhost | ok: Runtime: 0:00:00.004285
2026-10-28 14:54:17.793707 | 
2026-10-28 14:54:17.794118 | TASK [upload-logs : Upload logs to log server]
2026-10-28 14:54:18.328577 | localhost | Output suppressed because no_log was given
2026-10-28 14:54:18.336076 | 
2026-10-28 14:54:18.336294 | LOOP [upload-logs : Compress console log and json output]
2026-10-28 14:54:18.463515 | localhost | skipping: Conditional result was False
2026-10-28 14:54:18.470398 | localhost | skipping: Conditional result was False
2026-10-28 14:54:18.485465 | 
2026-10-28 14:54:18.485822 | LOOP [upload-logs : Upload compressed console log and json output]
2026-10-28 14:54:18.588065 | localhost | skipping: Conditional result was False
2026-10-28 14:54:18.588544 | 
2026-10-28 14:54:18.591596 | localhost | skipping: Conditional result was False
2026-10-28 14:54:18.601768 | 
2026-10-28 14:54:18.602063 | LOOP [upload-logs : Upload console log and json output]