2026-06-17 18:57:03.257646 | Job console starting 2026-06-17 18:57:03.272402 | Updating git repos 2026-06-17 18:57:03.373318 | Cloning repos into workspace 2026-06-17 18:57:03.420607 | Restoring repo states 2026-06-17 18:57:03.473385 | Merging changes 2026-06-17 18:57:04.622931 | Checking out repos 2026-06-17 18:57:04.683020 | Preparing playbooks 2026-06-17 18:57:08.659162 | Running Ansible setup 2026-06-17 18:57:12.759860 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-17 18:57:13.399396 | 2026-06-17 18:57:13.399543 | PLAY [localhost] 2026-06-17 18:57:13.408286 | 2026-06-17 18:57:13.408389 | TASK [Gathering Facts] 2026-06-17 18:57:14.480716 | localhost | ok 2026-06-17 18:57:14.492600 | 2026-06-17 18:57:14.492725 | TASK [Setup log path fact] 2026-06-17 18:57:14.515368 | localhost | ok 2026-06-17 18:57:14.531433 | 2026-06-17 18:57:14.531556 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-17 18:57:14.560441 | localhost | ok 2026-06-17 18:57:14.567653 | 2026-06-17 18:57:14.567727 | TASK [emit-job-header : Print job information] 2026-06-17 18:57:14.609375 | # Job Information 2026-06-17 18:57:14.609572 | Ansible Version: 2.16.18 2026-06-17 18:57:14.609627 | Job: ansible-collection-kubernetes-molecule-helm 2026-06-17 18:57:14.609660 | Pipeline: check 2026-06-17 18:57:14.609688 | Executor: 2d72f0692154 2026-06-17 18:57:14.609715 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/284 2026-06-17 18:57:14.609747 | Event ID: 34b337a0-6a7e-11f1-8a88-f16196b774a1 2026-06-17 18:57:14.613784 | 2026-06-17 18:57:14.613884 | LOOP [emit-job-header : Print node information] 2026-06-17 18:57:14.855511 | localhost | ok: 2026-06-17 18:57:14.855684 | localhost | # Node Information 2026-06-17 18:57:14.855713 | localhost | Inventory Hostname: controller 2026-06-17 18:57:14.855735 | localhost | Hostname: np0000181306 2026-06-17 18:57:14.855755 | localhost | Username: zuul 2026-06-17 18:57:14.855777 | localhost | Distro: Debian 13.5 2026-06-17 18:57:14.855797 | localhost | Provider: yul1 2026-06-17 18:57:14.855816 | localhost | Region: ca-ymq-1 2026-06-17 18:57:14.855834 | localhost | Label: debian-trixie 2026-06-17 18:57:14.855853 | localhost | Product Name: OpenStack Nova 2026-06-17 18:57:14.855871 | localhost | Interface IP: 199.204.45.38 2026-06-17 18:57:14.878093 | 2026-06-17 18:57:14.878426 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-17 18:57:15.293802 | localhost -> localhost | changed 2026-06-17 18:57:15.303109 | 2026-06-17 18:57:15.303218 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-17 18:57:16.210359 | localhost -> localhost | changed 2026-06-17 18:57:16.221717 | 2026-06-17 18:57:16.221802 | PLAY [all] 2026-06-17 18:57:16.229374 | 2026-06-17 18:57:16.229474 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-17 18:57:16.448059 | controller -> localhost | ok 2026-06-17 18:57:16.453956 | 2026-06-17 18:57:16.454099 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-17 18:57:16.483039 | controller | ok 2026-06-17 18:57:16.516823 | controller | included: /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-17 18:57:16.521887 | 2026-06-17 18:57:16.521955 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-17 18:57:17.757866 | controller -> localhost | Generating public/private rsa key pair. 2026-06-17 18:57:17.758099 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/6c296796dbc1415883b616befd8f7000_id_rsa 2026-06-17 18:57:17.758145 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/6c296796dbc1415883b616befd8f7000_id_rsa.pub 2026-06-17 18:57:17.758180 | controller -> localhost | The key fingerprint is: 2026-06-17 18:57:17.758212 | controller -> localhost | SHA256:UR4sN5YxgBTI1cycJlDksuPIvJDrRLuPVMP+n0wzbsU zuul-build-sshkey 2026-06-17 18:57:17.758260 | controller -> localhost | The key's randomart image is: 2026-06-17 18:57:17.758327 | controller -> localhost | +---[RSA 3072]----+ 2026-06-17 18:57:17.758368 | controller -> localhost | | ..B*B.+=o | 2026-06-17 18:57:17.758400 | controller -> localhost | | o.o Oo*o | 2026-06-17 18:57:17.758430 | controller -> localhost | | . .o.+.. | 2026-06-17 18:57:17.758460 | controller -> localhost | | . o . | 2026-06-17 18:57:17.758490 | controller -> localhost | | . +o S | 2026-06-17 18:57:17.758519 | controller -> localhost | |.++o.. E | 2026-06-17 18:57:17.758548 | controller -> localhost | |o++.. +. | 2026-06-17 18:57:17.758577 | controller -> localhost | |ooo.. +.+ | 2026-06-17 18:57:17.758610 | controller -> localhost | |o+o. .o= | 2026-06-17 18:57:17.758640 | controller -> localhost | +----[SHA256]-----+ 2026-06-17 18:57:17.758704 | controller -> localhost | ok: Runtime: 0:00:00.799174 2026-06-17 18:57:17.762933 | 2026-06-17 18:57:17.763019 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-17 18:57:17.795317 | controller | ok 2026-06-17 18:57:17.804845 | controller | included: /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-17 18:57:17.812330 | 2026-06-17 18:57:17.812443 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-17 18:57:17.837519 | controller | skipping: Conditional result was False 2026-06-17 18:57:17.844214 | 2026-06-17 18:57:17.844379 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-17 18:57:18.405305 | controller | changed 2026-06-17 18:57:18.410793 | 2026-06-17 18:57:18.410877 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-17 18:57:18.635609 | controller | ok 2026-06-17 18:57:18.643044 | 2026-06-17 18:57:18.643111 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-17 18:57:19.189239 | controller | changed 2026-06-17 18:57:19.194701 | 2026-06-17 18:57:19.194785 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-17 18:57:19.720102 | controller | changed 2026-06-17 18:57:19.768542 | 2026-06-17 18:57:19.768651 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-17 18:57:19.794257 | controller | skipping: Conditional result was False 2026-06-17 18:57:19.804267 | 2026-06-17 18:57:19.804469 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-17 18:57:20.208038 | controller -> localhost | changed 2026-06-17 18:57:20.223516 | 2026-06-17 18:57:20.223616 | TASK [add-build-sshkey : Add back temp key] 2026-06-17 18:57:20.530222 | controller -> localhost | Identity added: /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/6c296796dbc1415883b616befd8f7000_id_rsa (zuul-build-sshkey) 2026-06-17 18:57:20.530552 | controller -> localhost | ok: Runtime: 0:00:00.010624 2026-06-17 18:57:20.535313 | 2026-06-17 18:57:20.535380 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-17 18:57:20.878275 | controller | ok 2026-06-17 18:57:20.882267 | 2026-06-17 18:57:20.882331 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-17 18:57:20.907663 | controller | skipping: Conditional result was False 2026-06-17 18:57:20.920206 | 2026-06-17 18:57:20.920276 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-17 18:57:21.326185 | controller | ok 2026-06-17 18:57:21.331236 | 2026-06-17 18:57:21.331309 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-17 18:57:22.368013 | controller | Output suppressed because no_log was given 2026-06-17 18:57:22.386113 | 2026-06-17 18:57:22.386244 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-17 18:57:22.611512 | controller | ok: "logs" 2026-06-17 18:57:22.611846 | controller | ok: All items complete 2026-06-17 18:57:22.611889 | 2026-06-17 18:57:22.810619 | controller | ok: "artifacts" 2026-06-17 18:57:23.002698 | controller | ok: "docs" 2026-06-17 18:57:23.010637 | 2026-06-17 18:57:23.010793 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-17 18:57:23.240070 | controller | changed: "logs" 2026-06-17 18:57:23.425302 | controller | changed: "artifacts" 2026-06-17 18:57:23.609599 | controller | changed: "docs" 2026-06-17 18:57:23.617433 | 2026-06-17 18:57:23.617547 | PLAY RECAP 2026-06-17 18:57:23.617597 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-17 18:57:23.617626 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-17 18:57:23.617649 | 2026-06-17 18:57:23.742702 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-17 18:57:23.744292 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-17 18:57:24.433950 | 2026-06-17 18:57:24.434084 | PLAY [all] 2026-06-17 18:57:24.450114 | 2026-06-17 18:57:24.450393 | TASK [setup-uv : Extract archive] 2026-06-17 18:57:27.103729 | controller | changed 2026-06-17 18:57:27.108785 | 2026-06-17 18:57:27.108867 | TASK [setup-uv : Print version] 2026-06-17 18:57:27.607396 | controller | uv 0.8.13 2026-06-17 18:57:27.657581 | controller | ok: Runtime: 0:00:00.016307 2026-06-17 18:57:27.666346 | 2026-06-17 18:57:27.666414 | TASK [Install Ansible collection siblings] 2026-06-17 18:57:28.087659 | controller | ok: 2026-06-17 18:57:28.087923 | controller | Skipping ansible.posix: no checked-out sibling 2026-06-17 18:57:28.087985 | controller | Skipping community.crypto: no checked-out sibling 2026-06-17 18:57:28.088032 | controller | Skipping community.general: no checked-out sibling 2026-06-17 18:57:28.088077 | controller | Skipping kubernetes.core: no checked-out sibling 2026-06-17 18:57:28.088120 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-06-17 18:57:28.090362 | 2026-06-17 18:57:28.090407 | PLAY RECAP 2026-06-17 18:57:28.090451 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-17 18:57:28.090473 | 2026-06-17 18:57:28.236457 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-17 18:57:28.239237 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-06-17 18:57:28.915557 | 2026-06-17 18:57:28.915784 | PLAY [all] 2026-06-17 18:57:28.928144 | 2026-06-17 18:57:28.928309 | TASK [Update apt cache] 2026-06-17 18:57:34.784894 | controller | ok 2026-06-17 18:57:34.810667 | 2026-06-17 18:57:34.810887 | TASK [Disable firewalld] 2026-06-17 18:57:34.837078 | controller | skipping: Conditional result was False 2026-06-17 18:57:34.845087 | 2026-06-17 18:57:34.845181 | TASK [Install "jq" for log collection] 2026-06-17 18:57:37.228753 | controller | changed 2026-06-17 18:57:37.230905 | 2026-06-17 18:57:37.230957 | PLAY RECAP 2026-06-17 18:57:37.231005 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-17 18:57:37.231120 | 2026-06-17 18:57:37.358096 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-06-17 18:57:37.360974 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-17 18:57:37.988478 | 2026-06-17 18:57:37.988643 | PLAY [all] 2026-06-17 18:57:37.998876 | 2026-06-17 18:57:37.998950 | LOOP [Check inventory directories] 2026-06-17 18:57:38.391736 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-06-17 18:57:38.597820 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory" 2026-06-17 18:57:38.778581 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory" 2026-06-17 18:57:38.788276 | 2026-06-17 18:57:38.788546 | LOOP [Copy inventory file for Zuul] 2026-06-17 18:57:39.742517 | controller | changed: 2026-06-17 18:57:39.742729 | controller | { 2026-06-17 18:57:39.742758 | controller | "ansible_loop_var": "item", 2026-06-17 18:57:39.742781 | controller | "changed": false, 2026-06-17 18:57:39.742801 | controller | "failed": false, 2026-06-17 18:57:39.742823 | controller | "invocation": { 2026-06-17 18:57:39.742841 | controller | "module_args": { 2026-06-17 18:57:39.742859 | controller | "checksum_algorithm": "sha1", 2026-06-17 18:57:39.742876 | controller | "follow": true, 2026-06-17 18:57:39.742893 | controller | "get_attributes": true, 2026-06-17 18:57:39.742911 | controller | "get_checksum": true, 2026-06-17 18:57:39.742929 | controller | "get_mime": true, 2026-06-17 18:57:39.742945 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-06-17 18:57:39.742962 | controller | } 2026-06-17 18:57:39.742986 | controller | }, 2026-06-17 18:57:39.743008 | controller | "item": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-06-17 18:57:39.743026 | controller | "stat": { 2026-06-17 18:57:39.743043 | controller | "atime": 1781722642.304, 2026-06-17 18:57:39.743060 | controller | "attr_flags": "e", 2026-06-17 18:57:39.743077 | controller | "attributes": [ 2026-06-17 18:57:39.743093 | controller | "extents" 2026-06-17 18:57:39.743111 | controller | ], 2026-06-17 18:57:39.743128 | controller | "block_size": 4096, 2026-06-17 18:57:39.743145 | controller | "blocks": 8, 2026-06-17 18:57:39.743161 | controller | "charset": "unknown", 2026-06-17 18:57:39.743180 | controller | "ctime": 1781722642.328, 2026-06-17 18:57:39.743197 | controller | "dev": 65025, 2026-06-17 18:57:39.743213 | controller | "device_type": 0, 2026-06-17 18:57:39.743230 | controller | "executable": true, 2026-06-17 18:57:39.743247 | controller | "exists": true, 2026-06-17 18:57:39.743263 | controller | "gid": 1000, 2026-06-17 18:57:39.743280 | controller | "gr_name": "zuul", 2026-06-17 18:57:39.743296 | controller | "inode": 519959, 2026-06-17 18:57:39.743312 | controller | "isblk": false, 2026-06-17 18:57:39.743329 | controller | "ischr": false, 2026-06-17 18:57:39.743346 | controller | "isdir": true, 2026-06-17 18:57:39.743363 | controller | "isfifo": false, 2026-06-17 18:57:39.743380 | controller | "isgid": false, 2026-06-17 18:57:39.743399 | controller | "islnk": false, 2026-06-17 18:57:39.743418 | controller | "isreg": false, 2026-06-17 18:57:39.743434 | controller | "issock": false, 2026-06-17 18:57:39.743450 | controller | "isuid": false, 2026-06-17 18:57:39.743466 | controller | "mimetype": "unknown", 2026-06-17 18:57:39.743482 | controller | "mode": "0755", 2026-06-17 18:57:39.743498 | controller | "mtime": 1781722624.2634044, 2026-06-17 18:57:39.743514 | controller | "nlink": 14, 2026-06-17 18:57:39.743531 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-06-17 18:57:39.743547 | controller | "pw_name": "zuul", 2026-06-17 18:57:39.743568 | controller | "readable": true, 2026-06-17 18:57:39.743585 | controller | "rgrp": true, 2026-06-17 18:57:39.743602 | controller | "roth": true, 2026-06-17 18:57:39.743620 | controller | "rusr": true, 2026-06-17 18:57:39.743637 | controller | "size": 4096, 2026-06-17 18:57:39.743653 | controller | "uid": 1000, 2026-06-17 18:57:39.743669 | controller | "version": "3518860191", 2026-06-17 18:57:39.743686 | controller | "wgrp": false, 2026-06-17 18:57:39.743705 | controller | "woth": false, 2026-06-17 18:57:39.743722 | controller | "writeable": true, 2026-06-17 18:57:39.743738 | controller | "wusr": true, 2026-06-17 18:57:39.743755 | controller | "xgrp": true, 2026-06-17 18:57:39.743772 | controller | "xoth": true, 2026-06-17 18:57:39.743788 | controller | "xusr": true 2026-06-17 18:57:39.743805 | controller | } 2026-06-17 18:57:39.743840 | controller | } 2026-06-17 18:57:39.743876 | controller | ok: All items complete 2026-06-17 18:57:39.743898 | 2026-06-17 18:57:39.745243 | controller | skipping: Conditional result was False 2026-06-17 18:57:39.745899 | controller | skipping: Conditional result was False 2026-06-17 18:57:39.765901 | 2026-06-17 18:57:39.766111 | LOOP [Switch "ansible_host" to private IP] 2026-06-17 18:57:40.139276 | controller | changed: 1 replacements made 2026-06-17 18:57:40.141256 | controller | skipping: Conditional result was False 2026-06-17 18:57:40.141854 | controller | skipping: Conditional result was False 2026-06-17 18:57:40.157118 | 2026-06-17 18:57:40.157325 | TASK [Run Molecule scenario] 2026-06-17 18:57:40.693096 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-06-17 18:57:40.693184 | controller | Creating virtual environment at: .venv 2026-06-17 18:57:42.265233 | controller | Downloading pygments (1.2MiB) 2026-06-17 18:57:42.265539 | controller | Downloading ansible-core (2.3MiB) 2026-06-17 18:57:42.266395 | controller | Downloading cryptography (4.3MiB) 2026-06-17 18:57:42.437764 | controller | Downloading cryptography 2026-06-17 18:57:42.485083 | controller | Downloading pygments 2026-06-17 18:57:42.636150 | controller | Downloading ansible-core 2026-06-17 18:57:42.681216 | controller | Installed 36 packages in 44ms 2026-06-17 18:57:43.396569 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-06-17 18:57:43.396626 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-06-17 18:57:44.263295 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-06-17 18:57:44.263344 | controller | INFO default scenario not found, disabling shared state. 2026-06-17 18:57:44.263411 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-06-17 18:57:44.263497 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-06-17 19:01:41.666996 | controller | INFO [helm > dependency] Executing 2026-06-17 19:01:41.667047 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-06-17 19:01:41.667053 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-06-17 19:01:41.667079 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-06-17 19:01:41.674557 | controller | INFO [helm > cleanup] Executing 2026-06-17 19:01:41.674853 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-17 19:01:41.680201 | controller | INFO [helm > destroy] Executing 2026-06-17 19:01:41.680274 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-06-17 19:01:41.680345 | controller | INFO [helm > destroy] Executed: Successful 2026-06-17 19:01:41.685932 | controller | INFO [helm > syntax] Executing 2026-06-17 19:01:42.599263 | controller | 2026-06-17 19:01:42.599519 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-06-17 19:01:42.663198 | controller | INFO [helm > syntax] Executed: Successful 2026-06-17 19:01:42.670993 | controller | INFO [helm > create] Executing 2026-06-17 19:01:42.672909 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-17 19:01:42.679888 | controller | INFO [helm > prepare] Executing 2026-06-17 19:01:43.544096 | controller | 2026-06-17 19:01:43.544319 | controller | PLAY [Prepare] ***************************************************************** 2026-06-17 19:01:43.544525 | controller | 2026-06-17 19:01:43.544862 | controller | TASK [Gathering Facts] ********************************************************* 2026-06-17 19:01:43.545070 | controller | Wednesday 17 June 2026 19:01:43 +0000 (0:00:00.030) 0:00:00.030 ******** 2026-06-17 19:01:44.751200 | 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-06-17 19:01:44.759520 | controller | ok: [controller] 2026-06-17 19:01:44.759695 | controller | 2026-06-17 19:01:44.759886 | controller | TASK [Install Debian packages] ************************************************* 2026-06-17 19:01:44.760081 | controller | Wednesday 17 June 2026 19:01:44 +0000 (0:00:01.215) 0:00:01.245 ******** 2026-06-17 19:01:46.242557 | controller | ok: [controller] 2026-06-17 19:01:46.242710 | controller | 2026-06-17 19:01:46.242915 | controller | PLAY RECAP ********************************************************************* 2026-06-17 19:01:46.243137 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-17 19:01:46.243315 | controller | 2026-06-17 19:01:46.243491 | controller | 2026-06-17 19:01:46.243676 | controller | TASKS RECAP ******************************************************************** 2026-06-17 19:01:46.243874 | controller | Wednesday 17 June 2026 19:01:46 +0000 (0:00:01.483) 0:00:02.729 ******** 2026-06-17 19:01:46.244051 | controller | =============================================================================== 2026-06-17 19:01:46.244408 | controller | Install Debian packages ------------------------------------------------- 1.48s 2026-06-17 19:01:46.244602 | controller | Gathering Facts --------------------------------------------------------- 1.22s 2026-06-17 19:01:46.323019 | controller | INFO [helm > prepare] Executed: Successful 2026-06-17 19:01:46.332488 | controller | INFO [helm > converge] Executing 2026-06-17 19:01:47.157866 | controller | 2026-06-17 19:01:47.157932 | controller | PLAY [Converge] **************************************************************** 2026-06-17 19:01:47.158012 | controller | 2026-06-17 19:01:47.158162 | controller | TASK [Gathering Facts] ********************************************************* 2026-06-17 19:01:47.158263 | controller | Wednesday 17 June 2026 19:01:47 +0000 (0:00:00.013) 0:00:00.013 ******** 2026-06-17 19:01:48.232800 | 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-06-17 19:01:48.234783 | controller | ok: [controller] 2026-06-17 19:01:48.234894 | controller | 2026-06-17 19:01:48.235025 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-06-17 19:01:48.235179 | controller | Wednesday 17 June 2026 19:01:48 +0000 (0:00:01.076) 0:00:01.090 ******** 2026-06-17 19:01:48.769884 | controller | ok: [controller] 2026-06-17 19:01:48.769998 | controller | 2026-06-17 19:01:48.770259 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-06-17 19:01:48.770495 | controller | Wednesday 17 June 2026 19:01:48 +0000 (0:00:00.534) 0:00:01.624 ******** 2026-06-17 19:01:49.792977 | controller | ok: [controller] 2026-06-17 19:01:49.793158 | controller | 2026-06-17 19:01:49.793380 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-06-17 19:01:49.793581 | controller | Wednesday 17 June 2026 19:01:49 +0000 (0:00:01.023) 0:00:02.647 ******** 2026-06-17 19:01:50.220064 | controller | changed: [controller] 2026-06-17 19:01:50.220092 | controller | 2026-06-17 19:01:50.220097 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-06-17 19:01:50.220102 | controller | Wednesday 17 June 2026 19:01:50 +0000 (0:00:00.424) 0:00:03.072 ******** 2026-06-17 19:01:50.262554 | controller | ok: [controller] => { 2026-06-17 19:01:50.262748 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-06-17 19:01:50.262933 | controller | } 2026-06-17 19:01:50.263109 | controller | 2026-06-17 19:01:50.263308 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-06-17 19:01:50.263508 | controller | Wednesday 17 June 2026 19:01:50 +0000 (0:00:00.045) 0:00:03.117 ******** 2026-06-17 19:01:51.082189 | 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-06-17 19:01:51.087811 | controller | changed: [controller] 2026-06-17 19:01:51.088081 | controller | 2026-06-17 19:01:51.088406 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-06-17 19:01:51.088667 | controller | Wednesday 17 June 2026 19:01:51 +0000 (0:00:00.825) 0:00:03.943 ******** 2026-06-17 19:01:53.083613 | controller | changed: [controller] 2026-06-17 19:01:53.083795 | controller | 2026-06-17 19:01:53.084032 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-06-17 19:01:53.084279 | controller | Wednesday 17 June 2026 19:01:53 +0000 (0:00:01.995) 0:00:05.938 ******** 2026-06-17 19:01:53.614099 | controller | ok: [controller] 2026-06-17 19:01:53.614272 | controller | 2026-06-17 19:01:53.614504 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-06-17 19:01:53.614752 | controller | Wednesday 17 June 2026 19:01:53 +0000 (0:00:00.530) 0:00:06.468 ******** 2026-06-17 19:01:54.057969 | controller | changed: [controller] 2026-06-17 19:01:54.058117 | controller | 2026-06-17 19:01:54.058333 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-06-17 19:01:54.058533 | controller | Wednesday 17 June 2026 19:01:54 +0000 (0:00:00.444) 0:00:06.912 ******** 2026-06-17 19:01:54.500665 | controller | ok: [controller] 2026-06-17 19:01:54.500738 | controller | 2026-06-17 19:01:54.504319 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-06-17 19:01:54.504351 | controller | Wednesday 17 June 2026 19:01:54 +0000 (0:00:00.443) 0:00:07.355 ******** 2026-06-17 19:01:54.801169 | controller | changed: [controller] 2026-06-17 19:01:54.801321 | controller | 2026-06-17 19:01:54.801537 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-06-17 19:01:54.801733 | controller | Wednesday 17 June 2026 19:01:54 +0000 (0:00:00.300) 0:00:07.656 ******** 2026-06-17 19:01:55.097788 | controller | ok: [controller] 2026-06-17 19:01:55.097951 | controller | 2026-06-17 19:01:55.098155 | controller | TASK [Install plugin] ********************************************************** 2026-06-17 19:01:55.098367 | controller | Wednesday 17 June 2026 19:01:55 +0000 (0:00:00.296) 0:00:07.952 ******** 2026-06-17 19:01:55.150633 | controller | included: vexxhost.containers.download_artifact for controller 2026-06-17 19:01:55.150770 | controller | 2026-06-17 19:01:55.150971 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-06-17 19:01:55.151205 | controller | Wednesday 17 June 2026 19:01:55 +0000 (0:00:00.053) 0:00:08.005 ******** 2026-06-17 19:01:55.197919 | controller | ok: [controller] => { 2026-06-17 19:01:55.197970 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-06-17 19:01:55.198069 | controller | } 2026-06-17 19:01:55.198144 | controller | 2026-06-17 19:01:55.198241 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-06-17 19:01:55.198333 | controller | Wednesday 17 June 2026 19:01:55 +0000 (0:00:00.047) 0:00:08.053 ******** 2026-06-17 19:01:56.006849 | controller | changed: [controller] 2026-06-17 19:01:56.006885 | controller | 2026-06-17 19:01:56.006894 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-06-17 19:01:56.006901 | controller | Wednesday 17 June 2026 19:01:56 +0000 (0:00:00.807) 0:00:08.860 ******** 2026-06-17 19:01:59.034699 | controller | changed: [controller] 2026-06-17 19:01:59.034887 | controller | 2026-06-17 19:01:59.035091 | controller | PLAY RECAP ********************************************************************* 2026-06-17 19:01:59.035279 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-17 19:01:59.035432 | controller | 2026-06-17 19:01:59.035578 | controller | 2026-06-17 19:01:59.035737 | controller | TASKS RECAP ******************************************************************** 2026-06-17 19:01:59.035898 | controller | Wednesday 17 June 2026 19:01:59 +0000 (0:00:03.029) 0:00:11.890 ******** 2026-06-17 19:01:59.036049 | controller | =============================================================================== 2026-06-17 19:01:59.036206 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.03s 2026-06-17 19:01:59.036400 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.00s 2026-06-17 19:01:59.036557 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-06-17 19:01:59.036711 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.02s 2026-06-17 19:01:59.036902 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-06-17 19:01:59.037058 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-06-17 19:01:59.037215 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.53s 2026-06-17 19:01:59.037375 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s 2026-06-17 19:01:59.037550 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s 2026-06-17 19:01:59.037711 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-06-17 19:01:59.037879 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-06-17 19:01:59.038059 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-06-17 19:01:59.038227 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-06-17 19:01:59.038386 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-06-17 19:01:59.038559 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-06-17 19:01:59.038744 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-06-17 19:01:59.124761 | controller | INFO [helm > converge] Executed: Successful 2026-06-17 19:01:59.137431 | controller | INFO [helm > idempotence] Executing 2026-06-17 19:02:00.014055 | controller | 2026-06-17 19:02:00.014399 | controller | PLAY [Converge] **************************************************************** 2026-06-17 19:02:00.014660 | controller | 2026-06-17 19:02:00.014928 | controller | TASK [Gathering Facts] ********************************************************* 2026-06-17 19:02:00.015196 | controller | Wednesday 17 June 2026 19:02:00 +0000 (0:00:00.014) 0:00:00.014 ******** 2026-06-17 19:02:01.067914 | 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-06-17 19:02:01.073332 | controller | ok: [controller] 2026-06-17 19:02:01.073365 | controller | 2026-06-17 19:02:01.073371 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-06-17 19:02:01.073376 | controller | Wednesday 17 June 2026 19:02:01 +0000 (0:00:01.058) 0:00:01.073 ******** 2026-06-17 19:02:01.500900 | controller | ok: [controller] 2026-06-17 19:02:01.501166 | controller | 2026-06-17 19:02:01.501425 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-06-17 19:02:01.501670 | controller | Wednesday 17 June 2026 19:02:01 +0000 (0:00:00.427) 0:00:01.501 ******** 2026-06-17 19:02:02.473011 | controller | ok: [controller] 2026-06-17 19:02:02.473211 | controller | 2026-06-17 19:02:02.473479 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-06-17 19:02:02.473650 | controller | Wednesday 17 June 2026 19:02:02 +0000 (0:00:00.971) 0:00:02.472 ******** 2026-06-17 19:02:02.903679 | controller | ok: [controller] 2026-06-17 19:02:02.903738 | controller | 2026-06-17 19:02:02.903816 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-06-17 19:02:02.903908 | controller | Wednesday 17 June 2026 19:02:02 +0000 (0:00:00.431) 0:00:02.904 ******** 2026-06-17 19:02:02.947765 | controller | ok: [controller] => { 2026-06-17 19:02:02.947893 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-06-17 19:02:02.948050 | controller | } 2026-06-17 19:02:02.948202 | controller | 2026-06-17 19:02:02.948424 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-06-17 19:02:02.948605 | controller | Wednesday 17 June 2026 19:02:02 +0000 (0:00:00.041) 0:00:02.945 ******** 2026-06-17 19:02:03.462163 | controller | ok: [controller] 2026-06-17 19:02:03.462264 | controller | 2026-06-17 19:02:03.462334 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-06-17 19:02:03.462426 | controller | Wednesday 17 June 2026 19:02:03 +0000 (0:00:00.515) 0:00:03.460 ******** 2026-06-17 19:02:05.142283 | controller | ok: [controller] 2026-06-17 19:02:05.142331 | controller | 2026-06-17 19:02:05.142408 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-06-17 19:02:05.142496 | controller | Wednesday 17 June 2026 19:02:05 +0000 (0:00:01.680) 0:00:05.141 ******** 2026-06-17 19:02:05.691135 | controller | ok: [controller] 2026-06-17 19:02:05.691244 | controller | 2026-06-17 19:02:05.691401 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-06-17 19:02:05.691540 | controller | Wednesday 17 June 2026 19:02:05 +0000 (0:00:00.549) 0:00:05.690 ******** 2026-06-17 19:02:06.095706 | controller | ok: [controller] 2026-06-17 19:02:06.095799 | controller | 2026-06-17 19:02:06.095961 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-06-17 19:02:06.096136 | controller | Wednesday 17 June 2026 19:02:06 +0000 (0:00:00.405) 0:00:06.095 ******** 2026-06-17 19:02:06.567237 | controller | ok: [controller] 2026-06-17 19:02:06.567324 | controller | 2026-06-17 19:02:06.567466 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-06-17 19:02:06.567634 | controller | Wednesday 17 June 2026 19:02:06 +0000 (0:00:00.471) 0:00:06.567 ******** 2026-06-17 19:02:06.864462 | controller | ok: [controller] 2026-06-17 19:02:06.864522 | controller | 2026-06-17 19:02:06.864681 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-06-17 19:02:06.864768 | controller | Wednesday 17 June 2026 19:02:06 +0000 (0:00:00.297) 0:00:06.864 ******** 2026-06-17 19:02:07.179777 | controller | ok: [controller] 2026-06-17 19:02:07.179838 | controller | 2026-06-17 19:02:07.179892 | controller | TASK [Install plugin] ********************************************************** 2026-06-17 19:02:07.180030 | controller | Wednesday 17 June 2026 19:02:07 +0000 (0:00:00.313) 0:00:07.177 ******** 2026-06-17 19:02:07.231752 | controller | included: vexxhost.containers.download_artifact for controller 2026-06-17 19:02:07.231784 | controller | 2026-06-17 19:02:07.231884 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-06-17 19:02:07.231993 | controller | Wednesday 17 June 2026 19:02:07 +0000 (0:00:00.054) 0:00:07.232 ******** 2026-06-17 19:02:07.278182 | controller | ok: [controller] => { 2026-06-17 19:02:07.278374 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-06-17 19:02:07.278536 | controller | } 2026-06-17 19:02:07.278707 | controller | 2026-06-17 19:02:07.278908 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-06-17 19:02:07.279095 | controller | Wednesday 17 June 2026 19:02:07 +0000 (0:00:00.045) 0:00:07.277 ******** 2026-06-17 19:02:07.704323 | controller | ok: [controller] 2026-06-17 19:02:07.704511 | controller | 2026-06-17 19:02:07.704718 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-06-17 19:02:07.704878 | controller | Wednesday 17 June 2026 19:02:07 +0000 (0:00:00.425) 0:00:07.703 ******** 2026-06-17 19:02:09.336305 | controller | ok: [controller] 2026-06-17 19:02:09.336345 | controller | 2026-06-17 19:02:09.336355 | controller | PLAY RECAP ********************************************************************* 2026-06-17 19:02:09.336363 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-17 19:02:09.336371 | controller | 2026-06-17 19:02:09.336379 | controller | 2026-06-17 19:02:09.336386 | controller | TASKS RECAP ******************************************************************** 2026-06-17 19:02:09.336394 | controller | Wednesday 17 June 2026 19:02:09 +0000 (0:00:01.630) 0:00:09.334 ******** 2026-06-17 19:02:09.336401 | controller | =============================================================================== 2026-06-17 19:02:09.336408 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s 2026-06-17 19:02:09.336415 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.63s 2026-06-17 19:02:09.336422 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-06-17 19:02:09.336429 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.97s 2026-06-17 19:02:09.336603 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s 2026-06-17 19:02:09.336851 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.52s 2026-06-17 19:02:09.337095 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-06-17 19:02:09.337335 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-06-17 19:02:09.337575 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.43s 2026-06-17 19:02:09.337817 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-06-17 19:02:09.338154 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-06-17 19:02:09.338468 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-06-17 19:02:09.338791 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-06-17 19:02:09.339140 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-06-17 19:02:09.339450 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-06-17 19:02:09.339747 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-06-17 19:02:09.420392 | controller | INFO [helm > idempotence] Executed: Successful 2026-06-17 19:02:09.430214 | controller | INFO [helm > side_effect] Executing 2026-06-17 19:02:09.430553 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-17 19:02:09.435847 | controller | INFO [helm > verify] Executing 2026-06-17 19:02:10.257843 | controller | 2026-06-17 19:02:10.258166 | controller | PLAY [Verify] ****************************************************************** 2026-06-17 19:02:10.258420 | controller | 2026-06-17 19:02:10.258749 | controller | TASK [Gathering Facts] ********************************************************* 2026-06-17 19:02:10.259028 | controller | Wednesday 17 June 2026 19:02:10 +0000 (0:00:00.011) 0:00:00.011 ******** 2026-06-17 19:02:11.295583 | 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-06-17 19:02:11.301580 | controller | ok: [controller] 2026-06-17 19:02:11.301824 | controller | 2026-06-17 19:02:11.302108 | controller | TASK [Get the current Helm version] ******************************************** 2026-06-17 19:02:11.302359 | controller | Wednesday 17 June 2026 19:02:11 +0000 (0:00:01.043) 0:00:01.055 ******** 2026-06-17 19:02:11.738999 | controller | changed: [controller] 2026-06-17 19:02:11.739281 | controller | 2026-06-17 19:02:11.739549 | controller | TASK [Assert Helm version] ***************************************************** 2026-06-17 19:02:11.739808 | controller | Wednesday 17 June 2026 19:02:11 +0000 (0:00:00.437) 0:00:01.492 ******** 2026-06-17 19:02:11.767950 | controller | ok: [controller] => { 2026-06-17 19:02:11.768235 | controller | "changed": false, 2026-06-17 19:02:11.768524 | controller | "msg": "All assertions passed" 2026-06-17 19:02:11.768767 | controller | } 2026-06-17 19:02:11.768993 | controller | 2026-06-17 19:02:11.769231 | controller | PLAY RECAP ********************************************************************* 2026-06-17 19:02:11.769493 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-17 19:02:11.769718 | controller | 2026-06-17 19:02:11.770023 | controller | 2026-06-17 19:02:11.770267 | controller | TASKS RECAP ******************************************************************** 2026-06-17 19:02:11.770510 | controller | Wednesday 17 June 2026 19:02:11 +0000 (0:00:00.029) 0:00:01.522 ******** 2026-06-17 19:02:11.770741 | controller | =============================================================================== 2026-06-17 19:02:11.771059 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-06-17 19:02:11.771304 | controller | Get the current Helm version -------------------------------------------- 0.44s 2026-06-17 19:02:11.771541 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-06-17 19:02:11.853330 | controller | INFO [helm > verify] Executed: Successful 2026-06-17 19:02:11.863784 | controller | INFO [helm > cleanup] Executing 2026-06-17 19:02:11.864119 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-17 19:02:11.869562 | controller | INFO [helm > destroy] Executing 2026-06-17 19:02:11.869653 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-06-17 19:02:11.869737 | controller | INFO [helm > destroy] Executed: Successful 2026-06-17 19:02:11.870025 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-06-17 19:02:12.043150 | controller | ok: Runtime: 0:04:31.312342 2026-06-17 19:02:12.049719 | 2026-06-17 19:02:12.049787 | PLAY RECAP 2026-06-17 19:02:12.049834 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-17 19:02:12.049856 | 2026-06-17 19:02:12.532458 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-17 19:02:12.612393 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-06-17 19:02:13.740169 | 2026-06-17 19:02:13.740336 | PLAY [all] 2026-06-17 19:02:13.762898 | 2026-06-17 19:02:13.763025 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-06-17 19:02:15.549967 | controller | changed 2026-06-17 19:02:15.558632 | 2026-06-17 19:02:15.558856 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-06-17 19:02:16.033154 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-17 19:02:16.033365 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-17 19:02:16.040358 | controller | environment: line 1: kubectl: command not found 2026-06-17 19:02:16.041708 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-17 19:02:16.044111 | controller | environment: line 1: kubectl: command not found 2026-06-17 19:02:16.046532 | controller | environment: line 1: kubectl: command not found 2026-06-17 19:02:16.046547 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-17 19:02:16.046758 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-17 19:02:16.049045 | controller | environment: line 1: kubectl: command not found 2026-06-17 19:02:16.050146 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-17 19:02:16.051707 | controller | environment: line 1: kubectl: command not found 2026-06-17 19:02:16.053524 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-06-17 19:02:16.106875 | controller | ok: Runtime: 0:00:00.031696 2026-06-17 19:02:16.114603 | 2026-06-17 19:02:16.213408 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-06-17 19:02:16.510718 | controller | changed 2026-06-17 19:02:16.520747 | 2026-06-17 19:02:16.520901 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-06-17 19:02:16.772237 | controller | environment: line 5: kubectl: command not found 2026-06-17 19:02:16.773715 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-17 19:02:16.773868 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-17 19:02:16.774065 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-06-17 19:02:17.051792 | controller | ok: Runtime: 0:00:00.009686 2026-06-17 19:02:17.096730 | 2026-06-17 19:02:17.096912 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-06-17 19:02:17.926867 | controller | changed: 2026-06-17 19:02:17.927039 | controller | created directory /var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/logs/controller 2026-06-17 19:02:17.927071 | controller | cd+++++++++ objects/ 2026-06-17 19:02:17.927095 | controller | cd+++++++++ objects/cluster/ 2026-06-17 19:02:17.927118 | controller | cd+++++++++ objects/namespaced/ 2026-06-17 19:02:17.947383 | 2026-06-17 19:02:17.947545 | TASK [gather-pod-logs : creating directory for pod logs] 2026-06-17 19:02:19.175555 | controller | changed 2026-06-17 19:02:19.181967 | 2026-06-17 19:02:19.182161 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-06-17 19:02:19.467070 | controller | changed 2026-06-17 19:02:19.473306 | 2026-06-17 19:02:19.682896 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-06-17 19:02:19.950862 | controller | environment: line 3: kubectl: command not found 2026-06-17 19:02:20.226117 | controller | ok: Runtime: 0:00:00.010206 2026-06-17 19:02:20.231631 | 2026-06-17 19:02:20.231703 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-06-17 19:02:21.021410 | controller | changed: 2026-06-17 19:02:21.021664 | controller | cd+++++++++ pod-logs/ 2026-06-17 19:02:21.021708 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-06-17 19:02:21.033110 | 2026-06-17 19:02:21.033249 | LOOP [helm-release-status : creating directory for helm release status] 2026-06-17 19:02:21.269319 | controller | changed: "values" 2026-06-17 19:02:21.476649 | controller | changed: "releases" 2026-06-17 19:02:21.489051 | 2026-06-17 19:02:21.489222 | TASK [helm-release-status : Gather get release status for helm charts] 2026-06-17 19:02:21.757088 | controller | /bin/bash: line 3: kubectl: command not found 2026-06-17 19:02:22.027752 | controller | ok: Runtime: 0:00:00.007923 2026-06-17 19:02:22.043705 | 2026-06-17 19:02:22.044015 | TASK [helm-release-status : Downloads logs to executor] 2026-06-17 19:02:22.683139 | controller | changed: 2026-06-17 19:02:22.683325 | controller | cd+++++++++ helm/ 2026-06-17 19:02:22.683353 | controller | cd+++++++++ helm/releases/ 2026-06-17 19:02:22.683378 | controller | cd+++++++++ helm/values/ 2026-06-17 19:02:22.688887 | 2026-06-17 19:02:22.688949 | PLAY RECAP 2026-06-17 19:02:22.689047 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-17 19:02:22.689073 | 2026-06-17 19:02:22.997280 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-06-17 19:02:23.016241 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-17 19:02:24.209492 | 2026-06-17 19:02:24.318877 | PLAY [all] 2026-06-17 19:02:24.341227 | 2026-06-17 19:02:24.341385 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-17 19:02:24.398803 | controller | skipping: Conditional result was False 2026-06-17 19:02:24.403346 | 2026-06-17 19:02:24.403480 | TASK [fetch-output : Set log path for single node] 2026-06-17 19:02:24.449953 | controller | ok 2026-06-17 19:02:24.458456 | 2026-06-17 19:02:24.458579 | LOOP [fetch-output : Ensure local output dirs] 2026-06-17 19:02:25.094572 | controller -> localhost | ok: "/var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/logs" 2026-06-17 19:02:25.447008 | controller -> localhost | changed: "/var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/artifacts" 2026-06-17 19:02:25.697566 | controller -> localhost | changed: "/var/lib/zuul/builds/6c296796dbc1415883b616befd8f7000/work/docs" 2026-06-17 19:02:25.712344 | 2026-06-17 19:02:25.712518 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-17 19:02:27.306431 | controller | changed: .d..t...... ./ 2026-06-17 19:02:27.307097 | controller | changed: All items complete 2026-06-17 19:02:27.307207 | 2026-06-17 19:02:28.169617 | controller | changed: .d..t...... ./ 2026-06-17 19:02:28.722934 | controller | changed: .d..t...... ./ 2026-06-17 19:02:28.750033 | 2026-06-17 19:02:28.750342 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-17 19:02:29.836511 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.030938 2026-06-17 19:02:30.340766 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008253 2026-06-17 19:02:30.360383 | 2026-06-17 19:02:30.360493 | PLAY [all] 2026-06-17 19:02:30.379147 | 2026-06-17 19:02:30.379300 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-17 19:02:30.988126 | controller | changed 2026-06-17 19:02:30.992935 | 2026-06-17 19:02:30.993065 | PLAY RECAP 2026-06-17 19:02:30.993197 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-17 19:02:30.993228 | 2026-06-17 19:02:31.425923 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-17 19:02:31.640993 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-17 19:02:33.435226 | 2026-06-17 19:02:33.538186 | PLAY [localhost] 2026-06-17 19:02:33.552502 | 2026-06-17 19:02:33.552655 | TASK [Generate Zuul manifest] 2026-06-17 19:02:33.585018 | localhost | ok 2026-06-17 19:02:33.623624 | 2026-06-17 19:02:33.623804 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-17 19:02:34.540315 | localhost | changed 2026-06-17 19:02:34.565515 | 2026-06-17 19:02:34.565867 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-17 19:02:34.628793 | localhost | ok 2026-06-17 19:02:34.649015 | 2026-06-17 19:02:34.650047 | TASK [Upload logs] 2026-06-17 19:02:34.698982 | localhost | ok 2026-06-17 19:02:35.001214 | 2026-06-17 19:02:35.001379 | TASK [Set zuul-log-path fact] 2026-06-17 19:02:35.046201 | localhost | ok 2026-06-17 19:02:35.064164 | 2026-06-17 19:02:35.064514 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-17 19:02:35.147067 | localhost | ok 2026-06-17 19:02:35.175951 | 2026-06-17 19:02:35.176557 | TASK [upload-logs : Create log directories] 2026-06-17 19:02:36.332481 | localhost | changed 2026-06-17 19:02:36.337557 | 2026-06-17 19:02:36.337633 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-17 19:02:37.504075 | localhost -> localhost | ok: Runtime: 0:00:00.021766 2026-06-17 19:02:37.509960 | 2026-06-17 19:02:37.510040 | TASK [upload-logs : Upload logs to log server] 2026-06-17 19:02:38.363810 | localhost | Output suppressed because no_log was given 2026-06-17 19:02:38.370486 | 2026-06-17 19:02:38.370577 | LOOP [upload-logs : Compress console log and json output] 2026-06-17 19:02:38.425328 | localhost | skipping: Conditional result was False 2026-06-17 19:02:38.490263 | localhost | skipping: Conditional result was False 2026-06-17 19:02:38.515324 | 2026-06-17 19:02:38.515517 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-17 19:02:38.582558 | localhost | skipping: Conditional result was False 2026-06-17 19:02:38.582857 | 2026-06-17 19:02:38.587077 | localhost | skipping: Conditional result was False 2026-06-17 19:02:38.602175 | 2026-06-17 19:02:38.602337 | LOOP [upload-logs : Upload console log and json output]