2026-06-17 20:13:36.025394 | Job console starting
2026-06-17 20:13:36.077072 | Updating git repos
2026-06-17 20:13:36.159434 | Cloning repos into workspace
2026-06-17 20:13:36.425613 | Restoring repo states
2026-06-17 20:13:36.443490 | Merging changes
2026-06-17 20:13:40.631854 | Checking out repos
2026-06-17 20:13:42.017558 | Preparing playbooks
2026-06-17 20:13:57.846776 | Running Ansible setup
2026-06-17 20:14:02.276487 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-17 20:14:02.963728 | 
2026-06-17 20:14:02.963858 | PLAY [localhost]
2026-06-17 20:14:02.971681 | 
2026-06-17 20:14:02.971760 | TASK [Gathering Facts]
2026-06-17 20:14:03.894810 | localhost | ok
2026-06-17 20:14:03.904784 | 
2026-06-17 20:14:03.904892 | TASK [Setup log path fact]
2026-06-17 20:14:03.926490 | localhost | ok
2026-06-17 20:14:03.942677 | 
2026-06-17 20:14:03.942752 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-17 20:14:03.973059 | localhost | ok
2026-06-17 20:14:03.983181 | 
2026-06-17 20:14:03.983325 | TASK [emit-job-header : Print job information]
2026-06-17 20:14:04.024120 | # Job Information
2026-06-17 20:14:04.024338 | Ansible Version: 2.16.18
2026-06-17 20:14:04.024386 | Job: ansible-collection-kubernetes-molecule-helm
2026-06-17 20:14:04.024421 | Pipeline: check
2026-06-17 20:14:04.024452 | Executor: 2d72f0692154
2026-06-17 20:14:04.024481 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/284
2026-06-17 20:14:04.024517 | Event ID: d9a6f490-6a88-11f1-9017-12d25f9be681
2026-06-17 20:14:04.028844 | 
2026-06-17 20:14:04.028972 | LOOP [emit-job-header : Print node information]
2026-06-17 20:14:04.145021 | localhost | ok:
2026-06-17 20:14:04.145206 | localhost | # Node Information
2026-06-17 20:14:04.145236 | localhost | Inventory Hostname: controller
2026-06-17 20:14:04.145258 | localhost | Hostname: np0000181620
2026-06-17 20:14:04.145279 | localhost | Username: zuul
2026-06-17 20:14:04.145303 | localhost | Distro: Debian 13.5
2026-06-17 20:14:04.145323 | localhost | Provider: yul1
2026-06-17 20:14:04.145343 | localhost | Region: ca-ymq-1
2026-06-17 20:14:04.145362 | localhost | Label: debian-trixie
2026-06-17 20:14:04.145381 | localhost | Product Name: OpenStack Nova
2026-06-17 20:14:04.145400 | localhost | Interface IP: 199.204.45.109
2026-06-17 20:14:04.161033 | 
2026-06-17 20:14:04.161290 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-17 20:14:04.697649 | localhost -> localhost | changed
2026-06-17 20:14:04.713122 | 
2026-06-17 20:14:04.713278 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-17 20:14:05.638363 | localhost -> localhost | changed
2026-06-17 20:14:05.648909 | 
2026-06-17 20:14:05.648992 | PLAY [all]
2026-06-17 20:14:05.656332 | 
2026-06-17 20:14:05.656405 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-17 20:14:05.942496 | controller -> localhost | ok
2026-06-17 20:14:05.951341 | 
2026-06-17 20:14:05.951465 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-17 20:14:05.986185 | controller | ok
2026-06-17 20:14:06.002558 | controller | included: /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-17 20:14:06.007964 | 
2026-06-17 20:14:06.008071 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-17 20:14:07.719067 | controller -> localhost | Generating public/private rsa key pair.
2026-06-17 20:14:07.719307 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/18e74d0eeb1a437daaa7424cb6fb9405_id_rsa
2026-06-17 20:14:07.719356 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/18e74d0eeb1a437daaa7424cb6fb9405_id_rsa.pub
2026-06-17 20:14:07.719395 | controller -> localhost | The key fingerprint is:
2026-06-17 20:14:07.719482 | controller -> localhost | SHA256:9lHk+pd3tCXiLtMGB/y2gqT76WblT4iyyxykhOQ4FRg zuul-build-sshkey
2026-06-17 20:14:07.719533 | controller -> localhost | The key's randomart image is:
2026-06-17 20:14:07.719568 | controller -> localhost | +---[RSA 3072]----+
2026-06-17 20:14:07.719611 | controller -> localhost | |Eo.         .    |
2026-06-17 20:14:07.719651 | controller -> localhost | |.  .       o     |
2026-06-17 20:14:07.719693 | controller -> localhost | |  o      .  o    |
2026-06-17 20:14:07.719729 | controller -> localhost | | = .      oo     |
2026-06-17 20:14:07.719766 | controller -> localhost | |o o . . S oo. . o|
2026-06-17 20:14:07.719801 | controller -> localhost | | . . o ..oo=+. +o|
2026-06-17 20:14:07.719838 | controller -> localhost | |    . oo.+o=+.o.o|
2026-06-17 20:14:07.719875 | controller -> localhost | |     o.++.=o+. ..|
2026-06-17 20:14:07.719916 | controller -> localhost | |      *B+  *o    |
2026-06-17 20:14:07.719953 | controller -> localhost | +----[SHA256]-----+
2026-06-17 20:14:07.720025 | controller -> localhost | ok: Runtime: 0:00:01.259291
2026-06-17 20:14:07.726390 | 
2026-06-17 20:14:07.726510 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-17 20:14:07.759815 | controller | ok
2026-06-17 20:14:07.770414 | controller | included: /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-17 20:14:07.778111 | 
2026-06-17 20:14:07.778173 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-17 20:14:07.803235 | controller | skipping: Conditional result was False
2026-06-17 20:14:07.811605 | 
2026-06-17 20:14:07.811734 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-17 20:14:08.408185 | controller | changed
2026-06-17 20:14:11.288526 | 
2026-06-17 20:14:11.288813 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-17 20:14:11.513802 | controller | ok
2026-06-17 20:14:11.518550 | 
2026-06-17 20:14:11.518614 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-17 20:14:12.074404 | controller | changed
2026-06-17 20:14:12.078487 | 
2026-06-17 20:14:12.078551 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-17 20:14:12.636217 | controller | changed
2026-06-17 20:14:12.643099 | 
2026-06-17 20:14:12.643222 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-17 20:14:12.669463 | controller | skipping: Conditional result was False
2026-06-17 20:14:12.679506 | 
2026-06-17 20:14:12.679682 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-17 20:14:13.091298 | controller -> localhost | changed
2026-06-17 20:14:13.101470 | 
2026-06-17 20:14:13.101542 | TASK [add-build-sshkey : Add back temp key]
2026-06-17 20:14:13.697103 | controller -> localhost | Identity added: /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/18e74d0eeb1a437daaa7424cb6fb9405_id_rsa (zuul-build-sshkey)
2026-06-17 20:14:13.697306 | controller -> localhost | ok: Runtime: 0:00:00.016103
2026-06-17 20:14:13.702810 | 
2026-06-17 20:14:13.702904 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-17 20:14:14.081167 | controller | ok
2026-06-17 20:14:14.086533 | 
2026-06-17 20:14:14.086636 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-17 20:14:14.113688 | controller | skipping: Conditional result was False
2026-06-17 20:14:14.129517 | 
2026-06-17 20:14:14.129607 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-17 20:14:14.525473 | controller | ok
2026-06-17 20:14:14.532323 | 
2026-06-17 20:14:14.532457 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-17 20:14:15.603667 | controller | Output suppressed because no_log was given
2026-06-17 20:14:15.610480 | 
2026-06-17 20:14:15.610545 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-17 20:14:15.833221 | controller | ok: "logs"
2026-06-17 20:14:15.833530 | controller | ok: All items complete
2026-06-17 20:14:15.833563 | 
2026-06-17 20:14:16.014958 | controller | ok: "artifacts"
2026-06-17 20:14:16.205452 | controller | ok: "docs"
2026-06-17 20:14:16.223131 | 
2026-06-17 20:14:16.223280 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-17 20:14:16.438930 | controller | changed: "logs"
2026-06-17 20:14:16.640137 | controller | changed: "artifacts"
2026-06-17 20:14:16.835581 | controller | changed: "docs"
2026-06-17 20:14:16.853220 | 
2026-06-17 20:14:16.853359 | PLAY RECAP
2026-06-17 20:14:16.853412 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-17 20:14:16.853443 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:14:16.853467 | 
2026-06-17 20:14:17.026751 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-17 20:14:17.029558 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-17 20:14:17.670054 | 
2026-06-17 20:14:17.670338 | PLAY [all]
2026-06-17 20:14:17.683114 | 
2026-06-17 20:14:17.683199 | TASK [setup-uv : Extract archive]
2026-06-17 20:14:20.112495 | controller | changed
2026-06-17 20:14:20.117676 | 
2026-06-17 20:14:20.117784 | TASK [setup-uv : Print version]
2026-06-17 20:14:20.490822 | controller | uv 0.8.13
2026-06-17 20:14:20.648426 | controller | ok: Runtime: 0:00:00.013745
2026-06-17 20:14:20.658779 | 
2026-06-17 20:14:20.658872 | TASK [Install Ansible collection siblings]
2026-06-17 20:14:21.090201 | controller | ok:
2026-06-17 20:14:21.090696 | controller | Skipping ansible.posix: no checked-out sibling
2026-06-17 20:14:21.090749 | controller | Skipping community.crypto: no checked-out sibling
2026-06-17 20:14:21.090796 | controller | Skipping community.general: no checked-out sibling
2026-06-17 20:14:21.090836 | controller | Skipping kubernetes.core: no checked-out sibling
2026-06-17 20:14:21.090865 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-06-17 20:14:21.093939 | 
2026-06-17 20:14:21.094013 | PLAY RECAP
2026-06-17 20:14:21.094089 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:14:21.094125 | 
2026-06-17 20:14:21.248239 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-17 20:14:21.251110 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-17 20:14:21.906026 | 
2026-06-17 20:14:21.906213 | PLAY [all]
2026-06-17 20:14:21.918067 | 
2026-06-17 20:14:21.918215 | TASK [Update apt cache]
2026-06-17 20:14:26.679636 | controller | ok
2026-06-17 20:14:26.686010 | 
2026-06-17 20:14:26.686466 | TASK [Disable firewalld]
2026-06-17 20:14:26.712219 | controller | skipping: Conditional result was False
2026-06-17 20:14:26.720414 | 
2026-06-17 20:14:26.720508 | TASK [Install "jq" for log collection]
2026-06-17 20:14:29.009258 | controller | changed
2026-06-17 20:14:29.013176 | 
2026-06-17 20:14:29.013227 | PLAY RECAP
2026-06-17 20:14:29.013275 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-17 20:14:29.013298 | 
2026-06-17 20:14:29.195718 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-17 20:14:29.197954 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-17 20:14:29.834831 | 
2026-06-17 20:14:29.834955 | PLAY [all]
2026-06-17 20:14:29.844664 | 
2026-06-17 20:14:29.844736 | LOOP [Check inventory directories]
2026-06-17 20:14:30.222372 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-06-17 20:14:30.401378 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory"
2026-06-17 20:14:30.584423 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory"
2026-06-17 20:14:30.601277 | 
2026-06-17 20:14:30.601448 | LOOP [Copy inventory file for Zuul]
2026-06-17 20:14:31.498586 | controller | changed:
2026-06-17 20:14:31.498848 | controller | {
2026-06-17 20:14:31.498902 | controller |   "ansible_loop_var": "item",
2026-06-17 20:14:31.498933 | controller |   "changed": false,
2026-06-17 20:14:31.498960 | controller |   "failed": false,
2026-06-17 20:14:31.498998 | controller |   "invocation": {
2026-06-17 20:14:31.499023 | controller |     "module_args": {
2026-06-17 20:14:31.499046 | controller |       "checksum_algorithm": "sha1",
2026-06-17 20:14:31.499068 | controller |       "follow": true,
2026-06-17 20:14:31.499091 | controller |       "get_attributes": true,
2026-06-17 20:14:31.499114 | controller |       "get_checksum": true,
2026-06-17 20:14:31.499136 | controller |       "get_mime": true,
2026-06-17 20:14:31.499158 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-06-17 20:14:31.499180 | controller |     }
2026-06-17 20:14:31.499202 | controller |   },
2026-06-17 20:14:31.499223 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-06-17 20:14:31.499245 | controller |   "stat": {
2026-06-17 20:14:31.499267 | controller |     "atime": 1781727255.4647236,
2026-06-17 20:14:31.499289 | controller |     "attr_flags": "e",
2026-06-17 20:14:31.499311 | controller |     "attributes": [
2026-06-17 20:14:31.499333 | controller |       "extents"
2026-06-17 20:14:31.499354 | controller |     ],
2026-06-17 20:14:31.499376 | controller |     "block_size": 4096,
2026-06-17 20:14:31.499397 | controller |     "blocks": 8,
2026-06-17 20:14:31.499421 | controller |     "charset": "unknown",
2026-06-17 20:14:31.499446 | controller |     "ctime": 1781727255.488675,
2026-06-17 20:14:31.499468 | controller |     "dev": 65025,
2026-06-17 20:14:31.499490 | controller |     "device_type": 0,
2026-06-17 20:14:31.499512 | controller |     "executable": true,
2026-06-17 20:14:31.499533 | controller |     "exists": true,
2026-06-17 20:14:31.499554 | controller |     "gid": 1000,
2026-06-17 20:14:31.499576 | controller |     "gr_name": "zuul",
2026-06-17 20:14:31.499597 | controller |     "inode": 519959,
2026-06-17 20:14:31.499619 | controller |     "isblk": false,
2026-06-17 20:14:31.499641 | controller |     "ischr": false,
2026-06-17 20:14:31.499664 | controller |     "isdir": true,
2026-06-17 20:14:31.499686 | controller |     "isfifo": false,
2026-06-17 20:14:31.499708 | controller |     "isgid": false,
2026-06-17 20:14:31.499729 | controller |     "islnk": false,
2026-06-17 20:14:31.499751 | controller |     "isreg": false,
2026-06-17 20:14:31.499772 | controller |     "issock": false,
2026-06-17 20:14:31.499793 | controller |     "isuid": false,
2026-06-17 20:14:31.499815 | controller |     "mimetype": "unknown",
2026-06-17 20:14:31.499836 | controller |     "mode": "0755",
2026-06-17 20:14:31.499857 | controller |     "mtime": 1781727220.0852954,
2026-06-17 20:14:31.499878 | controller |     "nlink": 14,
2026-06-17 20:14:31.499899 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-06-17 20:14:31.499921 | controller |     "pw_name": "zuul",
2026-06-17 20:14:31.499947 | controller |     "readable": true,
2026-06-17 20:14:31.499969 | controller |     "rgrp": true,
2026-06-17 20:14:31.499991 | controller |     "roth": true,
2026-06-17 20:14:31.500013 | controller |     "rusr": true,
2026-06-17 20:14:31.500035 | controller |     "size": 4096,
2026-06-17 20:14:31.500058 | controller |     "uid": 1000,
2026-06-17 20:14:31.500080 | controller |     "version": "3856090659",
2026-06-17 20:14:31.500102 | controller |     "wgrp": false,
2026-06-17 20:14:31.500125 | controller |     "woth": false,
2026-06-17 20:14:31.500148 | controller |     "writeable": true,
2026-06-17 20:14:31.500170 | controller |     "wusr": true,
2026-06-17 20:14:31.500266 | controller |     "xgrp": true,
2026-06-17 20:14:31.500295 | controller |     "xoth": true,
2026-06-17 20:14:31.500319 | controller |     "xusr": true
2026-06-17 20:14:31.500341 | controller |   }
2026-06-17 20:14:31.500481 | controller | }
2026-06-17 20:14:31.500533 | controller | ok: All items complete
2026-06-17 20:14:31.500556 | 
2026-06-17 20:14:31.501928 | controller | skipping: Conditional result was False
2026-06-17 20:14:31.503808 | controller | skipping: Conditional result was False
2026-06-17 20:14:31.519664 | 
2026-06-17 20:14:31.519850 | LOOP [Switch "ansible_host" to private IP]
2026-06-17 20:14:31.903524 | controller | changed: 1 replacements made
2026-06-17 20:14:31.905461 | controller | skipping: Conditional result was False
2026-06-17 20:14:31.906423 | controller | skipping: Conditional result was False
2026-06-17 20:14:31.925131 | 
2026-06-17 20:14:31.925273 | TASK [Run Molecule scenario]
2026-06-17 20:14:32.387192 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-06-17 20:14:32.387323 | controller | Creating virtual environment at: .venv
2026-06-17 20:14:32.682116 | controller | Downloading ansible-core (2.3MiB)
2026-06-17 20:14:32.682709 | controller | Downloading pygments (1.2MiB)
2026-06-17 20:14:32.683116 | controller | Downloading cryptography (4.3MiB)
2026-06-17 20:14:32.867109 | controller |  Downloading cryptography
2026-06-17 20:14:32.908947 | controller |  Downloading pygments
2026-06-17 20:14:33.089330 | controller |  Downloading ansible-core
2026-06-17 20:14:33.140211 | controller | Installed 36 packages in 50ms
2026-06-17 20:14:33.811718 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-06-17 20:14:33.811805 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-06-17 20:14:34.674155 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-06-17 20:14:34.674245 | controller | INFO     default scenario not found, disabling shared state.
2026-06-17 20:14:34.674291 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-06-17 20:14:34.674307 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-06-17 20:14:57.219287 | controller | INFO     [helm > dependency] Executing
2026-06-17 20:14:57.219927 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-06-17 20:14:57.219940 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-06-17 20:14:57.219979 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-06-17 20:14:57.219987 | controller | INFO     [helm > cleanup] Executing
2026-06-17 20:14:57.220197 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:14:57.225529 | controller | INFO     [helm > destroy] Executing
2026-06-17 20:14:57.225586 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-06-17 20:14:57.225679 | controller | INFO     [helm > destroy] Executed: Successful
2026-06-17 20:14:57.230950 | controller | INFO     [helm > syntax] Executing
2026-06-17 20:14:58.174776 | controller |
2026-06-17 20:14:58.175010 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-06-17 20:14:58.233535 | controller | INFO     [helm > syntax] Executed: Successful
2026-06-17 20:14:58.244436 | controller | INFO     [helm > create] Executing
2026-06-17 20:14:58.245951 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:14:58.251584 | controller | INFO     [helm > prepare] Executing
2026-06-17 20:14:59.127277 | controller |
2026-06-17 20:14:59.127385 | controller | PLAY [Prepare] *****************************************************************
2026-06-17 20:14:59.127569 | controller |
2026-06-17 20:14:59.127796 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:14:59.127944 | controller | Wednesday 17 June 2026  20:14:59 +0000 (0:00:00.035)       0:00:00.035 ********
2026-06-17 20:15:00.388934 | 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:15:00.394847 | controller | ok: [controller]
2026-06-17 20:15:00.394989 | controller |
2026-06-17 20:15:00.395163 | controller | TASK [Install Debian packages] *************************************************
2026-06-17 20:15:00.395325 | controller | Wednesday 17 June 2026  20:15:00 +0000 (0:00:01.268)       0:00:01.304 ********
2026-06-17 20:15:01.985850 | controller | ok: [controller]
2026-06-17 20:15:01.986003 | controller |
2026-06-17 20:15:01.986189 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:15:01.986394 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:15:01.986558 | controller |
2026-06-17 20:15:01.986723 | controller |
2026-06-17 20:15:01.986891 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:15:01.987075 | controller | Wednesday 17 June 2026  20:15:01 +0000 (0:00:01.591)       0:00:02.895 ********
2026-06-17 20:15:01.987269 | controller | ===============================================================================
2026-06-17 20:15:01.987452 | controller | Install Debian packages ------------------------------------------------- 1.59s
2026-06-17 20:15:01.987630 | controller | Gathering Facts --------------------------------------------------------- 1.27s
2026-06-17 20:15:02.068590 | controller | INFO     [helm > prepare] Executed: Successful
2026-06-17 20:15:02.078246 | controller | INFO     [helm > converge] Executing
2026-06-17 20:15:02.965326 | controller |
2026-06-17 20:15:02.965383 | controller | PLAY [Converge] ****************************************************************
2026-06-17 20:15:02.965390 | controller |
2026-06-17 20:15:02.965507 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:15:02.965595 | controller | Wednesday 17 June 2026  20:15:02 +0000 (0:00:00.019)       0:00:00.019 ********
2026-06-17 20:15:05.034398 | 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:15:05.038631 | controller | ok: [controller]
2026-06-17 20:15:05.038908 | controller |
2026-06-17 20:15:05.039162 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-17 20:15:05.039371 | controller | Wednesday 17 June 2026  20:15:05 +0000 (0:00:02.073)       0:00:02.092 ********
2026-06-17 20:15:05.558240 | controller | ok: [controller]
2026-06-17 20:15:05.558317 | controller |
2026-06-17 20:15:05.558469 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-17 20:15:05.558599 | controller | Wednesday 17 June 2026  20:15:05 +0000 (0:00:00.519)       0:00:02.612 ********
2026-06-17 20:15:06.741339 | controller | ok: [controller]
2026-06-17 20:15:06.741366 | controller |
2026-06-17 20:15:06.741371 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-06-17 20:15:06.741377 | controller | Wednesday 17 June 2026  20:15:06 +0000 (0:00:01.181)       0:00:03.793 ********
2026-06-17 20:15:07.170792 | controller | changed: [controller]
2026-06-17 20:15:07.170947 | controller |
2026-06-17 20:15:07.171154 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:15:07.171349 | controller | Wednesday 17 June 2026  20:15:07 +0000 (0:00:00.430)       0:00:04.224 ********
2026-06-17 20:15:07.222297 | controller | ok: [controller] => {
2026-06-17 20:15:07.222526 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-06-17 20:15:07.222721 | controller | }
2026-06-17 20:15:07.222901 | controller |
2026-06-17 20:15:07.223104 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:15:07.223298 | controller | Wednesday 17 June 2026  20:15:07 +0000 (0:00:00.051)       0:00:04.275 ********
2026-06-17 20:15:08.208446 | 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:15:08.217768 | controller | changed: [controller]
2026-06-17 20:15:08.217882 | controller |
2026-06-17 20:15:08.218022 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:15:08.218148 | controller | Wednesday 17 June 2026  20:15:08 +0000 (0:00:00.996)       0:00:05.271 ********
2026-06-17 20:15:10.289941 | controller | changed: [controller]
2026-06-17 20:15:10.290074 | controller |
2026-06-17 20:15:10.290368 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-06-17 20:15:10.290467 | controller | Wednesday 17 June 2026  20:15:10 +0000 (0:00:02.072)       0:00:07.343 ********
2026-06-17 20:15:10.805033 | controller | ok: [controller]
2026-06-17 20:15:10.805110 | controller |
2026-06-17 20:15:10.805213 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-06-17 20:15:10.805349 | controller | Wednesday 17 June 2026  20:15:10 +0000 (0:00:00.514)       0:00:07.858 ********
2026-06-17 20:15:11.206554 | controller | changed: [controller]
2026-06-17 20:15:11.206657 | controller |
2026-06-17 20:15:11.206852 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-06-17 20:15:11.207054 | controller | Wednesday 17 June 2026  20:15:11 +0000 (0:00:00.401)       0:00:08.260 ********
2026-06-17 20:15:11.651576 | controller | ok: [controller]
2026-06-17 20:15:11.651763 | controller |
2026-06-17 20:15:11.651972 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-06-17 20:15:11.652165 | controller | Wednesday 17 June 2026  20:15:11 +0000 (0:00:00.444)       0:00:08.704 ********
2026-06-17 20:15:11.948330 | controller | changed: [controller]
2026-06-17 20:15:11.948430 | controller |
2026-06-17 20:15:11.948676 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-06-17 20:15:11.948892 | controller | Wednesday 17 June 2026  20:15:11 +0000 (0:00:00.297)       0:00:09.001 ********
2026-06-17 20:15:12.250179 | controller | ok: [controller]
2026-06-17 20:15:12.250273 | controller |
2026-06-17 20:15:12.250460 | controller | TASK [Install plugin] **********************************************************
2026-06-17 20:15:12.250679 | controller | Wednesday 17 June 2026  20:15:12 +0000 (0:00:00.302)       0:00:09.304 ********
2026-06-17 20:15:12.295341 | controller | included: vexxhost.containers.download_artifact for controller
2026-06-17 20:15:12.295414 | controller |
2026-06-17 20:15:12.295621 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:15:12.295878 | controller | Wednesday 17 June 2026  20:15:12 +0000 (0:00:00.045)       0:00:09.349 ********
2026-06-17 20:15:12.339205 | controller | ok: [controller] => {
2026-06-17 20:15:12.339294 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-06-17 20:15:12.339465 | controller | }
2026-06-17 20:15:12.339631 | controller |
2026-06-17 20:15:12.339870 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:15:12.340055 | controller | Wednesday 17 June 2026  20:15:12 +0000 (0:00:00.043)       0:00:09.393 ********
2026-06-17 20:15:13.100317 | controller | changed: [controller]
2026-06-17 20:15:13.100452 | controller |
2026-06-17 20:15:13.100657 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:15:13.100849 | controller | Wednesday 17 June 2026  20:15:13 +0000 (0:00:00.760)       0:00:10.154 ********
2026-06-17 20:15:15.159730 | controller | changed: [controller]
2026-06-17 20:15:15.159767 | controller |
2026-06-17 20:15:15.159776 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:15:15.159786 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:15:15.159794 | controller |
2026-06-17 20:15:15.159802 | controller |
2026-06-17 20:15:15.159809 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:15:15.159816 | controller | Wednesday 17 June 2026  20:15:15 +0000 (0:00:02.057)       0:00:12.211 ********
2026-06-17 20:15:15.159824 | controller | ===============================================================================
2026-06-17 20:15:15.159831 | controller | Gathering Facts --------------------------------------------------------- 2.07s
2026-06-17 20:15:15.159838 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.07s
2026-06-17 20:15:15.159873 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.06s
2026-06-17 20:15:15.159883 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.18s
2026-06-17 20:15:15.159892 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.00s
2026-06-17 20:15:15.159900 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-06-17 20:15:15.159907 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.52s
2026-06-17 20:15:15.159914 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s
2026-06-17 20:15:15.159921 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s
2026-06-17 20:15:15.159995 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s
2026-06-17 20:15:15.160270 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s
2026-06-17 20:15:15.160526 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s
2026-06-17 20:15:15.160775 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s
2026-06-17 20:15:15.161016 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:15:15.161251 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-06-17 20:15:15.161488 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-06-17 20:15:15.249124 | controller | INFO     [helm > converge] Executed: Successful
2026-06-17 20:15:15.258105 | controller | INFO     [helm > idempotence] Executing
2026-06-17 20:15:16.150574 | controller |
2026-06-17 20:15:16.150901 | controller | PLAY [Converge] ****************************************************************
2026-06-17 20:15:16.151211 | controller |
2026-06-17 20:15:16.151468 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:15:16.151765 | controller | Wednesday 17 June 2026  20:15:16 +0000 (0:00:00.014)       0:00:00.014 ********
2026-06-17 20:15:17.185216 | 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:15:17.190096 | controller | ok: [controller]
2026-06-17 20:15:17.190359 | controller |
2026-06-17 20:15:17.190635 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-17 20:15:17.190888 | controller | Wednesday 17 June 2026  20:15:17 +0000 (0:00:01.039)       0:00:01.054 ********
2026-06-17 20:15:17.612382 | controller | ok: [controller]
2026-06-17 20:15:17.612667 | controller |
2026-06-17 20:15:17.612939 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-17 20:15:17.613360 | controller | Wednesday 17 June 2026  20:15:17 +0000 (0:00:00.422)       0:00:01.476 ********
2026-06-17 20:15:18.774429 | controller | ok: [controller]
2026-06-17 20:15:18.774726 | controller |
2026-06-17 20:15:18.775016 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-06-17 20:15:18.775291 | controller | Wednesday 17 June 2026  20:15:18 +0000 (0:00:01.162)       0:00:02.638 ********
2026-06-17 20:15:19.192896 | controller | ok: [controller]
2026-06-17 20:15:19.193192 | controller |
2026-06-17 20:15:19.193482 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:15:19.193758 | controller | Wednesday 17 June 2026  20:15:19 +0000 (0:00:00.418)       0:00:03.056 ********
2026-06-17 20:15:19.236981 | controller | ok: [controller] => {
2026-06-17 20:15:19.237198 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-06-17 20:15:19.237371 | controller | }
2026-06-17 20:15:19.237536 | controller |
2026-06-17 20:15:19.237719 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:15:19.237895 | controller | Wednesday 17 June 2026  20:15:19 +0000 (0:00:00.044)       0:00:03.100 ********
2026-06-17 20:15:19.784982 | controller | ok: [controller]
2026-06-17 20:15:19.785207 | controller |
2026-06-17 20:15:19.785415 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:15:19.785618 | controller | Wednesday 17 June 2026  20:15:19 +0000 (0:00:00.548)       0:00:03.648 ********
2026-06-17 20:15:21.492026 | controller | ok: [controller]
2026-06-17 20:15:21.492114 | controller |
2026-06-17 20:15:21.492238 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-06-17 20:15:21.492361 | controller | Wednesday 17 June 2026  20:15:21 +0000 (0:00:01.704)       0:00:05.352 ********
2026-06-17 20:15:22.002417 | controller | ok: [controller]
2026-06-17 20:15:22.002588 | controller |
2026-06-17 20:15:22.003015 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-06-17 20:15:22.003047 | controller | Wednesday 17 June 2026  20:15:22 +0000 (0:00:00.512)       0:00:05.865 ********
2026-06-17 20:15:22.427760 | controller | ok: [controller]
2026-06-17 20:15:22.427818 | controller |
2026-06-17 20:15:22.427973 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-06-17 20:15:22.428096 | controller | Wednesday 17 June 2026  20:15:22 +0000 (0:00:00.424)       0:00:06.289 ********
2026-06-17 20:15:22.862554 | controller | ok: [controller]
2026-06-17 20:15:22.862601 | controller |
2026-06-17 20:15:22.862754 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-06-17 20:15:22.862880 | controller | Wednesday 17 June 2026  20:15:22 +0000 (0:00:00.436)       0:00:06.726 ********
2026-06-17 20:15:23.155566 | controller | ok: [controller]
2026-06-17 20:15:23.155647 | controller |
2026-06-17 20:15:23.155984 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-06-17 20:15:23.156008 | controller | Wednesday 17 June 2026  20:15:23 +0000 (0:00:00.293)       0:00:07.019 ********
2026-06-17 20:15:23.447253 | controller | ok: [controller]
2026-06-17 20:15:23.447315 | controller |
2026-06-17 20:15:23.447427 | controller | TASK [Install plugin] **********************************************************
2026-06-17 20:15:23.447555 | controller | Wednesday 17 June 2026  20:15:23 +0000 (0:00:00.291)       0:00:07.310 ********
2026-06-17 20:15:23.508163 | controller | included: vexxhost.containers.download_artifact for controller
2026-06-17 20:15:23.508213 | controller |
2026-06-17 20:15:23.510592 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-17 20:15:23.510612 | controller | Wednesday 17 June 2026  20:15:23 +0000 (0:00:00.059)       0:00:07.370 ********
2026-06-17 20:15:23.556101 | controller | ok: [controller] => {
2026-06-17 20:15:23.556263 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-06-17 20:15:23.556380 | controller | }
2026-06-17 20:15:23.556488 | controller |
2026-06-17 20:15:23.556605 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-17 20:15:23.556720 | controller | Wednesday 17 June 2026  20:15:23 +0000 (0:00:00.048)       0:00:07.418 ********
2026-06-17 20:15:23.978913 | controller | ok: [controller]
2026-06-17 20:15:23.979046 | controller |
2026-06-17 20:15:23.980379 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-17 20:15:23.980718 | controller | Wednesday 17 June 2026  20:15:23 +0000 (0:00:00.424)       0:00:07.843 ********
2026-06-17 20:15:25.597908 | controller | ok: [controller]
2026-06-17 20:15:25.598088 | controller |
2026-06-17 20:15:25.598234 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:15:25.598393 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:15:25.598516 | controller |
2026-06-17 20:15:25.598646 | controller |
2026-06-17 20:15:25.598777 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:15:25.598919 | controller | Wednesday 17 June 2026  20:15:25 +0000 (0:00:01.613)       0:00:09.456 ********
2026-06-17 20:15:25.599058 | controller | ===============================================================================
2026-06-17 20:15:25.599188 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s
2026-06-17 20:15:25.599317 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.61s
2026-06-17 20:15:25.599439 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.16s
2026-06-17 20:15:25.599576 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2026-06-17 20:15:25.599914 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.55s
2026-06-17 20:15:25.600080 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s
2026-06-17 20:15:25.600242 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s
2026-06-17 20:15:25.600403 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s
2026-06-17 20:15:25.600568 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s
2026-06-17 20:15:25.600726 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s
2026-06-17 20:15:25.600902 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s
2026-06-17 20:15:25.601057 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-06-17 20:15:25.601207 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s
2026-06-17 20:15:25.601354 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-06-17 20:15:25.601506 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-06-17 20:15:25.601655 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-06-17 20:15:25.685450 | controller | INFO     [helm > idempotence] Executed: Successful
2026-06-17 20:15:25.694912 | controller | INFO     [helm > side_effect] Executing
2026-06-17 20:15:25.695360 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:15:25.702140 | controller | INFO     [helm > verify] Executing
2026-06-17 20:15:26.527397 | controller |
2026-06-17 20:15:26.527871 | controller | PLAY [Verify] ******************************************************************
2026-06-17 20:15:26.528107 | controller |
2026-06-17 20:15:26.528354 | controller | TASK [Gathering Facts] *********************************************************
2026-06-17 20:15:26.528596 | controller | Wednesday 17 June 2026  20:15:26 +0000 (0:00:00.010)       0:00:00.010 ********
2026-06-17 20:15:27.573461 | 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:15:27.581270 | controller | ok: [controller]
2026-06-17 20:15:27.581436 | controller |
2026-06-17 20:15:27.581604 | controller | TASK [Get the current Helm version] ********************************************
2026-06-17 20:15:27.581772 | controller | Wednesday 17 June 2026  20:15:27 +0000 (0:00:01.053)       0:00:01.063 ********
2026-06-17 20:15:28.019809 | controller | changed: [controller]
2026-06-17 20:15:28.019950 | controller |
2026-06-17 20:15:28.020069 | controller | TASK [Assert Helm version] *****************************************************
2026-06-17 20:15:28.020195 | controller | Wednesday 17 June 2026  20:15:28 +0000 (0:00:00.438)       0:00:01.502 ********
2026-06-17 20:15:28.048227 | controller | ok: [controller] => {
2026-06-17 20:15:28.048493 | controller |     "changed": false,
2026-06-17 20:15:28.048740 | controller |     "msg": "All assertions passed"
2026-06-17 20:15:28.048978 | controller | }
2026-06-17 20:15:28.049207 | controller |
2026-06-17 20:15:28.049450 | controller | PLAY RECAP *********************************************************************
2026-06-17 20:15:28.049713 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-06-17 20:15:28.050039 | controller |
2026-06-17 20:15:28.050346 | controller |
2026-06-17 20:15:28.050654 | controller | TASKS RECAP ********************************************************************
2026-06-17 20:15:28.050959 | controller | Wednesday 17 June 2026  20:15:28 +0000 (0:00:00.028)       0:00:01.531 ********
2026-06-17 20:15:28.051212 | controller | ===============================================================================
2026-06-17 20:15:28.051496 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-06-17 20:15:28.051786 | controller | Get the current Helm version -------------------------------------------- 0.44s
2026-06-17 20:15:28.052097 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-06-17 20:15:28.131570 | controller | INFO     [helm > verify] Executed: Successful
2026-06-17 20:15:28.143495 | controller | INFO     [helm > cleanup] Executing
2026-06-17 20:15:28.143847 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-17 20:15:28.149167 | controller | INFO     [helm > destroy] Executing
2026-06-17 20:15:28.149258 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-06-17 20:15:28.149374 | controller | INFO     [helm > destroy] Executed: Successful
2026-06-17 20:15:28.149662 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-06-17 20:15:28.500435 | controller | ok: Runtime: 0:00:55.929634
2026-06-17 20:15:28.505276 | 
2026-06-17 20:15:28.505346 | PLAY RECAP
2026-06-17 20:15:28.505465 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:15:28.505499 | 
2026-06-17 20:15:28.684850 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-17 20:15:28.689025 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-17 20:15:29.325740 | 
2026-06-17 20:15:29.325883 | PLAY [all]
2026-06-17 20:15:29.337442 | 
2026-06-17 20:15:29.337525 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-06-17 20:15:29.754617 | controller | changed
2026-06-17 20:15:29.760811 | 
2026-06-17 20:15:29.760925 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-06-17 20:15:30.163774 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:15:30.163897 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:15:30.172222 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:15:30.173652 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:15:30.174443 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:15:30.174760 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:15:30.178295 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:15:30.180686 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:15:30.180747 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:15:30.183715 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:15:30.184751 | controller | environment: line 1: kubectl: command not found
2026-06-17 20:15:30.185979 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-17 20:15:30.293621 | controller | ok: Runtime: 0:00:00.035984
2026-06-17 20:15:30.299333 | 
2026-06-17 20:15:30.299427 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-06-17 20:15:30.535640 | controller | changed
2026-06-17 20:15:30.544609 | 
2026-06-17 20:15:30.544755 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-06-17 20:15:30.786154 | controller | environment: line 5: kubectl: command not found
2026-06-17 20:15:30.787636 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:15:30.787786 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:15:30.787917 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-17 20:15:31.071975 | controller | ok: Runtime: 0:00:00.013784
2026-06-17 20:15:31.076937 | 
2026-06-17 20:15:31.077037 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-06-17 20:15:31.721907 | controller | changed:
2026-06-17 20:15:31.722178 | controller | created directory /var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/logs/controller
2026-06-17 20:15:31.722245 | controller | cd+++++++++ objects/
2026-06-17 20:15:31.722295 | controller | cd+++++++++ objects/cluster/
2026-06-17 20:15:31.722347 | controller | cd+++++++++ objects/namespaced/
2026-06-17 20:15:31.733645 | 
2026-06-17 20:15:31.733790 | TASK [gather-pod-logs : creating directory for pod logs]
2026-06-17 20:15:31.971618 | controller | changed
2026-06-17 20:15:31.977097 | 
2026-06-17 20:15:31.977191 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-06-17 20:15:32.209240 | controller | changed
2026-06-17 20:15:32.213394 | 
2026-06-17 20:15:32.213469 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-06-17 20:15:32.447753 | controller | environment: line 3: kubectl: command not found
2026-06-17 20:15:32.744375 | controller | ok: Runtime: 0:00:00.013012
2026-06-17 20:15:32.750356 | 
2026-06-17 20:15:32.750450 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-06-17 20:15:33.270268 | controller | changed:
2026-06-17 20:15:33.270533 | controller | cd+++++++++ pod-logs/
2026-06-17 20:15:33.270592 | controller | cd+++++++++ pod-logs/failed-pods/
2026-06-17 20:15:33.280025 | 
2026-06-17 20:15:33.280088 | LOOP [helm-release-status : creating directory for helm release status]
2026-06-17 20:15:33.516364 | controller | changed: "values"
2026-06-17 20:15:33.717220 | controller | changed: "releases"
2026-06-17 20:15:33.729662 | 
2026-06-17 20:15:33.729843 | TASK [helm-release-status : Gather get release status for helm charts]
2026-06-17 20:15:33.977241 | controller | /bin/bash: line 3: kubectl: command not found
2026-06-17 20:15:34.273262 | controller | ok: Runtime: 0:00:00.007448
2026-06-17 20:15:34.280263 | 
2026-06-17 20:15:34.280330 | TASK [helm-release-status : Downloads logs to executor]
2026-06-17 20:15:34.787616 | controller | changed:
2026-06-17 20:15:34.787830 | controller | cd+++++++++ helm/
2026-06-17 20:15:34.787868 | controller | cd+++++++++ helm/releases/
2026-06-17 20:15:34.787901 | controller | cd+++++++++ helm/values/
2026-06-17 20:15:34.794554 | 
2026-06-17 20:15:34.794607 | PLAY RECAP
2026-06-17 20:15:34.794657 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-17 20:15:34.794678 | 
2026-06-17 20:15:34.943044 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-17 20:15:34.945850 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-17 20:15:35.642568 | 
2026-06-17 20:15:35.642738 | PLAY [all]
2026-06-17 20:15:35.654095 | 
2026-06-17 20:15:35.654263 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-17 20:15:35.699746 | controller | skipping: Conditional result was False
2026-06-17 20:15:35.707466 | 
2026-06-17 20:15:35.707587 | TASK [fetch-output : Set log path for single node]
2026-06-17 20:15:35.749588 | controller | ok
2026-06-17 20:15:35.755931 | 
2026-06-17 20:15:35.756027 | LOOP [fetch-output : Ensure local output dirs]
2026-06-17 20:15:36.150632 | controller -> localhost | ok: "/var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/logs"
2026-06-17 20:15:36.368189 | controller -> localhost | changed: "/var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/artifacts"
2026-06-17 20:15:36.600074 | controller -> localhost | changed: "/var/lib/zuul/builds/18e74d0eeb1a437daaa7424cb6fb9405/work/docs"
2026-06-17 20:15:36.618187 | 
2026-06-17 20:15:36.618318 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-17 20:15:37.224572 | controller | changed: .d..t...... ./
2026-06-17 20:15:37.224823 | controller | changed: All items complete
2026-06-17 20:15:37.224864 | 
2026-06-17 20:15:37.649839 | controller | changed: .d..t...... ./
2026-06-17 20:15:38.083262 | controller | changed: .d..t...... ./
2026-06-17 20:15:38.102199 | 
2026-06-17 20:15:38.102334 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-17 20:15:38.551210 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007374
2026-06-17 20:15:38.792671 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007677
2026-06-17 20:15:38.808281 | 
2026-06-17 20:15:38.808655 | PLAY [all]
2026-06-17 20:15:38.817894 | 
2026-06-17 20:15:38.817970 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-17 20:15:39.331142 | controller | changed
2026-06-17 20:15:39.336090 | 
2026-06-17 20:15:39.336154 | PLAY RECAP
2026-06-17 20:15:39.336208 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-17 20:15:39.336231 | 
2026-06-17 20:15:39.503350 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-17 20:15:39.506305 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-06-17 20:15:40.087968 | 
2026-06-17 20:15:40.088099 | PLAY [localhost]
2026-06-17 20:15:40.098143 | 
2026-06-17 20:15:40.098218 | TASK [Generate Zuul manifest]
2026-06-17 20:15:40.118740 | localhost | ok
2026-06-17 20:15:40.136512 | 
2026-06-17 20:15:40.136593 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-17 20:15:40.519530 | localhost | changed
2026-06-17 20:15:40.531771 | 
2026-06-17 20:15:40.531857 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-17 20:15:40.564193 | localhost | ok
2026-06-17 20:15:40.572575 | 
2026-06-17 20:15:40.572636 | TASK [Upload logs]
2026-06-17 20:15:40.594775 | localhost | ok
2026-06-17 20:15:40.656101 | 
2026-06-17 20:15:40.656233 | TASK [Set zuul-log-path fact]
2026-06-17 20:15:40.676676 | localhost | ok
2026-06-17 20:15:40.690007 | 
2026-06-17 20:15:40.690071 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-17 20:15:40.721739 | localhost | ok
2026-06-17 20:15:40.729477 | 
2026-06-17 20:15:40.729538 | TASK [upload-logs : Create log directories]
2026-06-17 20:15:41.147090 | localhost | changed
2026-06-17 20:15:41.153986 | 
2026-06-17 20:15:41.154111 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-17 20:15:41.596627 | localhost -> localhost | ok: Runtime: 0:00:00.005842
2026-06-17 20:15:41.604269 | 
2026-06-17 20:15:41.604430 | TASK [upload-logs : Upload logs to log server]
2026-06-17 20:15:42.132644 | localhost | Output suppressed because no_log was given
2026-06-17 20:15:42.138067 | 
2026-06-17 20:15:42.138154 | LOOP [upload-logs : Compress console log and json output]
2026-06-17 20:15:42.188385 | localhost | skipping: Conditional result was False
2026-06-17 20:15:42.246725 | localhost | skipping: Conditional result was False
2026-06-17 20:15:42.263415 | 
2026-06-17 20:15:42.263627 | LOOP [upload-logs : Upload compressed console log and json output]
2026-06-17 20:15:42.308584 | localhost | skipping: Conditional result was False
2026-06-17 20:15:42.309040 | 
2026-06-17 20:15:42.312593 | localhost | skipping: Conditional result was False
2026-06-17 20:15:42.328349 | 
2026-06-17 20:15:42.328505 | LOOP [upload-logs : Upload console log and json output]