2026-06-17 20:40:47.546541 | Job console starting
2026-06-17 20:40:47.563126 | Updating git repos
2026-06-17 20:40:47.748472 | Cloning repos into workspace
2026-06-17 20:40:47.946243 | Restoring repo states
2026-06-17 20:40:47.959530 | Merging changes
2026-06-17 20:40:49.325432 | Checking out repos
2026-06-17 20:40:49.484851 | Preparing playbooks
2026-06-17 20:40:54.041382 | Running Ansible setup
2026-06-17 20:40:58.863076 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-17 20:40:59.494891 | 
2026-06-17 20:40:59.495031 | PLAY [localhost]
2026-06-17 20:40:59.504243 | 
2026-06-17 20:40:59.504328 | TASK [Gathering Facts]
2026-06-17 20:41:00.642222 | localhost | ok
2026-06-17 20:41:00.654170 | 
2026-06-17 20:41:00.654354 | TASK [Setup log path fact]
2026-06-17 20:41:00.674115 | localhost | ok
2026-06-17 20:41:00.694986 | 
2026-06-17 20:41:00.695243 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-17 20:41:00.724988 | localhost | ok
2026-06-17 20:41:00.733377 | 
2026-06-17 20:41:00.733494 | TASK [emit-job-header : Print job information]
2026-06-17 20:41:00.773605 | # Job Information
2026-06-17 20:41:00.773788 | Ansible Version: 2.16.18
2026-06-17 20:41:00.773834 | Job: ansible-collection-kubernetes-molecule-helm
2026-06-17 20:41:00.773866 | Pipeline: check
2026-06-17 20:41:00.773894 | Executor: 2d72f0692154
2026-06-17 20:41:00.773922 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/285
2026-06-17 20:41:00.773955 | Event ID: ade49340-6a8c-11f1-9331-ca890a4b8b58
2026-06-17 20:41:00.778741 | 
2026-06-17 20:41:00.778833 | LOOP [emit-job-header : Print node information]
2026-06-17 20:41:00.854555 | localhost | ok:
2026-06-17 20:41:00.854741 | localhost | # Node Information
2026-06-17 20:41:00.854789 | localhost | Inventory Hostname: controller
2026-06-17 20:41:00.854826 | localhost | Hostname: np0000181658
2026-06-17 20:41:00.854863 | localhost | Username: zuul
2026-06-17 20:41:00.854900 | localhost | Distro: Debian 13.5
2026-06-17 20:41:00.854925 | localhost | Provider: yul1
2026-06-17 20:41:00.854949 | localhost | Region: ca-ymq-1
2026-06-17 20:41:00.854973 | localhost | Label: debian-trixie
2026-06-17 20:41:00.855002 | localhost | Product Name: OpenStack Nova
2026-06-17 20:41:00.855037 | localhost | Interface IP: 199.204.45.70
2026-06-17 20:41:00.865686 | 
2026-06-17 20:41:00.865855 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-17 20:41:01.308660 | localhost -> localhost | changed
2026-06-17 20:41:01.313819 | 
2026-06-17 20:41:01.313895 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-17 20:41:02.597624 | localhost -> localhost | changed
2026-06-17 20:41:02.607743 | 
2026-06-17 20:41:02.607856 | PLAY [all]
2026-06-17 20:41:02.615853 | 
2026-06-17 20:41:02.615954 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-17 20:41:02.862442 | controller -> localhost | ok
2026-06-17 20:41:02.871567 | 
2026-06-17 20:41:02.871779 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-17 20:41:02.902785 | controller | ok
2026-06-17 20:41:02.925519 | controller | included: /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-17 20:41:02.930990 | 
2026-06-17 20:41:02.931062 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-17 20:41:03.953464 | controller -> localhost | Generating public/private rsa key pair.
2026-06-17 20:41:03.954105 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/9e272086935c48648490081a250ba8f5_id_rsa
2026-06-17 20:41:03.954159 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/9e272086935c48648490081a250ba8f5_id_rsa.pub
2026-06-17 20:41:03.954195 | controller -> localhost | The key fingerprint is:
2026-06-17 20:41:03.954625 | controller -> localhost | SHA256:x2ioWunOdw+exnczd1P+X5M7hUMWMSIX/txpUr2Wm3M zuul-build-sshkey
2026-06-17 20:41:03.954707 | controller -> localhost | The key's randomart image is:
2026-06-17 20:41:03.954746 | controller -> localhost | +---[RSA 3072]----+
2026-06-17 20:41:03.954787 | controller -> localhost | |          . +.o. |
2026-06-17 20:41:03.954823 | controller -> localhost | |           + ....|
2026-06-17 20:41:03.954854 | controller -> localhost | |            .  o.|
2026-06-17 20:41:03.954883 | controller -> localhost | |       . o   o+.+|
2026-06-17 20:41:03.954912 | controller -> localhost | |      . S o  +oB.|
2026-06-17 20:41:03.954939 | controller -> localhost | |     o . .    * *|
2026-06-17 20:41:03.954968 | controller -> localhost | |    +  ..      OE|
2026-06-17 20:41:03.954996 | controller -> localhost | |   =  ..+o. + .oO|
2026-06-17 20:41:03.955028 | controller -> localhost | |  ..+. ooo.. + oB|
2026-06-17 20:41:03.955058 | controller -> localhost | +----[SHA256]-----+
2026-06-17 20:41:03.955129 | controller -> localhost | ok: Runtime: 0:00:00.594578
2026-06-17 20:41:03.964297 | 
2026-06-17 20:41:03.964382 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-17 20:41:03.997450 | controller | ok
2026-06-17 20:41:04.023230 | controller | included: /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-17 20:41:04.030669 | 
2026-06-17 20:41:04.030736 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-17 20:41:04.059978 | controller | skipping: Conditional result was False
2026-06-17 20:41:04.064707 | 
2026-06-17 20:41:04.064802 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-17 20:41:04.649609 | controller | changed
2026-06-17 20:41:04.655510 | 
2026-06-17 20:41:04.655590 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-17 20:41:04.870701 | controller | ok
2026-06-17 20:41:04.881193 | 
2026-06-17 20:41:04.881346 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-17 20:41:05.420199 | controller | changed
2026-06-17 20:41:05.425631 | 
2026-06-17 20:41:05.425721 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-17 20:41:05.957770 | controller | changed
2026-06-17 20:41:05.965732 | 
2026-06-17 20:41:05.965837 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-17 20:41:05.991990 | controller | skipping: Conditional result was False
2026-06-17 20:41:06.000303 | 
2026-06-17 20:41:06.000469 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-17 20:41:06.381666 | controller -> localhost | changed
2026-06-17 20:41:06.395519 | 
2026-06-17 20:41:06.395636 | TASK [add-build-sshkey : Add back temp key]
2026-06-17 20:41:06.722772 | controller -> localhost | Identity added: /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/9e272086935c48648490081a250ba8f5_id_rsa (zuul-build-sshkey)
2026-06-17 20:41:06.723057 | controller -> localhost | ok: Runtime: 0:00:00.017859
2026-06-17 20:41:06.728429 | 
2026-06-17 20:41:06.728495 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-17 20:41:07.096755 | controller | ok
2026-06-17 20:41:07.102303 | 
2026-06-17 20:41:07.102397 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-17 20:41:07.125742 | controller | skipping: Conditional result was False
2026-06-17 20:41:07.139309 | 
2026-06-17 20:41:07.139387 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-17 20:41:07.524424 | controller | ok
2026-06-17 20:41:07.530850 | 
2026-06-17 20:41:07.530956 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-17 20:41:08.538979 | controller | Output suppressed because no_log was given
2026-06-17 20:41:08.548757 | 
2026-06-17 20:41:08.548843 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-17 20:41:08.763495 | controller | ok: "logs"
2026-06-17 20:41:08.763780 | controller | ok: All items complete
2026-06-17 20:41:08.763824 | 
2026-06-17 20:41:08.948170 | controller | ok: "artifacts"
2026-06-17 20:41:09.138353 | controller | ok: "docs"
2026-06-17 20:41:09.153665 | 
2026-06-17 20:41:09.153954 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-17 20:41:09.363312 | controller | changed: "logs"
2026-06-17 20:41:09.556662 | controller | changed: "artifacts"
2026-06-17 20:41:09.745298 | controller | changed: "docs"
2026-06-17 20:41:09.764358 | 
2026-06-17 20:41:09.764502 | PLAY RECAP
2026-06-17 20:41:09.764556 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-17 20:41:09.764585 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:41:09.764607 | 
2026-06-17 20:41:09.962089 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-17 20:41:09.963612 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-17 20:41:10.575417 | 
2026-06-17 20:41:10.575571 | PLAY [all]
2026-06-17 20:41:10.585359 | 
2026-06-17 20:41:10.585445 | TASK [setup-uv : Extract archive]
2026-06-17 20:41:13.001191 | controller | changed
2026-06-17 20:41:13.192457 | 
2026-06-17 20:41:13.192622 | TASK [setup-uv : Print version]
2026-06-17 20:41:13.604285 | controller | uv 0.8.13
2026-06-17 20:41:13.728085 | controller | ok: Runtime: 0:00:00.010400
2026-06-17 20:41:13.735079 | 
2026-06-17 20:41:13.735180 | TASK [Install Ansible collection siblings]
2026-06-17 20:41:14.142567 | controller | ok:
2026-06-17 20:41:14.142769 | controller | Skipping ansible.posix: no checked-out sibling
2026-06-17 20:41:14.142810 | controller | Skipping community.crypto: no checked-out sibling
2026-06-17 20:41:14.142844 | controller | Skipping community.general: no checked-out sibling
2026-06-17 20:41:14.142874 | controller | Skipping kubernetes.core: no checked-out sibling
2026-06-17 20:41:14.142903 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-06-17 20:41:14.145293 | 
2026-06-17 20:41:14.145358 | PLAY RECAP
2026-06-17 20:41:14.145420 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:41:14.145452 | 
2026-06-17 20:41:14.290838 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-17 20:41:14.293742 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-17 20:41:14.901172 | 
2026-06-17 20:41:14.901317 | PLAY [all]
2026-06-17 20:41:14.912290 | 
2026-06-17 20:41:14.912382 | TASK [Update apt cache]
2026-06-17 20:41:19.611426 | controller | ok
2026-06-17 20:41:19.618347 | 
2026-06-17 20:41:19.618528 | TASK [Disable firewalld]
2026-06-17 20:41:19.643913 | controller | skipping: Conditional result was False
2026-06-17 20:41:19.652290 | 
2026-06-17 20:41:19.652483 | TASK [Install "jq" for log collection]
2026-06-17 20:41:21.921129 | controller | changed
2026-06-17 20:41:21.928700 | 
2026-06-17 20:41:21.928750 | PLAY RECAP
2026-06-17 20:41:21.928795 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-17 20:41:21.928816 | 
2026-06-17 20:41:22.052466 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-17 20:41:22.054456 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-17 20:41:22.656152 | 
2026-06-17 20:41:22.656278 | PLAY [all]
2026-06-17 20:41:22.666062 | 
2026-06-17 20:41:22.666138 | LOOP [Check inventory directories]
2026-06-17 20:41:23.034792 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-06-17 20:41:23.207095 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory"
2026-06-17 20:41:23.400223 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory"
2026-06-17 20:41:23.421738 | 
2026-06-17 20:41:23.421906 | LOOP [Copy inventory file for Zuul]
2026-06-17 20:41:24.307298 | controller | changed:
2026-06-17 20:41:24.307518 | controller | {
2026-06-17 20:41:24.307560 | controller |   "ansible_loop_var": "item",
2026-06-17 20:41:24.307595 | controller |   "changed": false,
2026-06-17 20:41:24.307630 | controller |   "failed": false,
2026-06-17 20:41:24.307669 | controller |   "invocation": {
2026-06-17 20:41:24.307703 | controller |     "module_args": {
2026-06-17 20:41:24.307736 | controller |       "checksum_algorithm": "sha1",
2026-06-17 20:41:24.307776 | controller |       "follow": true,
2026-06-17 20:41:24.307817 | controller |       "get_attributes": true,
2026-06-17 20:41:24.307861 | controller |       "get_checksum": true,
2026-06-17 20:41:24.307893 | controller |       "get_mime": true,
2026-06-17 20:41:24.307922 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-06-17 20:41:24.307951 | controller |     }
2026-06-17 20:41:24.307979 | controller |   },
2026-06-17 20:41:24.308005 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-06-17 20:41:24.308032 | controller |   "stat": {
2026-06-17 20:41:24.308059 | controller |     "atime": 1781728868.4986842,
2026-06-17 20:41:24.308087 | controller |     "attr_flags": "e",
2026-06-17 20:41:24.308116 | controller |     "attributes": [
2026-06-17 20:41:24.308144 | controller |       "extents"
2026-06-17 20:41:24.308172 | controller |     ],
2026-06-17 20:41:24.308201 | controller |     "block_size": 4096,
2026-06-17 20:41:24.308228 | controller |     "blocks": 8,
2026-06-17 20:41:24.308257 | controller |     "charset": "unknown",
2026-06-17 20:41:24.308286 | controller |     "ctime": 1781728868.51845,
2026-06-17 20:41:24.308315 | controller |     "dev": 65025,
2026-06-17 20:41:24.308343 | controller |     "device_type": 0,
2026-06-17 20:41:24.308371 | controller |     "executable": true,
2026-06-17 20:41:24.308399 | controller |     "exists": true,
2026-06-17 20:41:24.308427 | controller |     "gid": 1000,
2026-06-17 20:41:24.308453 | controller |     "gr_name": "zuul",
2026-06-17 20:41:24.308478 | controller |     "inode": 519959,
2026-06-17 20:41:24.308504 | controller |     "isblk": false,
2026-06-17 20:41:24.308531 | controller |     "ischr": false,
2026-06-17 20:41:24.308558 | controller |     "isdir": true,
2026-06-17 20:41:24.308583 | controller |     "isfifo": false,
2026-06-17 20:41:24.308609 | controller |     "isgid": false,
2026-06-17 20:41:24.308635 | controller |     "islnk": false,
2026-06-17 20:41:24.308661 | controller |     "isreg": false,
2026-06-17 20:41:24.308686 | controller |     "issock": false,
2026-06-17 20:41:24.308711 | controller |     "isuid": false,
2026-06-17 20:41:24.308736 | controller |     "mimetype": "unknown",
2026-06-17 20:41:24.308761 | controller |     "mode": "0755",
2026-06-17 20:41:24.308787 | controller |     "mtime": 1781728849.2702038,
2026-06-17 20:41:24.308813 | controller |     "nlink": 14,
2026-06-17 20:41:24.308838 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-06-17 20:41:24.308864 | controller |     "pw_name": "zuul",
2026-06-17 20:41:24.308895 | controller |     "readable": true,
2026-06-17 20:41:24.308933 | controller |     "rgrp": true,
2026-06-17 20:41:24.308996 | controller |     "roth": true,
2026-06-17 20:41:24.309028 | controller |     "rusr": true,
2026-06-17 20:41:24.309062 | controller |     "size": 4096,
2026-06-17 20:41:24.309100 | controller |     "uid": 1000,
2026-06-17 20:41:24.309130 | controller |     "version": "406204501",
2026-06-17 20:41:24.309157 | controller |     "wgrp": false,
2026-06-17 20:41:24.309185 | controller |     "woth": false,
2026-06-17 20:41:24.309211 | controller |     "writeable": true,
2026-06-17 20:41:24.309236 | controller |     "wusr": true,
2026-06-17 20:41:24.309262 | controller |     "xgrp": true,
2026-06-17 20:41:24.309288 | controller |     "xoth": true,
2026-06-17 20:41:24.309314 | controller |     "xusr": true
2026-06-17 20:41:24.309340 | controller |   }
2026-06-17 20:41:24.309380 | controller | }
2026-06-17 20:41:24.309429 | controller | ok: All items complete
2026-06-17 20:41:24.309459 | 
2026-06-17 20:41:24.311253 | controller | skipping: Conditional result was False
2026-06-17 20:41:24.311949 | controller | skipping: Conditional result was False
2026-06-17 20:41:24.328594 | 
2026-06-17 20:41:24.328724 | LOOP [Switch "ansible_host" to private IP]
2026-06-17 20:41:24.715980 | controller | changed: 1 replacements made
2026-06-17 20:41:24.718574 | controller | skipping: Conditional result was False
2026-06-17 20:41:24.722422 | controller | skipping: Conditional result was False
2026-06-17 20:41:24.754161 | 
2026-06-17 20:41:24.754301 | TASK [Run Molecule scenario]
2026-06-17 20:41:25.219261 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-06-17 20:41:25.219374 | controller | Creating virtual environment at: .venv
2026-06-17 20:41:25.842618 | controller | Downloading cryptography (4.3MiB)
2026-06-17 20:41:25.842855 | controller | Downloading ansible-core (2.3MiB)
2026-06-17 20:41:25.844021 | controller | Downloading pygments (1.2MiB)
2026-06-17 20:41:26.003428 | controller |  Downloading cryptography
2026-06-17 20:41:26.046178 | controller |  Downloading pygments
2026-06-17 20:41:26.201360 | controller |  Downloading ansible-core
2026-06-17 20:41:26.246428 | controller | Installed 36 packages in 44ms
2026-06-17 20:41:26.922672 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-06-17 20:41:26.922731 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-06-17 20:41:27.784667 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-06-17 20:41:27.784718 | controller | INFO     default scenario not found, disabling shared state.
2026-06-17 20:41:27.784801 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-06-17 20:41:27.784864 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-06-17 20:41:52.522123 | controller | INFO     [helm > dependency] Executing
2026-06-17 20:41:52.522189 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-06-17 20:41:52.522366 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-06-17 20:41:52.522523 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-06-17 20:41:52.528525 | controller | INFO     [helm > cleanup] Executing
2026-06-17 20:41:52.528812 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:41:52.534207 | controller | INFO     [helm > destroy] Executing
2026-06-17 20:41:52.534235 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-06-17 20:41:52.534381 | controller | INFO     [helm > destroy] Executed: Successful
2026-06-17 20:41:52.539705 | controller | INFO     [helm > syntax] Executing
2026-06-17 20:41:53.448574 | controller |
2026-06-17 20:41:53.448882 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-06-17 20:41:53.521068 | controller | INFO     [helm > syntax] Executed: Successful
2026-06-17 20:41:53.533804 | controller | INFO     [helm > create] Executing
2026-06-17 20:41:53.535349 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:41:53.540861 | controller | INFO     [helm > prepare] Executing
2026-06-17 20:41:54.379536 | controller |
2026-06-17 20:41:54.379779 | controller | PLAY [Prepare] *****************************************************************
2026-06-17 20:41:54.379958 | controller |
2026-06-17 20:41:54.380158 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:41:54.380420 | controller | Wednesday 17 June 2026  20:41:54 +0000 (0:00:00.030)       0:00:00.030 ********
2026-06-17 20:41:55.653833 | 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 20:41:55.659708 | controller | ok: [controller]
2026-06-17 20:41:55.659870 | controller |
2026-06-17 20:41:55.660070 | controller | TASK [Install Debian packages] *************************************************
2026-06-17 20:41:55.660273 | controller | Wednesday 17 June 2026  20:41:55 +0000 (0:00:01.280)       0:00:01.311 ********
2026-06-17 20:41:57.231366 | controller | ok: [controller]
2026-06-17 20:41:57.231519 | controller |
2026-06-17 20:41:57.231819 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:41:57.232064 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:41:57.232238 | controller |
2026-06-17 20:41:57.232417 | controller |
2026-06-17 20:41:57.232612 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:41:57.232855 | controller | Wednesday 17 June 2026  20:41:57 +0000 (0:00:01.572)       0:00:02.883 ********
2026-06-17 20:41:57.233043 | controller | ===============================================================================
2026-06-17 20:41:57.233235 | controller | Install Debian packages ------------------------------------------------- 1.57s
2026-06-17 20:41:57.233429 | controller | Gathering Facts --------------------------------------------------------- 1.28s
2026-06-17 20:41:57.326890 | controller | INFO     [helm > prepare] Executed: Successful
2026-06-17 20:41:57.336406 | controller | INFO     [helm > converge] Executing
2026-06-17 20:41:58.193025 | controller |
2026-06-17 20:41:58.193244 | controller | PLAY [Converge] ****************************************************************
2026-06-17 20:41:58.193431 | controller |
2026-06-17 20:41:58.193647 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:41:58.193852 | controller | Wednesday 17 June 2026  20:41:58 +0000 (0:00:00.014)       0:00:00.014 ********
2026-06-17 20:41:59.235489 | 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 20:41:59.242382 | controller | ok: [controller]
2026-06-17 20:41:59.242394 | controller |
2026-06-17 20:41:59.242398 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-17 20:41:59.242402 | controller | Wednesday 17 June 2026  20:41:59 +0000 (0:00:01.047)       0:00:01.062 ********
2026-06-17 20:41:59.710275 | controller | ok: [controller]
2026-06-17 20:41:59.710468 | controller |
2026-06-17 20:41:59.710695 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-17 20:41:59.710907 | controller | Wednesday 17 June 2026  20:41:59 +0000 (0:00:00.469)       0:00:01.532 ********
2026-06-17 20:42:00.823597 | controller | ok: [controller]
2026-06-17 20:42:00.823774 | controller |
2026-06-17 20:42:00.823916 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-06-17 20:42:00.824061 | controller | Wednesday 17 June 2026  20:42:00 +0000 (0:00:01.113)       0:00:02.645 ********
2026-06-17 20:42:01.235244 | controller | changed: [controller]
2026-06-17 20:42:01.235399 | controller |
2026-06-17 20:42:01.235660 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:42:01.235975 | controller | Wednesday 17 June 2026  20:42:01 +0000 (0:00:00.411)       0:00:03.056 ********
2026-06-17 20:42:01.282253 | controller | ok: [controller] => {
2026-06-17 20:42:01.282587 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-06-17 20:42:01.282843 | controller | }
2026-06-17 20:42:01.283045 | controller |
2026-06-17 20:42:01.283266 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:42:01.283482 | controller | Wednesday 17 June 2026  20:42:01 +0000 (0:00:00.047)       0:00:03.103 ********
2026-06-17 20:42:02.234271 | 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 20:42:02.241369 | controller | changed: [controller]
2026-06-17 20:42:02.241543 | controller |
2026-06-17 20:42:02.241744 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:42:02.241937 | controller | Wednesday 17 June 2026  20:42:02 +0000 (0:00:00.959)       0:00:04.063 ********
2026-06-17 20:42:05.223893 | controller | changed: [controller]
2026-06-17 20:42:05.223988 | controller |
2026-06-17 20:42:05.224149 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-06-17 20:42:05.224288 | controller | Wednesday 17 June 2026  20:42:05 +0000 (0:00:02.982)       0:00:07.045 ********
2026-06-17 20:42:05.741316 | controller | ok: [controller]
2026-06-17 20:42:05.741505 | controller |
2026-06-17 20:42:05.741732 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-06-17 20:42:05.741999 | controller | Wednesday 17 June 2026  20:42:05 +0000 (0:00:00.517)       0:00:07.562 ********
2026-06-17 20:42:06.149606 | controller | changed: [controller]
2026-06-17 20:42:06.149755 | controller |
2026-06-17 20:42:06.149967 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-06-17 20:42:06.150395 | controller | Wednesday 17 June 2026  20:42:06 +0000 (0:00:00.408)       0:00:07.971 ********
2026-06-17 20:42:06.608084 | controller | ok: [controller]
2026-06-17 20:42:06.608222 | controller |
2026-06-17 20:42:06.608446 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-06-17 20:42:06.608640 | controller | Wednesday 17 June 2026  20:42:06 +0000 (0:00:00.458)       0:00:08.429 ********
2026-06-17 20:42:06.902645 | controller | changed: [controller]
2026-06-17 20:42:06.902701 | controller |
2026-06-17 20:42:06.902867 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-06-17 20:42:06.903005 | controller | Wednesday 17 June 2026  20:42:06 +0000 (0:00:00.294)       0:00:08.724 ********
2026-06-17 20:42:07.196877 | controller | ok: [controller]
2026-06-17 20:42:07.197066 | controller |
2026-06-17 20:42:07.197287 | controller | TASK [Install plugin] **********************************************************
2026-06-17 20:42:07.197503 | controller | Wednesday 17 June 2026  20:42:07 +0000 (0:00:00.293)       0:00:09.018 ********
2026-06-17 20:42:07.251492 | controller | included: vexxhost.containers.download_artifact for controller
2026-06-17 20:42:07.251758 | controller |
2026-06-17 20:42:07.252028 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:42:07.252264 | controller | Wednesday 17 June 2026  20:42:07 +0000 (0:00:00.055)       0:00:09.073 ********
2026-06-17 20:42:07.297443 | controller | ok: [controller] => {
2026-06-17 20:42:07.297716 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-06-17 20:42:07.297944 | controller | }
2026-06-17 20:42:07.298157 | controller |
2026-06-17 20:42:07.298405 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:42:07.298682 | controller | Wednesday 17 June 2026  20:42:07 +0000 (0:00:00.045)       0:00:09.119 ********
2026-06-17 20:42:08.155493 | controller | changed: [controller]
2026-06-17 20:42:08.155712 | controller |
2026-06-17 20:42:08.155930 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:42:08.156126 | controller | Wednesday 17 June 2026  20:42:08 +0000 (0:00:00.857)       0:00:09.976 ********
2026-06-17 20:42:10.217820 | controller | changed: [controller]
2026-06-17 20:42:10.217991 | controller |
2026-06-17 20:42:10.218194 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:42:10.218420 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:42:10.218601 | controller |
2026-06-17 20:42:10.218778 | controller |
2026-06-17 20:42:10.218966 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:42:10.219210 | controller | Wednesday 17 June 2026  20:42:10 +0000 (0:00:02.063)       0:00:12.040 ********
2026-06-17 20:42:10.219394 | controller | ===============================================================================
2026-06-17 20:42:10.219736 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.98s
2026-06-17 20:42:10.219969 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.06s
2026-06-17 20:42:10.220240 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.11s
2026-06-17 20:42:10.220426 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-06-17 20:42:10.220625 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.96s
2026-06-17 20:42:10.220825 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.86s
2026-06-17 20:42:10.221026 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s
2026-06-17 20:42:10.221224 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.47s
2026-06-17 20:42:10.221409 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s
2026-06-17 20:42:10.221617 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s
2026-06-17 20:42:10.221808 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s
2026-06-17 20:42:10.222019 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-06-17 20:42:10.222224 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s
2026-06-17 20:42:10.222416 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-06-17 20:42:10.222614 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:42:10.222810 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:42:10.325705 | controller | INFO     [helm > converge] Executed: Successful
2026-06-17 20:42:10.335197 | controller | INFO     [helm > idempotence] Executing
2026-06-17 20:42:11.174386 | controller |
2026-06-17 20:42:11.174594 | controller | PLAY [Converge] ****************************************************************
2026-06-17 20:42:11.174797 | controller |
2026-06-17 20:42:11.175068 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:42:11.175320 | controller | Wednesday 17 June 2026  20:42:11 +0000 (0:00:00.012)       0:00:00.012 ********
2026-06-17 20:42:12.222536 | 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 20:42:12.228703 | controller | ok: [controller]
2026-06-17 20:42:12.228810 | controller |
2026-06-17 20:42:12.228938 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-17 20:42:12.229106 | controller | Wednesday 17 June 2026  20:42:12 +0000 (0:00:01.053)       0:00:01.066 ********
2026-06-17 20:42:12.646776 | controller | ok: [controller]
2026-06-17 20:42:12.646966 | controller |
2026-06-17 20:42:12.647233 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-17 20:42:12.647488 | controller | Wednesday 17 June 2026  20:42:12 +0000 (0:00:00.418)       0:00:01.485 ********
2026-06-17 20:42:13.741607 | controller | ok: [controller]
2026-06-17 20:42:13.741802 | controller |
2026-06-17 20:42:13.742015 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-06-17 20:42:13.742243 | controller | Wednesday 17 June 2026  20:42:13 +0000 (0:00:01.094)       0:00:02.579 ********
2026-06-17 20:42:14.153758 | controller | ok: [controller]
2026-06-17 20:42:14.153855 | controller |
2026-06-17 20:42:14.154016 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:42:14.154144 | controller | Wednesday 17 June 2026  20:42:14 +0000 (0:00:00.411)       0:00:02.991 ********
2026-06-17 20:42:14.199116 | controller | ok: [controller] => {
2026-06-17 20:42:14.199266 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-06-17 20:42:14.199507 | controller | }
2026-06-17 20:42:14.199670 | controller |
2026-06-17 20:42:14.199856 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:42:14.200043 | controller | Wednesday 17 June 2026  20:42:14 +0000 (0:00:00.045)       0:00:03.036 ********
2026-06-17 20:42:14.727049 | controller | ok: [controller]
2026-06-17 20:42:14.727194 | controller |
2026-06-17 20:42:14.727432 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:42:14.727669 | controller | Wednesday 17 June 2026  20:42:14 +0000 (0:00:00.527)       0:00:03.564 ********
2026-06-17 20:42:17.383312 | controller | ok: [controller]
2026-06-17 20:42:17.383347 | controller |
2026-06-17 20:42:17.383359 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-06-17 20:42:17.383368 | controller | Wednesday 17 June 2026  20:42:17 +0000 (0:00:02.656)       0:00:06.220 ********
2026-06-17 20:42:17.891042 | controller | ok: [controller]
2026-06-17 20:42:17.891099 | controller |
2026-06-17 20:42:17.891114 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-06-17 20:42:17.891242 | controller | Wednesday 17 June 2026  20:42:17 +0000 (0:00:00.506)       0:00:06.727 ********
2026-06-17 20:42:18.280826 | controller | ok: [controller]
2026-06-17 20:42:18.280859 | controller |
2026-06-17 20:42:18.280869 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-06-17 20:42:18.280878 | controller | Wednesday 17 June 2026  20:42:18 +0000 (0:00:00.387)       0:00:07.114 ********
2026-06-17 20:42:18.724047 | controller | ok: [controller]
2026-06-17 20:42:18.726506 | controller |
2026-06-17 20:42:18.726526 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-06-17 20:42:18.726535 | controller | Wednesday 17 June 2026  20:42:18 +0000 (0:00:00.445)       0:00:07.560 ********
2026-06-17 20:42:19.012847 | controller | ok: [controller]
2026-06-17 20:42:19.012879 | controller |
2026-06-17 20:42:19.012889 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-06-17 20:42:19.012897 | controller | Wednesday 17 June 2026  20:42:19 +0000 (0:00:00.287)       0:00:07.847 ********
2026-06-17 20:42:19.323337 | controller | ok: [controller]
2026-06-17 20:42:19.323361 | controller |
2026-06-17 20:42:19.323367 | controller | TASK [Install plugin] **********************************************************
2026-06-17 20:42:19.323373 | controller | Wednesday 17 June 2026  20:42:19 +0000 (0:00:00.310)       0:00:08.158 ********
2026-06-17 20:42:19.372864 | controller | included: vexxhost.containers.download_artifact for controller
2026-06-17 20:42:19.372998 | controller |
2026-06-17 20:42:19.375336 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:42:19.375345 | controller | Wednesday 17 June 2026  20:42:19 +0000 (0:00:00.052)       0:00:08.211 ********
2026-06-17 20:42:19.417834 | controller | ok: [controller] => {
2026-06-17 20:42:19.417975 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-06-17 20:42:19.418089 | controller | }
2026-06-17 20:42:19.419692 | controller |
2026-06-17 20:42:19.419814 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:42:19.419930 | controller | Wednesday 17 June 2026  20:42:19 +0000 (0:00:00.044)       0:00:08.256 ********
2026-06-17 20:42:19.839544 | controller | ok: [controller]
2026-06-17 20:42:19.839623 | controller |
2026-06-17 20:42:19.839764 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:42:19.839885 | controller | Wednesday 17 June 2026  20:42:19 +0000 (0:00:00.421)       0:00:08.677 ********
2026-06-17 20:42:21.492194 | controller | ok: [controller]
2026-06-17 20:42:21.492229 | controller |
2026-06-17 20:42:21.492239 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:42:21.492248 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:42:21.492256 | controller |
2026-06-17 20:42:21.492263 | controller |
2026-06-17 20:42:21.492270 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:42:21.492278 | controller | Wednesday 17 June 2026  20:42:21 +0000 (0:00:01.648)       0:00:10.326 ********
2026-06-17 20:42:21.492285 | controller | ===============================================================================
2026-06-17 20:42:21.492292 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.66s
2026-06-17 20:42:21.492299 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.65s
2026-06-17 20:42:21.492306 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.09s
2026-06-17 20:42:21.492313 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-06-17 20:42:21.492320 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s
2026-06-17 20:42:21.492326 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s
2026-06-17 20:42:21.492333 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s
2026-06-17 20:42:21.492340 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s
2026-06-17 20:42:21.492349 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s
2026-06-17 20:42:21.492356 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s
2026-06-17 20:42:21.492373 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.39s
2026-06-17 20:42:21.492381 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s
2026-06-17 20:42:21.492388 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-06-17 20:42:21.492467 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-06-17 20:42:21.492749 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:42:21.493004 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:42:21.579372 | controller | INFO     [helm > idempotence] Executed: Successful
2026-06-17 20:42:21.588505 | controller | INFO     [helm > side_effect] Executing
2026-06-17 20:42:21.588973 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:42:21.594716 | controller | INFO     [helm > verify] Executing
2026-06-17 20:42:22.419008 | controller |
2026-06-17 20:42:22.419539 | controller | PLAY [Verify] ******************************************************************
2026-06-17 20:42:22.419914 | controller |
2026-06-17 20:42:22.420198 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:42:22.420478 | controller | Wednesday 17 June 2026  20:42:22 +0000 (0:00:00.009)       0:00:00.009 ********
2026-06-17 20:42:23.495868 | 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 20:42:23.502369 | controller | ok: [controller]
2026-06-17 20:42:23.502753 | controller |
2026-06-17 20:42:23.503082 | controller | TASK [Get the current Helm version] ********************************************
2026-06-17 20:42:23.503427 | controller | Wednesday 17 June 2026  20:42:23 +0000 (0:00:01.083)       0:00:01.093 ********
2026-06-17 20:42:23.961988 | controller | changed: [controller]
2026-06-17 20:42:23.962330 | controller |
2026-06-17 20:42:23.962620 | controller | TASK [Assert Helm version] *****************************************************
2026-06-17 20:42:23.962977 | controller | Wednesday 17 June 2026  20:42:23 +0000 (0:00:00.458)       0:00:01.551 ********
2026-06-17 20:42:23.996203 | controller | ok: [controller] => {
2026-06-17 20:42:23.996623 | controller |     "changed": false,
2026-06-17 20:42:23.996911 | controller |     "msg": "All assertions passed"
2026-06-17 20:42:23.997165 | controller | }
2026-06-17 20:42:23.997402 | controller |
2026-06-17 20:42:23.997653 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:42:23.997926 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:42:23.998161 | controller |
2026-06-17 20:42:23.998395 | controller |
2026-06-17 20:42:23.998642 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:42:23.999031 | controller | Wednesday 17 June 2026  20:42:23 +0000 (0:00:00.034)       0:00:01.586 ********
2026-06-17 20:42:23.999280 | controller | ===============================================================================
2026-06-17 20:42:23.999526 | controller | Gathering Facts --------------------------------------------------------- 1.08s
2026-06-17 20:42:23.999907 | controller | Get the current Helm version -------------------------------------------- 0.46s
2026-06-17 20:42:24.000168 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-06-17 20:42:24.106684 | controller | INFO     [helm > verify] Executed: Successful
2026-06-17 20:42:24.119827 | controller | INFO     [helm > cleanup] Executing
2026-06-17 20:42:24.120239 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:42:24.126602 | controller | INFO     [helm > destroy] Executing
2026-06-17 20:42:24.126731 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-06-17 20:42:24.126857 | controller | INFO     [helm > destroy] Executed: Successful
2026-06-17 20:42:24.127164 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-06-17 20:42:24.347104 | controller | ok: Runtime: 0:00:59.086268
2026-06-17 20:42:24.352518 | 
2026-06-17 20:42:24.352594 | PLAY RECAP
2026-06-17 20:42:24.352675 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:42:24.352711 | 
2026-06-17 20:42:24.487282 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-17 20:42:24.490520 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-17 20:42:25.121390 | 
2026-06-17 20:42:25.121566 | PLAY [all]
2026-06-17 20:42:25.134653 | 
2026-06-17 20:42:25.134799 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-06-17 20:42:25.542803 | controller | changed
2026-06-17 20:42:25.599606 | 
2026-06-17 20:42:25.599764 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-06-17 20:42:25.984540 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:42:25.984823 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:42:25.992077 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:42:25.993498 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:42:25.993515 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:42:25.995517 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:42:25.998407 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:42:25.999169 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:42:26.000390 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:42:26.000454 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:42:26.003361 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:42:26.004467 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:42:26.130858 | controller | ok: Runtime: 0:00:00.034042
2026-06-17 20:42:26.138007 | 
2026-06-17 20:42:26.138073 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-06-17 20:42:26.359039 | controller | changed
2026-06-17 20:42:26.364412 | 
2026-06-17 20:42:26.364510 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-06-17 20:42:26.609403 | controller | environment: line 5: kubectl: command not found
2026-06-17 20:42:26.611033 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:42:26.611283 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:42:26.612669 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:42:26.896040 | controller | ok: Runtime: 0:00:00.013153
2026-06-17 20:42:26.903282 | 
2026-06-17 20:42:26.903367 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-06-17 20:42:27.519763 | controller | changed:
2026-06-17 20:42:27.519976 | controller | created directory /var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/logs/controller
2026-06-17 20:42:27.520020 | controller | cd+++++++++ objects/
2026-06-17 20:42:27.520051 | controller | cd+++++++++ objects/cluster/
2026-06-17 20:42:27.520082 | controller | cd+++++++++ objects/namespaced/
2026-06-17 20:42:27.529237 | 
2026-06-17 20:42:27.529335 | TASK [gather-pod-logs : creating directory for pod logs]
2026-06-17 20:42:27.764559 | controller | changed
2026-06-17 20:42:27.770746 | 
2026-06-17 20:42:27.770879 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-06-17 20:42:28.007332 | controller | changed
2026-06-17 20:42:28.012793 | 
2026-06-17 20:42:28.012902 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-06-17 20:42:28.246322 | controller | environment: line 3: kubectl: command not found
2026-06-17 20:42:28.542314 | controller | ok: Runtime: 0:00:00.011413
2026-06-17 20:42:28.548302 | 
2026-06-17 20:42:28.548392 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-06-17 20:42:29.035404 | controller | changed:
2026-06-17 20:42:29.035704 | controller | cd+++++++++ pod-logs/
2026-06-17 20:42:29.035774 | controller | cd+++++++++ pod-logs/failed-pods/
2026-06-17 20:42:29.044354 | 
2026-06-17 20:42:29.044461 | LOOP [helm-release-status : creating directory for helm release status]
2026-06-17 20:42:29.270062 | controller | changed: "values"
2026-06-17 20:42:29.466464 | controller | changed: "releases"
2026-06-17 20:42:29.475196 | 
2026-06-17 20:42:29.475398 | TASK [helm-release-status : Gather get release status for helm charts]
2026-06-17 20:42:29.708003 | controller | /bin/bash: line 3: kubectl: command not found
2026-06-17 20:42:30.012349 | controller | ok: Runtime: 0:00:00.008070
2026-06-17 20:42:30.018054 | 
2026-06-17 20:42:30.018122 | TASK [helm-release-status : Downloads logs to executor]
2026-06-17 20:42:30.524873 | controller | changed:
2026-06-17 20:42:30.525260 | controller | cd+++++++++ helm/
2026-06-17 20:42:30.525301 | controller | cd+++++++++ helm/releases/
2026-06-17 20:42:30.525335 | controller | cd+++++++++ helm/values/
2026-06-17 20:42:30.531735 | 
2026-06-17 20:42:30.532751 | PLAY RECAP
2026-06-17 20:42:30.532815 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:42:30.532844 | 
2026-06-17 20:42:30.652993 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-17 20:42:30.655086 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-17 20:42:31.235350 | 
2026-06-17 20:42:31.235480 | PLAY [all]
2026-06-17 20:42:31.245356 | 
2026-06-17 20:42:31.245430 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-17 20:42:31.290080 | controller | skipping: Conditional result was False
2026-06-17 20:42:31.298940 | 
2026-06-17 20:42:31.299041 | TASK [fetch-output : Set log path for single node]
2026-06-17 20:42:31.338408 | controller | ok
2026-06-17 20:42:31.343976 | 
2026-06-17 20:42:31.344058 | LOOP [fetch-output : Ensure local output dirs]
2026-06-17 20:42:31.771530 | controller -> localhost | ok: "/var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/logs"
2026-06-17 20:42:31.995424 | controller -> localhost | changed: "/var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/artifacts"
2026-06-17 20:42:32.214725 | controller -> localhost | changed: "/var/lib/zuul/builds/9e272086935c48648490081a250ba8f5/work/docs"
2026-06-17 20:42:32.229759 | 
2026-06-17 20:42:32.229915 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-17 20:42:32.858511 | controller | changed: .d..t...... ./
2026-06-17 20:42:32.858748 | controller | changed: All items complete
2026-06-17 20:42:32.858790 | 
2026-06-17 20:42:33.293146 | controller | changed: .d..t...... ./
2026-06-17 20:42:33.733486 | controller | changed: .d..t...... ./
2026-06-17 20:42:33.752948 | 
2026-06-17 20:42:33.753322 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-17 20:42:34.209843 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006972
2026-06-17 20:42:34.462469 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006786
2026-06-17 20:42:34.480394 | 
2026-06-17 20:42:34.480496 | PLAY [all]
2026-06-17 20:42:34.485861 | 
2026-06-17 20:42:34.485928 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-17 20:42:34.929359 | controller | changed
2026-06-17 20:42:34.936576 | 
2026-06-17 20:42:34.936698 | PLAY RECAP
2026-06-17 20:42:34.936754 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-17 20:42:34.936780 | 
2026-06-17 20:42:35.103337 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-17 20:42:35.106281 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-06-17 20:42:35.750958 | 
2026-06-17 20:42:36.719617 | PLAY [localhost]
2026-06-17 20:42:36.735553 | 
2026-06-17 20:42:36.735738 | TASK [Generate Zuul manifest]
2026-06-17 20:42:36.755845 | localhost | ok
2026-06-17 20:42:36.775356 | 
2026-06-17 20:42:36.775538 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-17 20:42:37.596112 | localhost | changed
2026-06-17 20:42:37.612518 | 
2026-06-17 20:42:37.612706 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-17 20:42:37.643737 | localhost | ok
2026-06-17 20:42:37.658028 | 
2026-06-17 20:42:37.658167 | TASK [Upload logs]
2026-06-17 20:42:37.679835 | localhost | ok
2026-06-17 20:42:37.749916 | 
2026-06-17 20:42:37.750123 | TASK [Set zuul-log-path fact]
2026-06-17 20:42:37.771350 | localhost | ok
2026-06-17 20:42:37.785512 | 
2026-06-17 20:42:37.785654 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-17 20:42:37.818963 | localhost | ok
2026-06-17 20:42:37.830759 | 
2026-06-17 20:42:37.830925 | TASK [upload-logs : Create log directories]
2026-06-17 20:42:38.340115 | localhost | changed
2026-06-17 20:42:38.346960 | 
2026-06-17 20:42:38.347055 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-17 20:42:38.754965 | localhost -> localhost | ok: Runtime: 0:00:00.004960
2026-06-17 20:42:38.762154 | 
2026-06-17 20:42:38.762246 | TASK [upload-logs : Upload logs to log server]
2026-06-17 20:42:40.324535 | localhost | Output suppressed because no_log was given
2026-06-17 20:42:40.330234 | 
2026-06-17 20:42:40.330335 | LOOP [upload-logs : Compress console log and json output]
2026-06-17 20:42:40.378315 | localhost | skipping: Conditional result was False
2026-06-17 20:42:40.428876 | localhost | skipping: Conditional result was False
2026-06-17 20:42:40.445432 | 
2026-06-17 20:42:40.445588 | LOOP [upload-logs : Upload compressed console log and json output]
2026-06-17 20:42:40.489509 | localhost | skipping: Conditional result was False
2026-06-17 20:42:40.489929 | 
2026-06-17 20:42:40.493840 | localhost | skipping: Conditional result was False
2026-06-17 20:42:40.513114 | 
2026-06-17 20:42:40.513247 | LOOP [upload-logs : Upload console log and json output]