2026-07-06 14:00:04.554193 | Job console starting
2026-07-06 14:00:04.565339 | Updating git repos
2026-07-06 14:00:04.617730 | Cloning repos into workspace
2026-07-06 14:00:07.449505 | Restoring repo states
2026-07-06 14:00:07.462633 | Merging changes
2026-07-06 14:00:08.213235 | Checking out repos
2026-07-06 14:00:08.974102 | Preparing playbooks
2026-07-06 14:00:34.156315 | Running Ansible setup
2026-07-06 14:00:38.228780 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-06 14:00:38.948838 | 
2026-07-06 14:00:38.949163 | PLAY [localhost]
2026-07-06 14:00:38.960008 | 
2026-07-06 14:00:38.960146 | TASK [Gathering Facts]
2026-07-06 14:00:39.891388 | localhost | ok
2026-07-06 14:00:39.898222 | 
2026-07-06 14:00:39.898338 | TASK [Setup log path fact]
2026-07-06 14:00:39.919007 | localhost | ok
2026-07-06 14:00:39.934009 | 
2026-07-06 14:00:39.934140 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-06 14:00:39.964538 | localhost | ok
2026-07-06 14:00:39.973297 | 
2026-07-06 14:00:39.973437 | TASK [emit-job-header : Print job information]
2026-07-06 14:00:40.013992 | # Job Information
2026-07-06 14:00:40.014183 | Ansible Version: 2.16.18
2026-07-06 14:00:40.014229 | Job: ansible-collection-kubernetes-molecule-helm
2026-07-06 14:00:40.014262 | Pipeline: check
2026-07-06 14:00:40.014291 | Executor: 2d72f0692154
2026-07-06 14:00:40.014318 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/288
2026-07-06 14:00:40.014347 | Event ID: d1bb6e00-7942-11f1-88cb-b67e381e99bd
2026-07-06 14:00:40.018274 | 
2026-07-06 14:00:40.018377 | LOOP [emit-job-header : Print node information]
2026-07-06 14:00:40.104169 | localhost | ok:
2026-07-06 14:00:40.104468 | localhost | # Node Information
2026-07-06 14:00:40.104539 | localhost | Inventory Hostname: controller
2026-07-06 14:00:40.104591 | localhost | Hostname: np0000184170
2026-07-06 14:00:40.104638 | localhost | Username: zuul
2026-07-06 14:00:40.104692 | localhost | Distro: Debian 13.5
2026-07-06 14:00:40.104739 | localhost | Provider: yul1
2026-07-06 14:00:40.104799 | localhost | Region: ca-ymq-1
2026-07-06 14:00:40.104857 | localhost | Label: debian-trixie
2026-07-06 14:00:40.104912 | localhost | Product Name: OpenStack Nova
2026-07-06 14:00:40.104945 | localhost | Interface IP: 199.204.45.156
2026-07-06 14:00:40.115259 | 
2026-07-06 14:00:40.115422 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-06 14:00:40.566786 | localhost -> localhost | changed
2026-07-06 14:00:40.575539 | 
2026-07-06 14:00:40.575723 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-06 14:00:42.166578 | localhost -> localhost | changed
2026-07-06 14:00:42.174581 | 
2026-07-06 14:00:42.174654 | PLAY [all]
2026-07-06 14:00:42.182314 | 
2026-07-06 14:00:42.182421 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-06 14:00:42.419490 | controller -> localhost | ok
2026-07-06 14:00:42.426297 | 
2026-07-06 14:00:42.426392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-06 14:00:42.454424 | controller | ok
2026-07-06 14:00:42.468535 | controller | included: /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-06 14:00:42.474421 | 
2026-07-06 14:00:42.474576 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-06 14:00:43.334536 | controller -> localhost | Generating public/private rsa key pair.
2026-07-06 14:00:43.334740 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/00af381d9bec41f6861c9499b3c9cd09_id_rsa
2026-07-06 14:00:43.334774 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/00af381d9bec41f6861c9499b3c9cd09_id_rsa.pub
2026-07-06 14:00:43.334798 | controller -> localhost | The key fingerprint is:
2026-07-06 14:00:43.334820 | controller -> localhost | SHA256:rDOiG918jwjbVe/PzAcUmNSdtvz+rorcd406/3SNhDQ zuul-build-sshkey
2026-07-06 14:00:43.334858 | controller -> localhost | The key's randomart image is:
2026-07-06 14:00:43.334879 | controller -> localhost | +---[RSA 3072]----+
2026-07-06 14:00:43.334905 | controller -> localhost | |           ..+ ..|
2026-07-06 14:00:43.334926 | controller -> localhost | |            o oo.|
2026-07-06 14:00:43.334946 | controller -> localhost | |            E o..|
2026-07-06 14:00:43.334966 | controller -> localhost | |       .   . o.o |
2026-07-06 14:00:43.334987 | controller -> localhost | |        S . ... .|
2026-07-06 14:00:43.335006 | controller -> localhost | |   . o . . . ...o|
2026-07-06 14:00:43.335025 | controller -> localhost | |  . + * o   . .+=|
2026-07-06 14:00:43.335045 | controller -> localhost | |   o = * + +.+o.*|
2026-07-06 14:00:43.335069 | controller -> localhost | |  o.. o . + =BB*=|
2026-07-06 14:00:43.335092 | controller -> localhost | +----[SHA256]-----+
2026-07-06 14:00:43.335143 | controller -> localhost | ok: Runtime: 0:00:00.405920
2026-07-06 14:00:43.339366 | 
2026-07-06 14:00:43.339431 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-06 14:00:43.372479 | controller | ok
2026-07-06 14:00:43.383471 | controller | included: /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-06 14:00:43.642297 | 
2026-07-06 14:00:43.642440 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-06 14:00:43.668617 | controller | skipping: Conditional result was False
2026-07-06 14:00:43.674174 | 
2026-07-06 14:00:43.674309 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-06 14:00:44.276867 | controller | changed
2026-07-06 14:00:44.306960 | 
2026-07-06 14:00:44.307236 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-06 14:00:44.525263 | controller | ok
2026-07-06 14:00:44.532264 | 
2026-07-06 14:00:44.532365 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-06 14:00:45.154821 | controller | changed
2026-07-06 14:00:45.160176 | 
2026-07-06 14:00:45.160301 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-06 14:00:45.792316 | controller | changed
2026-07-06 14:00:45.797097 | 
2026-07-06 14:00:45.797179 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-06 14:00:45.813150 | controller | skipping: Conditional result was False
2026-07-06 14:00:45.820046 | 
2026-07-06 14:00:45.820176 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-06 14:00:46.209809 | controller -> localhost | changed
2026-07-06 14:00:46.223272 | 
2026-07-06 14:00:46.223438 | TASK [add-build-sshkey : Add back temp key]
2026-07-06 14:00:47.204317 | controller -> localhost | Identity added: /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/00af381d9bec41f6861c9499b3c9cd09_id_rsa (zuul-build-sshkey)
2026-07-06 14:00:47.204684 | controller -> localhost | ok: Runtime: 0:00:00.014056
2026-07-06 14:00:47.211359 | 
2026-07-06 14:00:47.211480 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-06 14:00:47.620138 | controller | ok
2026-07-06 14:00:47.627640 | 
2026-07-06 14:00:47.627801 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-06 14:00:47.672993 | controller | skipping: Conditional result was False
2026-07-06 14:00:47.686417 | 
2026-07-06 14:00:47.686586 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-06 14:00:48.092329 | controller | ok
2026-07-06 14:00:48.099756 | 
2026-07-06 14:00:48.099953 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-06 14:00:49.204915 | controller | Output suppressed because no_log was given
2026-07-06 14:00:49.213759 | 
2026-07-06 14:00:49.213878 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-06 14:00:49.466339 | controller | ok: "logs"
2026-07-06 14:00:49.466730 | controller | ok: All items complete
2026-07-06 14:00:49.466787 | 
2026-07-06 14:00:49.647254 | controller | ok: "artifacts"
2026-07-06 14:00:49.869057 | controller | ok: "docs"
2026-07-06 14:00:49.886144 | 
2026-07-06 14:00:49.886324 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-06 14:00:50.130589 | controller | changed: "logs"
2026-07-06 14:00:50.341754 | controller | changed: "artifacts"
2026-07-06 14:00:50.541287 | controller | changed: "docs"
2026-07-06 14:00:50.559985 | 
2026-07-06 14:00:50.560119 | PLAY RECAP
2026-07-06 14:00:50.560183 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-06 14:00:50.560224 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-06 14:00:50.560254 | 
2026-07-06 14:00:50.718078 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-06 14:00:50.720251 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-06 14:00:51.462344 | 
2026-07-06 14:00:51.664061 | PLAY [all]
2026-07-06 14:00:51.680413 | 
2026-07-06 14:00:51.680583 | TASK [setup-uv : Extract archive]
2026-07-06 14:00:54.410004 | controller | changed
2026-07-06 14:00:54.417962 | 
2026-07-06 14:00:54.418192 | TASK [setup-uv : Print version]
2026-07-06 14:00:54.804077 | controller | uv 0.8.13
2026-07-06 14:00:54.961781 | controller | ok: Runtime: 0:00:00.010376
2026-07-06 14:00:54.972393 | 
2026-07-06 14:00:54.972533 | TASK [Install Ansible collection siblings]
2026-07-06 14:00:55.439514 | controller | ok:
2026-07-06 14:00:55.439778 | controller | Skipping ansible.posix: no checked-out sibling
2026-07-06 14:00:55.439843 | controller | Skipping community.crypto: no checked-out sibling
2026-07-06 14:00:55.439895 | controller | Skipping community.general: no checked-out sibling
2026-07-06 14:00:55.439945 | controller | Skipping kubernetes.core: no checked-out sibling
2026-07-06 14:00:55.439993 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-07-06 14:00:55.442532 | 
2026-07-06 14:00:55.442584 | PLAY RECAP
2026-07-06 14:00:55.442634 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-06 14:00:55.442657 | 
2026-07-06 14:00:55.629111 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-06 14:00:55.631802 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-07-06 14:00:56.240024 | 
2026-07-06 14:00:56.240215 | PLAY [all]
2026-07-06 14:00:56.251361 | 
2026-07-06 14:00:56.251522 | TASK [Update apt cache]
2026-07-06 14:01:01.352066 | controller | ok
2026-07-06 14:01:01.405468 | 
2026-07-06 14:01:01.406976 | TASK [Disable firewalld]
2026-07-06 14:01:01.432819 | controller | skipping: Conditional result was False
2026-07-06 14:01:01.442962 | 
2026-07-06 14:01:01.443109 | TASK [Install "jq" for log collection]
2026-07-06 14:01:03.818160 | controller | changed
2026-07-06 14:01:03.820396 | 
2026-07-06 14:01:03.820454 | PLAY RECAP
2026-07-06 14:01:03.820502 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-06 14:01:03.820526 | 
2026-07-06 14:01:03.999491 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-07-06 14:01:04.002606 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-06 14:01:04.669826 | 
2026-07-06 14:01:04.669967 | PLAY [all]
2026-07-06 14:01:04.682875 | 
2026-07-06 14:01:04.682989 | LOOP [Check inventory directories]
2026-07-06 14:01:05.098054 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-07-06 14:01:05.287088 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory"
2026-07-06 14:01:05.468466 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory"
2026-07-06 14:01:05.488045 | 
2026-07-06 14:01:05.488328 | LOOP [Copy inventory file for Zuul]
2026-07-06 14:01:06.447801 | controller | changed:
2026-07-06 14:01:06.447991 | controller | {
2026-07-06 14:01:06.448021 | controller |   "ansible_loop_var": "item",
2026-07-06 14:01:06.448045 | controller |   "changed": false,
2026-07-06 14:01:06.448066 | controller |   "failed": false,
2026-07-06 14:01:06.448089 | controller |   "invocation": {
2026-07-06 14:01:06.448109 | controller |     "module_args": {
2026-07-06 14:01:06.448128 | controller |       "checksum_algorithm": "sha1",
2026-07-06 14:01:06.448147 | controller |       "follow": true,
2026-07-06 14:01:06.448165 | controller |       "get_attributes": true,
2026-07-06 14:01:06.448184 | controller |       "get_checksum": true,
2026-07-06 14:01:06.448202 | controller |       "get_mime": true,
2026-07-06 14:01:06.448220 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-07-06 14:01:06.448238 | controller |     }
2026-07-06 14:01:06.448256 | controller |   },
2026-07-06 14:01:06.448424 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-07-06 14:01:06.448454 | controller |   "stat": {
2026-07-06 14:01:06.448474 | controller |     "atime": 1783346449.0575156,
2026-07-06 14:01:06.448493 | controller |     "attr_flags": "e",
2026-07-06 14:01:06.448511 | controller |     "attributes": [
2026-07-06 14:01:06.448559 | controller |       "extents"
2026-07-06 14:01:06.448581 | controller |     ],
2026-07-06 14:01:06.448599 | controller |     "block_size": 4096,
2026-07-06 14:01:06.448616 | controller |     "blocks": 8,
2026-07-06 14:01:06.448634 | controller |     "charset": "unknown",
2026-07-06 14:01:06.448653 | controller |     "ctime": 1783346449.0815158,
2026-07-06 14:01:06.448671 | controller |     "dev": 65025,
2026-07-06 14:01:06.448689 | controller |     "device_type": 0,
2026-07-06 14:01:06.448706 | controller |     "executable": true,
2026-07-06 14:01:06.448724 | controller |     "exists": true,
2026-07-06 14:01:06.448741 | controller |     "gid": 1000,
2026-07-06 14:01:06.448758 | controller |     "gr_name": "zuul",
2026-07-06 14:01:06.448776 | controller |     "inode": 520215,
2026-07-06 14:01:06.448793 | controller |     "isblk": false,
2026-07-06 14:01:06.448811 | controller |     "ischr": false,
2026-07-06 14:01:06.448828 | controller |     "isdir": true,
2026-07-06 14:01:06.448846 | controller |     "isfifo": false,
2026-07-06 14:01:06.448863 | controller |     "isgid": false,
2026-07-06 14:01:06.448880 | controller |     "islnk": false,
2026-07-06 14:01:06.448904 | controller |     "isreg": false,
2026-07-06 14:01:06.448928 | controller |     "issock": false,
2026-07-06 14:01:06.448976 | controller |     "isuid": false,
2026-07-06 14:01:06.449003 | controller |     "mimetype": "unknown",
2026-07-06 14:01:06.449023 | controller |     "mode": "0755",
2026-07-06 14:01:06.449040 | controller |     "mtime": 1783346407.7630816,
2026-07-06 14:01:06.449057 | controller |     "nlink": 14,
2026-07-06 14:01:06.449075 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-07-06 14:01:06.449093 | controller |     "pw_name": "zuul",
2026-07-06 14:01:06.449110 | controller |     "readable": true,
2026-07-06 14:01:06.449128 | controller |     "rgrp": true,
2026-07-06 14:01:06.449146 | controller |     "roth": true,
2026-07-06 14:01:06.449170 | controller |     "rusr": true,
2026-07-06 14:01:06.449193 | controller |     "size": 4096,
2026-07-06 14:01:06.449212 | controller |     "uid": 1000,
2026-07-06 14:01:06.449230 | controller |     "version": "118666336",
2026-07-06 14:01:06.449248 | controller |     "wgrp": false,
2026-07-06 14:01:06.449267 | controller |     "woth": false,
2026-07-06 14:01:06.449285 | controller |     "writeable": true,
2026-07-06 14:01:06.449303 | controller |     "wusr": true,
2026-07-06 14:01:06.449323 | controller |     "xgrp": true,
2026-07-06 14:01:06.449346 | controller |     "xoth": true,
2026-07-06 14:01:06.449364 | controller |     "xusr": true
2026-07-06 14:01:06.449381 | controller |   }
2026-07-06 14:01:06.449407 | controller | }
2026-07-06 14:01:06.449448 | controller | ok: All items complete
2026-07-06 14:01:06.449470 | 
2026-07-06 14:01:06.450738 | controller | skipping: Conditional result was False
2026-07-06 14:01:06.453342 | controller | skipping: Conditional result was False
2026-07-06 14:01:06.470222 | 
2026-07-06 14:01:06.470411 | LOOP [Switch "ansible_host" to private IP]
2026-07-06 14:01:06.867036 | controller | changed: 1 replacements made
2026-07-06 14:01:06.869053 | controller | skipping: Conditional result was False
2026-07-06 14:01:06.869782 | controller | skipping: Conditional result was False
2026-07-06 14:01:06.882433 | 
2026-07-06 14:01:06.882674 | TASK [Run Molecule scenario]
2026-07-06 14:01:07.368437 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-07-06 14:01:07.368528 | controller | Creating virtual environment at: .venv
2026-07-06 14:01:07.801883 | controller | Downloading cryptography (4.3MiB)
2026-07-06 14:01:07.803924 | controller | Downloading ansible-core (2.3MiB)
2026-07-06 14:01:07.804147 | controller | Downloading pygments (1.2MiB)
2026-07-06 14:01:07.992981 | controller |  Downloading cryptography
2026-07-06 14:01:08.053425 | controller |  Downloading pygments
2026-07-06 14:01:08.227554 | controller |  Downloading ansible-core
2026-07-06 14:01:08.274024 | controller | Installed 36 packages in 45ms
2026-07-06 14:01:09.062295 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-07-06 14:01:09.062356 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-07-06 14:01:10.166957 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-07-06 14:01:10.167025 | controller | INFO     default scenario not found, disabling shared state.
2026-07-06 14:01:10.167256 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-07-06 14:01:10.167346 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-07-06 14:02:21.470591 | controller | INFO     [helm > dependency] Executing
2026-07-06 14:02:21.470819 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-07-06 14:02:21.471099 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-07-06 14:02:21.471262 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-07-06 14:02:21.477450 | controller | INFO     [helm > cleanup] Executing
2026-07-06 14:02:21.477744 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-06 14:02:21.483897 | controller | INFO     [helm > destroy] Executing
2026-07-06 14:02:21.483935 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-07-06 14:02:21.484023 | controller | INFO     [helm > destroy] Executed: Successful
2026-07-06 14:02:21.489731 | controller | INFO     [helm > syntax] Executing
2026-07-06 14:02:22.538913 | controller |
2026-07-06 14:02:22.539166 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-07-06 14:02:22.614915 | controller | INFO     [helm > syntax] Executed: Successful
2026-07-06 14:02:22.624442 | controller | INFO     [helm > create] Executing
2026-07-06 14:02:22.627038 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-06 14:02:22.633925 | controller | INFO     [helm > prepare] Executing
2026-07-06 14:02:23.574556 | controller |
2026-07-06 14:02:23.574762 | controller | PLAY [Prepare] *****************************************************************
2026-07-06 14:02:23.574813 | controller |
2026-07-06 14:02:23.574913 | controller | TASK [Gathering Facts] *********************************************************
2026-07-06 14:02:23.575074 | controller | Monday 06 July 2026  14:02:23 +0000 (0:00:00.033)       0:00:00.033 ***********
2026-07-06 14:02:24.856367 | 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-07-06 14:02:24.863649 | controller | ok: [controller]
2026-07-06 14:02:24.863732 | controller |
2026-07-06 14:02:24.863867 | controller | TASK [Install Debian packages] *************************************************
2026-07-06 14:02:24.864073 | controller | Monday 06 July 2026  14:02:24 +0000 (0:00:01.289)       0:00:01.322 ***********
2026-07-06 14:02:26.615232 | controller | ok: [controller]
2026-07-06 14:02:26.615513 | controller |
2026-07-06 14:02:26.615681 | controller | PLAY RECAP *********************************************************************
2026-07-06 14:02:26.615788 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-06 14:02:26.615913 | controller |
2026-07-06 14:02:26.616046 | controller |
2026-07-06 14:02:26.616173 | controller | TASKS RECAP ********************************************************************
2026-07-06 14:02:26.616354 | controller | Monday 06 July 2026  14:02:26 +0000 (0:00:01.752)       0:00:03.074 ***********
2026-07-06 14:02:26.616533 | controller | ===============================================================================
2026-07-06 14:02:26.616696 | controller | Install Debian packages ------------------------------------------------- 1.75s
2026-07-06 14:02:26.616853 | controller | Gathering Facts --------------------------------------------------------- 1.29s
2026-07-06 14:02:26.776738 | controller | INFO     [helm > prepare] Executed: Successful
2026-07-06 14:02:26.787372 | controller | INFO     [helm > converge] Executing
2026-07-06 14:02:27.720093 | controller |
2026-07-06 14:02:27.720170 | controller | PLAY [Converge] ****************************************************************
2026-07-06 14:02:27.720306 | controller |
2026-07-06 14:02:27.720448 | controller | TASK [Gathering Facts] *********************************************************
2026-07-06 14:02:27.720585 | controller | Monday 06 July 2026  14:02:27 +0000 (0:00:00.013)       0:00:00.013 ***********
2026-07-06 14:02:28.860725 | 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-07-06 14:02:28.866693 | controller | ok: [controller]
2026-07-06 14:02:28.866869 | controller |
2026-07-06 14:02:28.867080 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-07-06 14:02:28.867332 | controller | Monday 06 July 2026  14:02:28 +0000 (0:00:01.146)       0:00:01.160 ***********
2026-07-06 14:02:29.417835 | controller | ok: [controller]
2026-07-06 14:02:29.417874 | controller |
2026-07-06 14:02:29.417973 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-07-06 14:02:29.418124 | controller | Monday 06 July 2026  14:02:29 +0000 (0:00:00.551)       0:00:01.711 ***********
2026-07-06 14:02:30.612579 | controller | ok: [controller]
2026-07-06 14:02:30.612638 | controller |
2026-07-06 14:02:30.612757 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-07-06 14:02:30.612908 | controller | Monday 06 July 2026  14:02:30 +0000 (0:00:01.194)       0:00:02.906 ***********
2026-07-06 14:02:31.084219 | controller | changed: [controller]
2026-07-06 14:02:31.084425 | controller |
2026-07-06 14:02:31.084790 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-07-06 14:02:31.085142 | controller | Monday 06 July 2026  14:02:31 +0000 (0:00:00.471)       0:00:03.377 ***********
2026-07-06 14:02:31.128586 | controller | ok: [controller] => {
2026-07-06 14:02:31.128881 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-07-06 14:02:31.129121 | controller | }
2026-07-06 14:02:31.129335 | controller |
2026-07-06 14:02:31.129575 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-07-06 14:02:31.129817 | controller | Monday 06 July 2026  14:02:31 +0000 (0:00:00.044)       0:00:03.422 ***********
2026-07-06 14:02:32.300855 | 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-07-06 14:02:32.309307 | controller | changed: [controller]
2026-07-06 14:02:32.309467 | controller |
2026-07-06 14:02:32.309819 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-07-06 14:02:32.309969 | controller | Monday 06 July 2026  14:02:32 +0000 (0:00:01.180)       0:00:04.602 ***********
2026-07-06 14:02:34.416759 | controller | changed: [controller]
2026-07-06 14:02:34.416785 | controller |
2026-07-06 14:02:34.416795 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-07-06 14:02:34.416826 | controller | Monday 06 July 2026  14:02:34 +0000 (0:00:02.106)       0:00:06.709 ***********
2026-07-06 14:02:34.972229 | controller | ok: [controller]
2026-07-06 14:02:34.972410 | controller |
2026-07-06 14:02:34.972558 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-07-06 14:02:34.972692 | controller | Monday 06 July 2026  14:02:34 +0000 (0:00:00.556)       0:00:07.265 ***********
2026-07-06 14:02:35.422229 | controller | changed: [controller]
2026-07-06 14:02:35.422369 | controller |
2026-07-06 14:02:35.422528 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-07-06 14:02:35.422642 | controller | Monday 06 July 2026  14:02:35 +0000 (0:00:00.450)       0:00:07.715 ***********
2026-07-06 14:02:35.902330 | controller | ok: [controller]
2026-07-06 14:02:35.902432 | controller |
2026-07-06 14:02:35.902450 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-07-06 14:02:35.902589 | controller | Monday 06 July 2026  14:02:35 +0000 (0:00:00.479)       0:00:08.195 ***********
2026-07-06 14:02:36.219084 | controller | changed: [controller]
2026-07-06 14:02:36.219155 | controller |
2026-07-06 14:02:36.219212 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-07-06 14:02:36.219322 | controller | Monday 06 July 2026  14:02:36 +0000 (0:00:00.316)       0:00:08.512 ***********
2026-07-06 14:02:36.532918 | controller | ok: [controller]
2026-07-06 14:02:36.532951 | controller |
2026-07-06 14:02:36.532959 | controller | TASK [Install plugin] **********************************************************
2026-07-06 14:02:36.533089 | controller | Monday 06 July 2026  14:02:36 +0000 (0:00:00.313)       0:00:08.825 ***********
2026-07-06 14:02:36.587758 | controller | included: vexxhost.containers.download_artifact for controller
2026-07-06 14:02:36.587818 | controller |
2026-07-06 14:02:36.588688 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-07-06 14:02:36.588703 | controller | Monday 06 July 2026  14:02:36 +0000 (0:00:00.054)       0:00:08.879 ***********
2026-07-06 14:02:36.633980 | controller | ok: [controller] => {
2026-07-06 14:02:36.634005 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-07-06 14:02:36.634011 | controller | }
2026-07-06 14:02:36.634017 | controller |
2026-07-06 14:02:36.634022 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-07-06 14:02:36.634027 | controller | Monday 06 July 2026  14:02:36 +0000 (0:00:00.046)       0:00:08.925 ***********
2026-07-06 14:02:37.472720 | controller | changed: [controller]
2026-07-06 14:02:37.472772 | controller |
2026-07-06 14:02:37.473094 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-07-06 14:02:37.473118 | controller | Monday 06 July 2026  14:02:37 +0000 (0:00:00.840)       0:00:09.766 ***********
2026-07-06 14:02:39.591872 | controller | changed: [controller]
2026-07-06 14:02:39.592125 | controller |
2026-07-06 14:02:39.592369 | controller | PLAY RECAP *********************************************************************
2026-07-06 14:02:39.592609 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-06 14:02:39.592775 | controller |
2026-07-06 14:02:39.592988 | controller |
2026-07-06 14:02:39.593206 | controller | TASKS RECAP ********************************************************************
2026-07-06 14:02:39.593428 | controller | Monday 06 July 2026  14:02:39 +0000 (0:00:02.119)       0:00:11.886 ***********
2026-07-06 14:02:39.593648 | controller | ===============================================================================
2026-07-06 14:02:39.593774 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.12s
2026-07-06 14:02:39.593925 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.11s
2026-07-06 14:02:39.594047 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.19s
2026-07-06 14:02:39.594161 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.18s
2026-07-06 14:02:39.594272 | controller | Gathering Facts --------------------------------------------------------- 1.15s
2026-07-06 14:02:39.594387 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.84s
2026-07-06 14:02:39.594501 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s
2026-07-06 14:02:39.594613 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.55s
2026-07-06 14:02:39.594810 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s
2026-07-06 14:02:39.594952 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.47s
2026-07-06 14:02:39.595083 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.45s
2026-07-06 14:02:39.595203 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s
2026-07-06 14:02:39.595323 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s
2026-07-06 14:02:39.595436 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-07-06 14:02:39.595550 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-07-06 14:02:39.595662 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-07-06 14:02:39.711016 | controller | INFO     [helm > converge] Executed: Successful
2026-07-06 14:02:39.718918 | controller | INFO     [helm > idempotence] Executing
2026-07-06 14:02:40.786523 | controller |
2026-07-06 14:02:40.786546 | controller | PLAY [Converge] ****************************************************************
2026-07-06 14:02:40.786552 | controller |
2026-07-06 14:02:40.786556 | controller | TASK [Gathering Facts] *********************************************************
2026-07-06 14:02:40.786560 | controller | Monday 06 July 2026  14:02:40 +0000 (0:00:00.015)       0:00:00.015 ***********
2026-07-06 14:02:41.917401 | 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-07-06 14:02:41.921352 | controller | ok: [controller]
2026-07-06 14:02:41.921366 | controller |
2026-07-06 14:02:41.921372 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-07-06 14:02:41.921377 | controller | Monday 06 July 2026  14:02:41 +0000 (0:00:01.134)       0:00:01.150 ***********
2026-07-06 14:02:42.407657 | controller | ok: [controller]
2026-07-06 14:02:42.407800 | controller |
2026-07-06 14:02:42.407924 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-07-06 14:02:42.408042 | controller | Monday 06 July 2026  14:02:42 +0000 (0:00:00.486)       0:00:01.636 ***********
2026-07-06 14:02:43.584342 | controller | ok: [controller]
2026-07-06 14:02:43.584480 | controller |
2026-07-06 14:02:43.587533 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-07-06 14:02:43.587552 | controller | Monday 06 July 2026  14:02:43 +0000 (0:00:01.176)       0:00:02.813 ***********
2026-07-06 14:02:44.026440 | controller | ok: [controller]
2026-07-06 14:02:44.026582 | controller |
2026-07-06 14:02:44.026708 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-07-06 14:02:44.026829 | controller | Monday 06 July 2026  14:02:44 +0000 (0:00:00.441)       0:00:03.255 ***********
2026-07-06 14:02:44.068224 | controller | ok: [controller] => {
2026-07-06 14:02:44.068477 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-07-06 14:02:44.072433 | controller | }
2026-07-06 14:02:44.072452 | controller |
2026-07-06 14:02:44.072457 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-07-06 14:02:44.072462 | controller | Monday 06 July 2026  14:02:44 +0000 (0:00:00.041)       0:00:03.296 ***********
2026-07-06 14:02:44.652585 | controller | ok: [controller]
2026-07-06 14:02:44.652634 | controller |
2026-07-06 14:02:44.653069 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-07-06 14:02:44.653099 | controller | Monday 06 July 2026  14:02:44 +0000 (0:00:00.584)       0:00:03.881 ***********
2026-07-06 14:02:46.457405 | controller | ok: [controller]
2026-07-06 14:02:46.457474 | controller |
2026-07-06 14:02:46.457606 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-07-06 14:02:46.457765 | controller | Monday 06 July 2026  14:02:46 +0000 (0:00:01.802)       0:00:05.683 ***********
2026-07-06 14:02:47.005580 | controller | ok: [controller]
2026-07-06 14:02:47.005697 | controller |
2026-07-06 14:02:47.005907 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-07-06 14:02:47.006057 | controller | Monday 06 July 2026  14:02:47 +0000 (0:00:00.548)       0:00:06.232 ***********
2026-07-06 14:02:47.445804 | controller | ok: [controller]
2026-07-06 14:02:47.446270 | controller |
2026-07-06 14:02:47.446286 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-07-06 14:02:47.446293 | controller | Monday 06 July 2026  14:02:47 +0000 (0:00:00.441)       0:00:06.674 ***********
2026-07-06 14:02:47.945248 | controller | ok: [controller]
2026-07-06 14:02:47.945313 | controller |
2026-07-06 14:02:47.945397 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-07-06 14:02:47.945491 | controller | Monday 06 July 2026  14:02:47 +0000 (0:00:00.496)       0:00:07.170 ***********
2026-07-06 14:02:48.319836 | controller | ok: [controller]
2026-07-06 14:02:48.319952 | controller |
2026-07-06 14:02:48.320168 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-07-06 14:02:48.320325 | controller | Monday 06 July 2026  14:02:48 +0000 (0:00:00.377)       0:00:07.548 ***********
2026-07-06 14:02:48.665224 | controller | ok: [controller]
2026-07-06 14:02:48.665314 | controller |
2026-07-06 14:02:48.665390 | controller | TASK [Install plugin] **********************************************************
2026-07-06 14:02:48.665485 | controller | Monday 06 July 2026  14:02:48 +0000 (0:00:00.345)       0:00:07.894 ***********
2026-07-06 14:02:48.728451 | controller | included: vexxhost.containers.download_artifact for controller
2026-07-06 14:02:48.728506 | controller |
2026-07-06 14:02:48.728610 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-07-06 14:02:48.728707 | controller | Monday 06 July 2026  14:02:48 +0000 (0:00:00.060)       0:00:07.955 ***********
2026-07-06 14:02:48.770657 | controller | ok: [controller] => {
2026-07-06 14:02:48.770780 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-07-06 14:02:48.770888 | controller | }
2026-07-06 14:02:48.771054 | controller |
2026-07-06 14:02:48.771132 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-07-06 14:02:48.771275 | controller | Monday 06 July 2026  14:02:48 +0000 (0:00:00.044)       0:00:07.999 ***********
2026-07-06 14:02:49.244888 | controller | ok: [controller]
2026-07-06 14:02:49.244934 | controller |
2026-07-06 14:02:49.244941 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-07-06 14:02:49.244946 | controller | Monday 06 July 2026  14:02:49 +0000 (0:00:00.472)       0:00:08.471 ***********
2026-07-06 14:02:50.937412 | controller | ok: [controller]
2026-07-06 14:02:50.937464 | controller |
2026-07-06 14:02:50.937615 | controller | PLAY RECAP *********************************************************************
2026-07-06 14:02:50.937763 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-06 14:02:50.937902 | controller |
2026-07-06 14:02:50.937999 | controller |
2026-07-06 14:02:50.938124 | controller | TASKS RECAP ********************************************************************
2026-07-06 14:02:50.938252 | controller | Monday 06 July 2026  14:02:50 +0000 (0:00:01.691)       0:00:10.163 ***********
2026-07-06 14:02:50.938370 | controller | ===============================================================================
2026-07-06 14:02:50.938496 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.80s
2026-07-06 14:02:50.938620 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.69s
2026-07-06 14:02:50.938745 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.18s
2026-07-06 14:02:50.938867 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-07-06 14:02:50.938994 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.58s
2026-07-06 14:02:50.939122 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s
2026-07-06 14:02:50.939252 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.50s
2026-07-06 14:02:50.939417 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-07-06 14:02:50.939571 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.47s
2026-07-06 14:02:50.939697 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s
2026-07-06 14:02:50.939828 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s
2026-07-06 14:02:50.939964 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.38s
2026-07-06 14:02:50.940098 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.35s
2026-07-06 14:02:50.940227 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-07-06 14:02:50.940396 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-07-06 14:02:50.940605 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-07-06 14:02:51.056839 | controller | INFO     [helm > idempotence] Executed: Successful
2026-07-06 14:02:51.059962 | controller | INFO     [helm > side_effect] Executing
2026-07-06 14:02:51.060341 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-06 14:02:51.066416 | controller | INFO     [helm > verify] Executing
2026-07-06 14:02:52.063140 | controller |
2026-07-06 14:02:52.063366 | controller | PLAY [Verify] ******************************************************************
2026-07-06 14:02:52.063525 | controller |
2026-07-06 14:02:52.063690 | controller | TASK [Gathering Facts] *********************************************************
2026-07-06 14:02:52.063855 | controller | Monday 06 July 2026  14:02:52 +0000 (0:00:00.019)       0:00:00.019 ***********
2026-07-06 14:02:53.299641 | 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-07-06 14:02:53.306820 | controller | ok: [controller]
2026-07-06 14:02:53.306928 | controller |
2026-07-06 14:02:53.307072 | controller | TASK [Get the current Helm version] ********************************************
2026-07-06 14:02:53.307225 | controller | Monday 06 July 2026  14:02:53 +0000 (0:00:01.243)       0:00:01.263 ***********
2026-07-06 14:02:53.797915 | controller | changed: [controller]
2026-07-06 14:02:53.798001 | controller |
2026-07-06 14:02:53.798283 | controller | TASK [Assert Helm version] *****************************************************
2026-07-06 14:02:53.798447 | controller | Monday 06 July 2026  14:02:53 +0000 (0:00:00.490)       0:00:01.753 ***********
2026-07-06 14:02:53.827042 | controller | ok: [controller] => {
2026-07-06 14:02:53.827249 | controller |     "changed": false,
2026-07-06 14:02:53.827463 | controller |     "msg": "All assertions passed"
2026-07-06 14:02:53.827662 | controller | }
2026-07-06 14:02:53.827871 | controller |
2026-07-06 14:02:53.828057 | controller | PLAY RECAP *********************************************************************
2026-07-06 14:02:53.828297 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-06 14:02:53.828475 | controller |
2026-07-06 14:02:53.828654 | controller |
2026-07-06 14:02:53.828891 | controller | TASKS RECAP ********************************************************************
2026-07-06 14:02:53.829258 | controller | Monday 06 July 2026  14:02:53 +0000 (0:00:00.030)       0:00:01.783 ***********
2026-07-06 14:02:53.829451 | controller | ===============================================================================
2026-07-06 14:02:53.829677 | controller | Gathering Facts --------------------------------------------------------- 1.24s
2026-07-06 14:02:53.830282 | controller | Get the current Helm version -------------------------------------------- 0.49s
2026-07-06 14:02:53.830306 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-07-06 14:02:53.925950 | controller | INFO     [helm > verify] Executed: Successful
2026-07-06 14:02:53.931995 | controller | INFO     [helm > cleanup] Executing
2026-07-06 14:02:53.932392 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-06 14:02:53.940073 | controller | INFO     [helm > destroy] Executing
2026-07-06 14:02:53.940161 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-07-06 14:02:53.940227 | controller | INFO     [helm > destroy] Executed: Successful
2026-07-06 14:02:53.940498 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-07-06 14:02:54.189733 | controller | ok: Runtime: 0:01:46.743990
2026-07-06 14:02:54.195261 | 
2026-07-06 14:02:54.195451 | PLAY RECAP
2026-07-06 14:02:54.195521 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-06 14:02:54.195552 | 
2026-07-06 14:02:54.369236 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-06 14:02:54.372193 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-07-06 14:02:55.034012 | 
2026-07-06 14:02:55.034223 | PLAY [all]
2026-07-06 14:02:55.050569 | 
2026-07-06 14:02:55.050798 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-06 14:02:55.448750 | controller | changed
2026-07-06 14:02:55.454108 | 
2026-07-06 14:02:55.454247 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-06 14:02:55.877101 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-06 14:02:55.877699 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-06 14:02:55.885623 | controller | environment: line 1: kubectl: command not found
2026-07-06 14:02:55.888861 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-06 14:02:55.889623 | controller | environment: line 1: kubectl: command not found
2026-07-06 14:02:55.891279 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-06 14:02:55.894379 | controller | environment: line 1: kubectl: command not found
2026-07-06 14:02:55.894622 | controller | environment: line 1: kubectl: command not found
2026-07-06 14:02:55.894873 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-06 14:02:55.896017 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-06 14:02:55.900031 | controller | environment: line 1: kubectl: command not found
2026-07-06 14:02:55.901660 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-06 14:02:55.984216 | controller | ok: Runtime: 0:00:00.037789
2026-07-06 14:02:55.989172 | 
2026-07-06 14:02:55.989251 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-06 14:02:56.304102 | controller | changed
2026-07-06 14:02:56.308753 | 
2026-07-06 14:02:56.308843 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-06 14:02:56.590328 | controller | environment: line 5: kubectl: command not found
2026-07-06 14:02:56.591519 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-06 14:02:56.591717 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-06 14:02:56.592279 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-06 14:02:56.841251 | controller | ok: Runtime: 0:00:00.012155
2026-07-06 14:02:56.852542 | 
2026-07-06 14:02:56.852784 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-06 14:02:57.517844 | controller | changed:
2026-07-06 14:02:57.518078 | controller | created directory /var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/logs/controller
2026-07-06 14:02:57.518125 | controller | cd+++++++++ objects/
2026-07-06 14:02:57.518160 | controller | cd+++++++++ objects/cluster/
2026-07-06 14:02:57.518195 | controller | cd+++++++++ objects/namespaced/
2026-07-06 14:02:57.528690 | 
2026-07-06 14:02:57.528865 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-06 14:02:57.806416 | controller | changed
2026-07-06 14:02:57.811161 | 
2026-07-06 14:02:57.811282 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-06 14:02:58.087108 | controller | changed
2026-07-06 14:02:58.092322 | 
2026-07-06 14:02:58.092394 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-06 14:02:58.349369 | controller | environment: line 3: kubectl: command not found
2026-07-06 14:02:58.621491 | controller | ok: Runtime: 0:00:00.011133
2026-07-06 14:02:58.626548 | 
2026-07-06 14:02:58.626613 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-06 14:02:59.126461 | controller | changed:
2026-07-06 14:02:59.126698 | controller | cd+++++++++ pod-logs/
2026-07-06 14:02:59.126742 | controller | cd+++++++++ pod-logs/failed-pods/
2026-07-06 14:02:59.137368 | 
2026-07-06 14:02:59.137536 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-06 14:02:59.380582 | controller | changed: "values"
2026-07-06 14:02:59.601838 | controller | changed: "releases"
2026-07-06 14:02:59.609156 | 
2026-07-06 14:02:59.609290 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-06 14:02:59.860917 | controller | /bin/bash: line 3: kubectl: command not found
2026-07-06 14:03:00.136799 | controller | ok: Runtime: 0:00:00.009134
2026-07-06 14:03:00.142216 | 
2026-07-06 14:03:00.142322 | TASK [helm-release-status : Downloads logs to executor]
2026-07-06 14:03:00.661419 | controller | changed:
2026-07-06 14:03:00.661640 | controller | cd+++++++++ helm/
2026-07-06 14:03:00.661693 | controller | cd+++++++++ helm/releases/
2026-07-06 14:03:00.661730 | controller | cd+++++++++ helm/values/
2026-07-06 14:03:00.667596 | 
2026-07-06 14:03:00.667660 | PLAY RECAP
2026-07-06 14:03:00.667708 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-06 14:03:00.667729 | 
2026-07-06 14:03:00.821263 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-07-06 14:03:00.823435 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-06 14:03:01.483729 | 
2026-07-06 14:03:01.483915 | PLAY [all]
2026-07-06 14:03:01.495601 | 
2026-07-06 14:03:01.495746 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-06 14:03:01.540918 | controller | skipping: Conditional result was False
2026-07-06 14:03:01.548749 | 
2026-07-06 14:03:01.548885 | TASK [fetch-output : Set log path for single node]
2026-07-06 14:03:01.591481 | controller | ok
2026-07-06 14:03:01.598455 | 
2026-07-06 14:03:01.598525 | LOOP [fetch-output : Ensure local output dirs]
2026-07-06 14:03:02.024366 | controller -> localhost | ok: "/var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/logs"
2026-07-06 14:03:02.253048 | controller -> localhost | changed: "/var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/artifacts"
2026-07-06 14:03:02.479199 | controller -> localhost | changed: "/var/lib/zuul/builds/00af381d9bec41f6861c9499b3c9cd09/work/docs"
2026-07-06 14:03:02.494403 | 
2026-07-06 14:03:02.494612 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-06 14:03:03.144691 | controller | changed: .d..t...... ./
2026-07-06 14:03:03.145098 | controller | changed: All items complete
2026-07-06 14:03:03.145184 | 
2026-07-06 14:03:03.589947 | controller | changed: .d..t...... ./
2026-07-06 14:03:04.043881 | controller | changed: .d..t...... ./
2026-07-06 14:03:04.059577 | 
2026-07-06 14:03:04.059780 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-06 14:03:04.534476 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008237
2026-07-06 14:03:04.776665 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009010
2026-07-06 14:03:04.791684 | 
2026-07-06 14:03:04.791838 | PLAY [all]
2026-07-06 14:03:04.799038 | 
2026-07-06 14:03:04.799125 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-06 14:03:05.321594 | controller | changed
2026-07-06 14:03:05.327092 | 
2026-07-06 14:03:05.327166 | PLAY RECAP
2026-07-06 14:03:05.327227 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-06 14:03:05.327258 | 
2026-07-06 14:03:05.461524 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-06 14:03:05.464528 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-06 14:03:06.112931 | 
2026-07-06 14:03:06.113142 | PLAY [localhost]
2026-07-06 14:03:06.124448 | 
2026-07-06 14:03:06.124589 | TASK [Generate Zuul manifest]
2026-07-06 14:03:06.146558 | localhost | ok
2026-07-06 14:03:06.164805 | 
2026-07-06 14:03:06.165053 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-06 14:03:06.564801 | localhost | changed
2026-07-06 14:03:06.577759 | 
2026-07-06 14:03:06.577856 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-06 14:03:06.609609 | localhost | ok
2026-07-06 14:03:06.617809 | 
2026-07-06 14:03:06.617940 | TASK [Upload logs]
2026-07-06 14:03:06.639838 | localhost | ok
2026-07-06 14:03:06.698723 | 
2026-07-06 14:03:06.698878 | TASK [Set zuul-log-path fact]
2026-07-06 14:03:06.721542 | localhost | ok
2026-07-06 14:03:06.735045 | 
2026-07-06 14:03:06.735176 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-06 14:03:06.769260 | localhost | ok
2026-07-06 14:03:06.784786 | 
2026-07-06 14:03:06.785018 | TASK [upload-logs : Create log directories]
2026-07-06 14:03:07.204527 | localhost | changed
2026-07-06 14:03:07.215327 | 
2026-07-06 14:03:07.215542 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-06 14:03:07.666488 | localhost -> localhost | ok: Runtime: 0:00:00.004573
2026-07-06 14:03:07.672624 | 
2026-07-06 14:03:07.672716 | TASK [upload-logs : Upload logs to log server]
2026-07-06 14:03:08.170572 | localhost | Output suppressed because no_log was given
2026-07-06 14:03:08.175748 | 
2026-07-06 14:03:08.175846 | LOOP [upload-logs : Compress console log and json output]
2026-07-06 14:03:08.223645 | localhost | skipping: Conditional result was False
2026-07-06 14:03:08.273330 | localhost | skipping: Conditional result was False
2026-07-06 14:03:08.291938 | 
2026-07-06 14:03:08.292134 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-06 14:03:08.344309 | localhost | skipping: Conditional result was False
2026-07-06 14:03:08.344724 | 
2026-07-06 14:03:08.349737 | localhost | skipping: Conditional result was False
2026-07-06 14:03:08.366489 | 
2026-07-06 14:03:08.366631 | LOOP [upload-logs : Upload console log and json output]