2026-08-06 17:25:28.135872 | Job console starting
2026-08-06 17:25:28.149465 | Updating git repos
2026-08-06 17:25:28.197682 | Cloning repos into workspace
2026-08-06 17:25:28.238827 | Restoring repo states
2026-08-06 17:25:28.253163 | Merging changes
2026-08-06 17:25:28.942751 | Checking out repos
2026-08-06 17:25:29.149839 | Preparing playbooks
2026-08-06 17:25:31.549943 | Running Ansible setup
2026-08-06 17:25:35.547642 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-06 17:25:36.262447 | 
2026-08-06 17:25:36.262588 | PLAY [localhost]
2026-08-06 17:25:36.270408 | 
2026-08-06 17:25:36.270478 | TASK [Gathering Facts]
2026-08-06 17:25:37.390003 | localhost | ok
2026-08-06 17:25:37.402992 | 
2026-08-06 17:25:37.403089 | TASK [Setup log path fact]
2026-08-06 17:25:37.436034 | localhost | ok
2026-08-06 17:25:37.454272 | 
2026-08-06 17:25:37.454405 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-06 17:25:37.483137 | localhost | ok
2026-08-06 17:25:37.493574 | 
2026-08-06 17:25:37.493672 | TASK [emit-job-header : Print job information]
2026-08-06 17:25:37.534744 | # Job Information
2026-08-06 17:25:37.534909 | Ansible Version: 2.16.18
2026-08-06 17:25:37.534956 | Job: ansible-collection-kubernetes-molecule-helm
2026-08-06 17:25:37.534988 | Pipeline: check
2026-08-06 17:25:37.535018 | Executor: 2d72f0692154
2026-08-06 17:25:37.535047 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/221
2026-08-06 17:25:37.535080 | Event ID: 521b9fd0-91bb-11f1-9faa-a6cdbd1fdabc
2026-08-06 17:25:37.539100 | 
2026-08-06 17:25:37.540029 | LOOP [emit-job-header : Print node information]
2026-08-06 17:25:37.628138 | localhost | ok:
2026-08-06 17:25:37.628444 | localhost | # Node Information
2026-08-06 17:25:37.628523 | localhost | Inventory Hostname: controller
2026-08-06 17:25:37.628585 | localhost | Hostname: np0000188174
2026-08-06 17:25:37.628644 | localhost | Username: zuul
2026-08-06 17:25:37.628707 | localhost | Distro: Debian 13.6
2026-08-06 17:25:37.628761 | localhost | Provider: yul1
2026-08-06 17:25:37.628794 | localhost | Region: ca-ymq-1
2026-08-06 17:25:37.628833 | localhost | Label: debian-trixie
2026-08-06 17:25:37.628877 | localhost | Product Name: OpenStack Nova
2026-08-06 17:25:37.628915 | localhost | Interface IP: 199.204.45.210
2026-08-06 17:25:37.640088 | 
2026-08-06 17:25:37.640256 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-06 17:25:38.079956 | localhost -> localhost | changed
2026-08-06 17:25:38.088270 | 
2026-08-06 17:25:38.088414 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-06 17:25:38.990032 | localhost -> localhost | changed
2026-08-06 17:25:38.999579 | 
2026-08-06 17:25:38.999653 | PLAY [all]
2026-08-06 17:25:39.011449 | 
2026-08-06 17:25:39.011520 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-06 17:25:39.226079 | controller -> localhost | ok
2026-08-06 17:25:39.231574 | 
2026-08-06 17:25:39.231652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-06 17:25:39.267067 | controller | ok
2026-08-06 17:25:39.282457 | controller | included: /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-06 17:25:39.287396 | 
2026-08-06 17:25:39.287457 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-06 17:25:40.180604 | controller -> localhost | Generating public/private rsa key pair.
2026-08-06 17:25:40.180808 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/473cdd553193462ba189d8fab6665783_id_rsa
2026-08-06 17:25:40.180856 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/473cdd553193462ba189d8fab6665783_id_rsa.pub
2026-08-06 17:25:40.180891 | controller -> localhost | The key fingerprint is:
2026-08-06 17:25:40.180924 | controller -> localhost | SHA256:kLC/+Ue8mTS3Iz6qQxhfVqigyAXoPocCljQ8hFh4xYs zuul-build-sshkey
2026-08-06 17:25:40.181024 | controller -> localhost | The key's randomart image is:
2026-08-06 17:25:40.181341 | controller -> localhost | +---[RSA 3072]----+
2026-08-06 17:25:40.181384 | controller -> localhost | |*=ooo    .       |
2026-08-06 17:25:40.181417 | controller -> localhost | |==..oo .. .      |
2026-08-06 17:25:40.181447 | controller -> localhost | |+o=o.oo. .       |
2026-08-06 17:25:40.181478 | controller -> localhost | |o=E o...o        |
2026-08-06 17:25:40.181537 | controller -> localhost | |+ .  +.oS.       |
2026-08-06 17:25:40.181571 | controller -> localhost | |.+ .. oo  = .    |
2026-08-06 17:25:40.181600 | controller -> localhost | |. o  .o  o * .   |
2026-08-06 17:25:40.181630 | controller -> localhost | |      ..  B o    |
2026-08-06 17:25:40.183611 | controller -> localhost | |      .oo+.o .   |
2026-08-06 17:25:40.183685 | controller -> localhost | +----[SHA256]-----+
2026-08-06 17:25:40.183773 | controller -> localhost | ok: Runtime: 0:00:00.479794
2026-08-06 17:25:40.190818 | 
2026-08-06 17:25:40.190909 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-06 17:25:40.224095 | controller | ok
2026-08-06 17:25:40.236104 | controller | included: /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-06 17:25:40.244856 | 
2026-08-06 17:25:40.245222 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-06 17:25:40.260822 | controller | skipping: Conditional result was False
2026-08-06 17:25:40.266305 | 
2026-08-06 17:25:40.266435 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-06 17:25:40.828120 | controller | changed
2026-08-06 17:25:40.837509 | 
2026-08-06 17:25:40.837582 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-06 17:25:41.033310 | controller | ok
2026-08-06 17:25:41.040271 | 
2026-08-06 17:25:41.040393 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-06 17:25:41.573871 | controller | changed
2026-08-06 17:25:41.578704 | 
2026-08-06 17:25:41.578768 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-06 17:25:42.116107 | controller | changed
2026-08-06 17:25:42.124787 | 
2026-08-06 17:25:42.125150 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-06 17:25:42.150937 | controller | skipping: Conditional result was False
2026-08-06 17:25:42.159515 | 
2026-08-06 17:25:42.159611 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-06 17:25:42.574497 | controller -> localhost | changed
2026-08-06 17:25:42.588712 | 
2026-08-06 17:25:42.588802 | TASK [add-build-sshkey : Add back temp key]
2026-08-06 17:25:42.886110 | controller -> localhost | Identity added: /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/473cdd553193462ba189d8fab6665783_id_rsa (zuul-build-sshkey)
2026-08-06 17:25:42.886374 | controller -> localhost | ok: Runtime: 0:00:00.016369
2026-08-06 17:25:42.892386 | 
2026-08-06 17:25:42.892466 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-06 17:25:43.238798 | controller | ok
2026-08-06 17:25:43.245633 | 
2026-08-06 17:25:43.245818 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-06 17:25:43.272727 | controller | skipping: Conditional result was False
2026-08-06 17:25:43.286547 | 
2026-08-06 17:25:43.286669 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-06 17:25:43.663566 | controller | ok
2026-08-06 17:25:43.672447 | 
2026-08-06 17:25:43.672544 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-06 17:25:44.676670 | controller | Output suppressed because no_log was given
2026-08-06 17:25:44.982984 | 
2026-08-06 17:25:44.983165 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-06 17:25:45.200141 | controller | ok: "logs"
2026-08-06 17:25:45.200498 | controller | ok: All items complete
2026-08-06 17:25:45.200541 | 
2026-08-06 17:25:45.405536 | controller | ok: "artifacts"
2026-08-06 17:25:45.587586 | controller | ok: "docs"
2026-08-06 17:25:45.600364 | 
2026-08-06 17:25:45.600601 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-06 17:25:45.838424 | controller | changed: "logs"
2026-08-06 17:25:46.029783 | controller | changed: "artifacts"
2026-08-06 17:25:46.204784 | controller | changed: "docs"
2026-08-06 17:25:46.229717 | 
2026-08-06 17:25:46.229845 | PLAY RECAP
2026-08-06 17:25:46.229900 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-06 17:25:46.229932 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-06 17:25:46.229955 | 
2026-08-06 17:25:46.382970 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-06 17:25:46.386041 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-06 17:25:46.985543 | 
2026-08-06 17:25:46.985669 | PLAY [all]
2026-08-06 17:25:46.995236 | 
2026-08-06 17:25:46.995346 | TASK [setup-uv : Extract archive]
2026-08-06 17:25:49.394691 | controller | changed
2026-08-06 17:25:49.400093 | 
2026-08-06 17:25:49.400178 | TASK [setup-uv : Print version]
2026-08-06 17:25:49.788603 | controller | uv 0.8.13
2026-08-06 17:25:49.928398 | controller | ok: Runtime: 0:00:00.015419
2026-08-06 17:25:49.938383 | 
2026-08-06 17:25:49.938474 | TASK [Install Ansible collection siblings]
2026-08-06 17:25:50.342401 | controller | ok:
2026-08-06 17:25:50.342574 | controller | Skipping ansible.posix: no checked-out sibling
2026-08-06 17:25:50.342603 | controller | Skipping community.crypto: no checked-out sibling
2026-08-06 17:25:50.342625 | controller | Skipping community.general: no checked-out sibling
2026-08-06 17:25:50.342646 | controller | Skipping kubernetes.core: no checked-out sibling
2026-08-06 17:25:50.342666 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-08-06 17:25:50.344204 | 
2026-08-06 17:25:50.344247 | PLAY RECAP
2026-08-06 17:25:50.344305 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-06 17:25:50.344341 | 
2026-08-06 17:25:50.481727 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-06 17:25:50.485165 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-06 17:25:51.240601 | 
2026-08-06 17:25:51.240790 | PLAY [all]
2026-08-06 17:25:51.251900 | 
2026-08-06 17:25:51.252014 | TASK [Update apt cache]
2026-08-06 17:25:57.181427 | controller | ok
2026-08-06 17:25:57.188108 | 
2026-08-06 17:25:57.188272 | TASK [Disable firewalld]
2026-08-06 17:25:57.215099 | controller | skipping: Conditional result was False
2026-08-06 17:25:57.223443 | 
2026-08-06 17:25:57.223599 | TASK [Install "jq" for log collection]
2026-08-06 17:25:59.584064 | controller | changed
2026-08-06 17:25:59.701210 | 
2026-08-06 17:25:59.701361 | PLAY RECAP
2026-08-06 17:25:59.701456 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-06 17:25:59.701508 | 
2026-08-06 17:25:59.834229 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-06 17:25:59.837140 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-06 17:26:00.716736 | 
2026-08-06 17:26:00.716895 | PLAY [all]
2026-08-06 17:26:00.727275 | 
2026-08-06 17:26:00.727357 | LOOP [Check inventory directories]
2026-08-06 17:26:01.133536 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-06 17:26:01.311251 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/helm/inventory"
2026-08-06 17:26:01.492205 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/inventory"
2026-08-06 17:26:01.581135 | 
2026-08-06 17:26:01.581321 | LOOP [Copy inventory file for Zuul]
2026-08-06 17:26:02.653270 | controller | changed:
2026-08-06 17:26:02.653491 | controller | {
2026-08-06 17:26:02.653533 | controller |   "ansible_loop_var": "item",
2026-08-06 17:26:02.653565 | controller |   "changed": false,
2026-08-06 17:26:02.653594 | controller |   "failed": false,
2026-08-06 17:26:02.653629 | controller |   "invocation": {
2026-08-06 17:26:02.653657 | controller |     "module_args": {
2026-08-06 17:26:02.653683 | controller |       "checksum_algorithm": "sha1",
2026-08-06 17:26:02.653709 | controller |       "follow": true,
2026-08-06 17:26:02.653735 | controller |       "get_attributes": true,
2026-08-06 17:26:02.653762 | controller |       "get_checksum": true,
2026-08-06 17:26:02.653788 | controller |       "get_mime": true,
2026-08-06 17:26:02.653814 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-06 17:26:02.653839 | controller |     }
2026-08-06 17:26:02.653865 | controller |   },
2026-08-06 17:26:02.653890 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-06 17:26:02.653915 | controller |   "stat": {
2026-08-06 17:26:02.653939 | controller |     "atime": 1786037144.5535154,
2026-08-06 17:26:02.653964 | controller |     "attr_flags": "e",
2026-08-06 17:26:02.653989 | controller |     "attributes": [
2026-08-06 17:26:02.654014 | controller |       "extents"
2026-08-06 17:26:02.654038 | controller |     ],
2026-08-06 17:26:02.654063 | controller |     "block_size": 4096,
2026-08-06 17:26:02.654088 | controller |     "blocks": 8,
2026-08-06 17:26:02.654113 | controller |     "charset": "unknown",
2026-08-06 17:26:02.654140 | controller |     "ctime": 1786037144.5735195,
2026-08-06 17:26:02.654165 | controller |     "dev": 65025,
2026-08-06 17:26:02.654190 | controller |     "device_type": 0,
2026-08-06 17:26:02.654250 | controller |     "executable": true,
2026-08-06 17:26:02.654278 | controller |     "exists": true,
2026-08-06 17:26:02.654303 | controller |     "gid": 1000,
2026-08-06 17:26:02.654328 | controller |     "gr_name": "zuul",
2026-08-06 17:26:02.654353 | controller |     "inode": 519191,
2026-08-06 17:26:02.654378 | controller |     "isblk": false,
2026-08-06 17:26:02.654403 | controller |     "ischr": false,
2026-08-06 17:26:02.654427 | controller |     "isdir": true,
2026-08-06 17:26:02.654452 | controller |     "isfifo": false,
2026-08-06 17:26:02.654476 | controller |     "isgid": false,
2026-08-06 17:26:02.654500 | controller |     "islnk": false,
2026-08-06 17:26:02.654525 | controller |     "isreg": false,
2026-08-06 17:26:02.654549 | controller |     "issock": false,
2026-08-06 17:26:02.654573 | controller |     "isuid": false,
2026-08-06 17:26:02.654597 | controller |     "mimetype": "unknown",
2026-08-06 17:26:02.654622 | controller |     "mode": "0755",
2026-08-06 17:26:02.654645 | controller |     "mtime": 1786037128.3598359,
2026-08-06 17:26:02.654670 | controller |     "nlink": 14,
2026-08-06 17:26:02.654694 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-06 17:26:02.654718 | controller |     "pw_name": "zuul",
2026-08-06 17:26:02.654746 | controller |     "readable": true,
2026-08-06 17:26:02.654772 | controller |     "rgrp": true,
2026-08-06 17:26:02.654796 | controller |     "roth": true,
2026-08-06 17:26:02.654822 | controller |     "rusr": true,
2026-08-06 17:26:02.654846 | controller |     "size": 4096,
2026-08-06 17:26:02.654871 | controller |     "uid": 1000,
2026-08-06 17:26:02.654896 | controller |     "version": "3642147953",
2026-08-06 17:26:02.654922 | controller |     "wgrp": false,
2026-08-06 17:26:02.654948 | controller |     "woth": false,
2026-08-06 17:26:02.654974 | controller |     "writeable": true,
2026-08-06 17:26:02.654999 | controller |     "wusr": true,
2026-08-06 17:26:02.655024 | controller |     "xgrp": true,
2026-08-06 17:26:02.655049 | controller |     "xoth": true,
2026-08-06 17:26:02.655074 | controller |     "xusr": true
2026-08-06 17:26:02.655098 | controller |   }
2026-08-06 17:26:02.655138 | controller | }
2026-08-06 17:26:02.655191 | controller | ok: All items complete
2026-08-06 17:26:02.655223 | 
2026-08-06 17:26:02.656866 | controller | skipping: Conditional result was False
2026-08-06 17:26:02.657712 | controller | skipping: Conditional result was False
2026-08-06 17:26:02.672480 | 
2026-08-06 17:26:02.672651 | LOOP [Switch "ansible_host" to private IP]
2026-08-06 17:26:03.084167 | controller | changed: 1 replacements made
2026-08-06 17:26:03.086384 | controller | skipping: Conditional result was False
2026-08-06 17:26:03.087348 | controller | skipping: Conditional result was False
2026-08-06 17:26:03.105543 | 
2026-08-06 17:26:03.105689 | TASK [Run Molecule scenario]
2026-08-06 17:26:03.575235 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-08-06 17:26:03.575300 | controller | Creating virtual environment at: .venv
2026-08-06 17:26:03.876321 | controller | Downloading pygments (1.2MiB)
2026-08-06 17:26:03.876699 | controller | Downloading ansible-core (2.3MiB)
2026-08-06 17:26:03.877154 | controller | Downloading cryptography (4.3MiB)
2026-08-06 17:26:04.038242 | controller |  Downloading cryptography
2026-08-06 17:26:04.093407 | controller |  Downloading pygments
2026-08-06 17:26:04.284938 | controller |  Downloading ansible-core
2026-08-06 17:26:04.334032 | controller | Installed 36 packages in 48ms
2026-08-06 17:26:05.012366 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-08-06 17:26:05.012440 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-06 17:26:05.867763 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-08-06 17:26:05.867833 | controller | INFO     default scenario not found, disabling shared state.
2026-08-06 17:26:05.867858 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-06 17:26:05.867943 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-08-06 17:26:23.279185 | controller | INFO     [helm > dependency] Executing
2026-08-06 17:26:23.279263 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-08-06 17:26:23.279333 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-08-06 17:26:23.279449 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-06 17:26:23.284915 | controller | INFO     [helm > cleanup] Executing
2026-08-06 17:26:23.285229 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-06 17:26:23.290472 | controller | INFO     [helm > destroy] Executing
2026-08-06 17:26:23.290530 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-08-06 17:26:23.290595 | controller | INFO     [helm > destroy] Executed: Successful
2026-08-06 17:26:23.295846 | controller | INFO     [helm > syntax] Executing
2026-08-06 17:26:24.217475 | controller |
2026-08-06 17:26:24.217534 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-08-06 17:26:24.280351 | controller | INFO     [helm > syntax] Executed: Successful
2026-08-06 17:26:24.291339 | controller | INFO     [helm > create] Executing
2026-08-06 17:26:24.292793 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-06 17:26:24.298132 | controller | INFO     [helm > prepare] Executing
2026-08-06 17:26:25.165114 | controller |
2026-08-06 17:26:25.165255 | controller | PLAY [Prepare] *****************************************************************
2026-08-06 17:26:25.165428 | controller |
2026-08-06 17:26:25.165620 | controller | TASK [Gathering Facts] *********************************************************
2026-08-06 17:26:25.165812 | controller | Thursday 06 August 2026  17:26:25 +0000 (0:00:00.030)       0:00:00.030 *******
2026-08-06 17:26:26.415712 | 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-08-06 17:26:26.421109 | controller | ok: [controller]
2026-08-06 17:26:26.421277 | controller |
2026-08-06 17:26:26.421486 | controller | TASK [Install Debian packages] *************************************************
2026-08-06 17:26:26.421736 | controller | Thursday 06 August 2026  17:26:26 +0000 (0:00:01.256)       0:00:01.287 *******
2026-08-06 17:26:27.755175 | controller | ok: [controller]
2026-08-06 17:26:27.755229 | controller |
2026-08-06 17:26:27.755325 | controller | PLAY RECAP *********************************************************************
2026-08-06 17:26:27.755432 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-06 17:26:27.755518 | controller |
2026-08-06 17:26:27.755642 | controller |
2026-08-06 17:26:27.755709 | controller | TASKS RECAP ********************************************************************
2026-08-06 17:26:27.755802 | controller | Thursday 06 August 2026  17:26:27 +0000 (0:00:01.334)       0:00:02.621 *******
2026-08-06 17:26:27.755921 | controller | ===============================================================================
2026-08-06 17:26:27.756005 | controller | Install Debian packages ------------------------------------------------- 1.33s
2026-08-06 17:26:27.756100 | controller | Gathering Facts --------------------------------------------------------- 1.26s
2026-08-06 17:26:27.847036 | controller | INFO     [helm > prepare] Executed: Successful
2026-08-06 17:26:27.852756 | controller | INFO     [helm > converge] Executing
2026-08-06 17:26:28.731723 | controller |
2026-08-06 17:26:28.731801 | controller | PLAY [Converge] ****************************************************************
2026-08-06 17:26:28.732004 | controller |
2026-08-06 17:26:28.732131 | controller | TASK [Gathering Facts] *********************************************************
2026-08-06 17:26:28.732205 | controller | Thursday 06 August 2026  17:26:28 +0000 (0:00:00.013)       0:00:00.013 *******
2026-08-06 17:26:29.805400 | 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-08-06 17:26:29.813465 | controller | ok: [controller]
2026-08-06 17:26:29.813658 | controller |
2026-08-06 17:26:29.813867 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-06 17:26:29.814069 | controller | Thursday 06 August 2026  17:26:29 +0000 (0:00:01.081)       0:00:01.094 *******
2026-08-06 17:26:30.299301 | controller | ok: [controller]
2026-08-06 17:26:30.299450 | controller |
2026-08-06 17:26:30.299654 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-06 17:26:30.299894 | controller | Thursday 06 August 2026  17:26:30 +0000 (0:00:00.486)       0:00:01.580 *******
2026-08-06 17:26:31.303001 | controller | ok: [controller]
2026-08-06 17:26:31.303215 | controller |
2026-08-06 17:26:31.303436 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-06 17:26:31.303648 | controller | Thursday 06 August 2026  17:26:31 +0000 (0:00:01.003)       0:00:02.584 *******
2026-08-06 17:26:31.734206 | controller | changed: [controller]
2026-08-06 17:26:31.734250 | controller |
2026-08-06 17:26:31.734259 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-06 17:26:31.734268 | controller | Thursday 06 August 2026  17:26:31 +0000 (0:00:00.430)       0:00:03.014 *******
2026-08-06 17:26:31.782715 | controller | ok: [controller] => {
2026-08-06 17:26:31.782759 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-08-06 17:26:31.782768 | controller | }
2026-08-06 17:26:31.782777 | controller |
2026-08-06 17:26:31.782785 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-06 17:26:31.782793 | controller | Thursday 06 August 2026  17:26:31 +0000 (0:00:00.048)       0:00:03.062 *******
2026-08-06 17:26:32.925700 | 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-08-06 17:26:32.936686 | controller | changed: [controller]
2026-08-06 17:26:32.936721 | controller |
2026-08-06 17:26:32.936732 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-06 17:26:32.936741 | controller | Thursday 06 August 2026  17:26:32 +0000 (0:00:01.154)       0:00:04.217 *******
2026-08-06 17:26:34.956606 | controller | changed: [controller]
2026-08-06 17:26:34.956896 | controller |
2026-08-06 17:26:34.957161 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-08-06 17:26:34.957414 | controller | Thursday 06 August 2026  17:26:34 +0000 (0:00:02.020)       0:00:06.237 *******
2026-08-06 17:26:35.526906 | controller | ok: [controller]
2026-08-06 17:26:35.527332 | controller |
2026-08-06 17:26:35.527624 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-08-06 17:26:35.527936 | controller | Thursday 06 August 2026  17:26:35 +0000 (0:00:00.569)       0:00:06.806 *******
2026-08-06 17:26:35.924068 | controller | changed: [controller]
2026-08-06 17:26:35.924363 | controller |
2026-08-06 17:26:35.924639 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-08-06 17:26:35.924919 | controller | Thursday 06 August 2026  17:26:35 +0000 (0:00:00.398)       0:00:07.205 *******
2026-08-06 17:26:36.414194 | controller | ok: [controller]
2026-08-06 17:26:36.414512 | controller |
2026-08-06 17:26:36.414795 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-08-06 17:26:36.415050 | controller | Thursday 06 August 2026  17:26:36 +0000 (0:00:00.489)       0:00:07.694 *******
2026-08-06 17:26:36.760649 | controller | changed: [controller]
2026-08-06 17:26:36.760684 | controller |
2026-08-06 17:26:36.760694 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-08-06 17:26:36.760702 | controller | Thursday 06 August 2026  17:26:36 +0000 (0:00:00.346)       0:00:08.040 *******
2026-08-06 17:26:37.079470 | controller | ok: [controller]
2026-08-06 17:26:37.079663 | controller |
2026-08-06 17:26:37.079834 | controller | TASK [Install plugin] **********************************************************
2026-08-06 17:26:37.080027 | controller | Thursday 06 August 2026  17:26:37 +0000 (0:00:00.320)       0:00:08.360 *******
2026-08-06 17:26:37.133064 | controller | included: vexxhost.containers.download_artifact for controller
2026-08-06 17:26:37.133328 | controller |
2026-08-06 17:26:37.133598 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-06 17:26:37.133910 | controller | Thursday 06 August 2026  17:26:37 +0000 (0:00:00.053)       0:00:08.414 *******
2026-08-06 17:26:37.184880 | controller | ok: [controller] => {
2026-08-06 17:26:37.185198 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-08-06 17:26:37.185449 | controller | }
2026-08-06 17:26:37.185684 | controller |
2026-08-06 17:26:37.185991 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-06 17:26:37.186347 | controller | Thursday 06 August 2026  17:26:37 +0000 (0:00:00.051)       0:00:08.465 *******
2026-08-06 17:26:37.974970 | controller | changed: [controller]
2026-08-06 17:26:37.975258 | controller |
2026-08-06 17:26:37.975530 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-06 17:26:37.975790 | controller | Thursday 06 August 2026  17:26:37 +0000 (0:00:00.789)       0:00:09.255 *******
2026-08-06 17:26:40.140026 | controller | changed: [controller]
2026-08-06 17:26:40.140311 | controller |
2026-08-06 17:26:40.140570 | controller | PLAY RECAP *********************************************************************
2026-08-06 17:26:40.140842 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-06 17:26:40.141073 | controller |
2026-08-06 17:26:40.141297 | controller |
2026-08-06 17:26:40.141537 | controller | TASKS RECAP ********************************************************************
2026-08-06 17:26:40.141789 | controller | Thursday 06 August 2026  17:26:40 +0000 (0:00:02.166)       0:00:11.421 *******
2026-08-06 17:26:40.142024 | controller | ===============================================================================
2026-08-06 17:26:40.142272 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.17s
2026-08-06 17:26:40.142521 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.02s
2026-08-06 17:26:40.142766 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.15s
2026-08-06 17:26:40.143006 | controller | Gathering Facts --------------------------------------------------------- 1.08s
2026-08-06 17:26:40.143252 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.00s
2026-08-06 17:26:40.143500 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.79s
2026-08-06 17:26:40.143815 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.57s
2026-08-06 17:26:40.144104 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s
2026-08-06 17:26:40.144357 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-08-06 17:26:40.144523 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s
2026-08-06 17:26:40.144689 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s
2026-08-06 17:26:40.144852 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.35s
2026-08-06 17:26:40.145014 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s
2026-08-06 17:26:40.145168 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-08-06 17:26:40.145329 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-08-06 17:26:40.145484 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-08-06 17:26:40.233903 | controller | INFO     [helm > converge] Executed: Successful
2026-08-06 17:26:40.243169 | controller | INFO     [helm > idempotence] Executing
2026-08-06 17:26:41.123081 | controller |
2026-08-06 17:26:41.123412 | controller | PLAY [Converge] ****************************************************************
2026-08-06 17:26:41.123654 | controller |
2026-08-06 17:26:41.124111 | controller | TASK [Gathering Facts] *********************************************************
2026-08-06 17:26:41.124376 | controller | Thursday 06 August 2026  17:26:41 +0000 (0:00:00.013)       0:00:00.013 *******
2026-08-06 17:26:42.243999 | 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-08-06 17:26:42.252752 | controller | ok: [controller]
2026-08-06 17:26:42.252773 | controller |
2026-08-06 17:26:42.252782 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-06 17:26:42.252790 | controller | Thursday 06 August 2026  17:26:42 +0000 (0:00:01.128)       0:00:01.142 *******
2026-08-06 17:26:42.678732 | controller | ok: [controller]
2026-08-06 17:26:42.679053 | controller |
2026-08-06 17:26:42.679323 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-06 17:26:42.679578 | controller | Thursday 06 August 2026  17:26:42 +0000 (0:00:00.426)       0:00:01.569 *******
2026-08-06 17:26:43.750551 | controller | ok: [controller]
2026-08-06 17:26:43.750839 | controller |
2026-08-06 17:26:43.751120 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-06 17:26:43.751406 | controller | Thursday 06 August 2026  17:26:43 +0000 (0:00:01.071)       0:00:02.640 *******
2026-08-06 17:26:44.166551 | controller | ok: [controller]
2026-08-06 17:26:44.166854 | controller |
2026-08-06 17:26:44.167140 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-06 17:26:44.167460 | controller | Thursday 06 August 2026  17:26:44 +0000 (0:00:00.416)       0:00:03.056 *******
2026-08-06 17:26:44.211557 | controller | ok: [controller] => {
2026-08-06 17:26:44.211841 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-08-06 17:26:44.212171 | controller | }
2026-08-06 17:26:44.212415 | controller |
2026-08-06 17:26:44.212677 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-06 17:26:44.212947 | controller | Thursday 06 August 2026  17:26:44 +0000 (0:00:00.044)       0:00:03.101 *******
2026-08-06 17:26:44.742108 | controller | ok: [controller]
2026-08-06 17:26:44.742395 | controller |
2026-08-06 17:26:44.742665 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-06 17:26:44.742926 | controller | Thursday 06 August 2026  17:26:44 +0000 (0:00:00.529)       0:00:03.631 *******
2026-08-06 17:26:46.437781 | controller | ok: [controller]
2026-08-06 17:26:46.437979 | controller |
2026-08-06 17:26:46.438151 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-08-06 17:26:46.438310 | controller | Thursday 06 August 2026  17:26:46 +0000 (0:00:01.696)       0:00:05.327 *******
2026-08-06 17:26:46.960159 | controller | ok: [controller]
2026-08-06 17:26:46.960468 | controller |
2026-08-06 17:26:46.960741 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-08-06 17:26:46.961048 | controller | Thursday 06 August 2026  17:26:46 +0000 (0:00:00.515)       0:00:05.843 *******
2026-08-06 17:26:47.365624 | controller | ok: [controller]
2026-08-06 17:26:47.365673 | controller |
2026-08-06 17:26:47.365683 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-08-06 17:26:47.365691 | controller | Thursday 06 August 2026  17:26:47 +0000 (0:00:00.411)       0:00:06.254 *******
2026-08-06 17:26:47.820362 | controller | ok: [controller]
2026-08-06 17:26:47.820428 | controller |
2026-08-06 17:26:47.820594 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-08-06 17:26:47.820692 | controller | Thursday 06 August 2026  17:26:47 +0000 (0:00:00.453)       0:00:06.708 *******
2026-08-06 17:26:48.116448 | controller | ok: [controller]
2026-08-06 17:26:48.116542 | controller |
2026-08-06 17:26:48.116677 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-08-06 17:26:48.116815 | controller | Thursday 06 August 2026  17:26:48 +0000 (0:00:00.297)       0:00:07.006 *******
2026-08-06 17:26:48.412397 | controller | ok: [controller]
2026-08-06 17:26:48.412456 | controller |
2026-08-06 17:26:48.412570 | controller | TASK [Install plugin] **********************************************************
2026-08-06 17:26:48.412707 | controller | Thursday 06 August 2026  17:26:48 +0000 (0:00:00.296)       0:00:07.302 *******
2026-08-06 17:26:48.472515 | controller | included: vexxhost.containers.download_artifact for controller
2026-08-06 17:26:48.472562 | controller |
2026-08-06 17:26:48.472639 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-06 17:26:48.472726 | controller | Thursday 06 August 2026  17:26:48 +0000 (0:00:00.058)       0:00:07.360 *******
2026-08-06 17:26:48.529861 | controller | ok: [controller] => {
2026-08-06 17:26:48.529917 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-08-06 17:26:48.529995 | controller | }
2026-08-06 17:26:48.530078 | controller |
2026-08-06 17:26:48.530175 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-06 17:26:48.530269 | controller | Thursday 06 August 2026  17:26:48 +0000 (0:00:00.058)       0:00:07.418 *******
2026-08-06 17:26:48.975519 | controller | ok: [controller]
2026-08-06 17:26:48.975577 | controller |
2026-08-06 17:26:48.975648 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-06 17:26:48.975739 | controller | Thursday 06 August 2026  17:26:48 +0000 (0:00:00.444)       0:00:07.863 *******
2026-08-06 17:26:50.608109 | controller | ok: [controller]
2026-08-06 17:26:50.608353 | controller |
2026-08-06 17:26:50.608366 | controller | PLAY RECAP *********************************************************************
2026-08-06 17:26:50.608377 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-06 17:26:50.608384 | controller |
2026-08-06 17:26:50.608391 | controller |
2026-08-06 17:26:50.608398 | controller | TASKS RECAP ********************************************************************
2026-08-06 17:26:50.608406 | controller | Thursday 06 August 2026  17:26:50 +0000 (0:00:01.632)       0:00:09.496 *******
2026-08-06 17:26:50.608413 | controller | ===============================================================================
2026-08-06 17:26:50.608420 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s
2026-08-06 17:26:50.608426 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.63s
2026-08-06 17:26:50.608433 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-08-06 17:26:50.608440 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.07s
2026-08-06 17:26:50.608447 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s
2026-08-06 17:26:50.608453 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s
2026-08-06 17:26:50.608460 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s
2026-08-06 17:26:50.608467 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s
2026-08-06 17:26:50.608475 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.43s
2026-08-06 17:26:50.608482 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s
2026-08-06 17:26:50.608511 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s
2026-08-06 17:26:50.608519 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s
2026-08-06 17:26:50.608526 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s
2026-08-06 17:26:50.608533 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-08-06 17:26:50.608539 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-08-06 17:26:50.608546 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-08-06 17:26:50.720066 | controller | INFO     [helm > idempotence] Executed: Successful
2026-08-06 17:26:50.730963 | controller | INFO     [helm > side_effect] Executing
2026-08-06 17:26:50.731299 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-06 17:26:50.736862 | controller | INFO     [helm > verify] Executing
2026-08-06 17:26:51.555973 | controller |
2026-08-06 17:26:51.556071 | controller | PLAY [Verify] ******************************************************************
2026-08-06 17:26:51.556254 | controller |
2026-08-06 17:26:51.556438 | controller | TASK [Gathering Facts] *********************************************************
2026-08-06 17:26:51.556631 | controller | Thursday 06 August 2026  17:26:51 +0000 (0:00:00.010)       0:00:00.010 *******
2026-08-06 17:26:52.588367 | 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-08-06 17:26:52.594633 | controller | ok: [controller]
2026-08-06 17:26:52.594825 | controller |
2026-08-06 17:26:52.595038 | controller | TASK [Get the current Helm version] ********************************************
2026-08-06 17:26:52.595269 | controller | Thursday 06 August 2026  17:26:52 +0000 (0:00:01.038)       0:00:01.048 *******
2026-08-06 17:26:53.062408 | controller | changed: [controller]
2026-08-06 17:26:53.062532 | controller |
2026-08-06 17:26:53.062744 | controller | TASK [Assert Helm version] *****************************************************
2026-08-06 17:26:53.062957 | controller | Thursday 06 August 2026  17:26:53 +0000 (0:00:00.467)       0:00:01.516 *******
2026-08-06 17:26:53.089428 | controller | ok: [controller] => {
2026-08-06 17:26:53.089615 | controller |     "changed": false,
2026-08-06 17:26:53.089805 | controller |     "msg": "All assertions passed"
2026-08-06 17:26:53.089989 | controller | }
2026-08-06 17:26:53.090166 | controller |
2026-08-06 17:26:53.090351 | controller | PLAY RECAP *********************************************************************
2026-08-06 17:26:53.090562 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-06 17:26:53.090726 | controller |
2026-08-06 17:26:53.090891 | controller |
2026-08-06 17:26:53.091075 | controller | TASKS RECAP ********************************************************************
2026-08-06 17:26:53.091268 | controller | Thursday 06 August 2026  17:26:53 +0000 (0:00:00.028)       0:00:01.544 *******
2026-08-06 17:26:53.091447 | controller | ===============================================================================
2026-08-06 17:26:53.091635 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2026-08-06 17:26:53.091824 | controller | Get the current Helm version -------------------------------------------- 0.47s
2026-08-06 17:26:53.092067 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-08-06 17:26:53.195350 | controller | INFO     [helm > verify] Executed: Successful
2026-08-06 17:26:53.205613 | controller | INFO     [helm > cleanup] Executing
2026-08-06 17:26:53.206054 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-06 17:26:53.213745 | controller | INFO     [helm > destroy] Executing
2026-08-06 17:26:53.213824 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-08-06 17:26:53.213914 | controller | INFO     [helm > destroy] Executed: Successful
2026-08-06 17:26:53.214258 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-08-06 17:26:53.678446 | controller | ok: Runtime: 0:00:49.800090
2026-08-06 17:26:53.686214 | 
2026-08-06 17:26:53.686284 | PLAY RECAP
2026-08-06 17:26:53.686327 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-06 17:26:53.686348 | 
2026-08-06 17:26:53.826732 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-06 17:26:53.829943 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-06 17:26:54.451686 | 
2026-08-06 17:26:54.451863 | PLAY [all]
2026-08-06 17:26:54.463771 | 
2026-08-06 17:26:54.463854 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-06 17:26:54.842147 | controller | changed
2026-08-06 17:26:54.848520 | 
2026-08-06 17:26:54.848651 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-06 17:26:55.285147 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-06 17:26:55.285597 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-06 17:26:55.292867 | controller | environment: line 1: kubectl: command not found
2026-08-06 17:26:55.294247 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-06 17:26:55.295779 | controller | environment: line 1: kubectl: command not found
2026-08-06 17:26:55.298430 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-06 17:26:55.301110 | controller | environment: line 1: kubectl: command not found
2026-08-06 17:26:55.302448 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-06 17:26:55.304397 | controller | environment: line 1: kubectl: command not found
2026-08-06 17:26:55.305591 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-06 17:26:55.308806 | controller | environment: line 1: kubectl: command not found
2026-08-06 17:26:55.311000 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-06 17:26:55.381590 | controller | ok: Runtime: 0:00:00.038430
2026-08-06 17:26:55.387151 | 
2026-08-06 17:26:55.387243 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-06 17:26:55.610783 | controller | changed
2026-08-06 17:26:55.615839 | 
2026-08-06 17:26:55.615922 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-06 17:26:55.857688 | controller | environment: line 5: kubectl: command not found
2026-08-06 17:26:55.858641 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-06 17:26:55.858669 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-06 17:26:55.859149 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-06 17:26:56.809487 | controller | ok: Runtime: 0:00:00.014445
2026-08-06 17:26:56.815375 | 
2026-08-06 17:26:56.815449 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-06 17:26:58.360589 | controller | changed:
2026-08-06 17:26:58.360895 | controller | created directory /var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/logs/controller
2026-08-06 17:26:58.360997 | controller | cd+++++++++ objects/
2026-08-06 17:26:58.361057 | controller | cd+++++++++ objects/cluster/
2026-08-06 17:26:58.361116 | controller | cd+++++++++ objects/namespaced/
2026-08-06 17:26:58.369359 | 
2026-08-06 17:26:58.369426 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-06 17:26:58.603079 | controller | changed
2026-08-06 17:26:58.608453 | 
2026-08-06 17:26:58.608564 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-06 17:26:58.845048 | controller | changed
2026-08-06 17:26:58.852694 | 
2026-08-06 17:26:58.852842 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-06 17:26:59.090992 | controller | environment: line 3: kubectl: command not found
2026-08-06 17:26:59.384076 | controller | ok: Runtime: 0:00:00.014051
2026-08-06 17:26:59.390179 | 
2026-08-06 17:26:59.390288 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-06 17:26:59.889762 | controller | changed:
2026-08-06 17:26:59.890084 | controller | cd+++++++++ pod-logs/
2026-08-06 17:26:59.890163 | controller | cd+++++++++ pod-logs/failed-pods/
2026-08-06 17:26:59.899621 | 
2026-08-06 17:26:59.899705 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-06 17:27:00.132218 | controller | changed: "values"
2026-08-06 17:27:00.337224 | controller | changed: "releases"
2026-08-06 17:27:00.356015 | 
2026-08-06 17:27:00.356210 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-06 17:27:00.608838 | controller | /bin/bash: line 3: kubectl: command not found
2026-08-06 17:27:01.336413 | controller | ok: Runtime: 0:00:00.009933
2026-08-06 17:27:01.341688 | 
2026-08-06 17:27:01.883321 | TASK [helm-release-status : Downloads logs to executor]
2026-08-06 17:27:03.689739 | controller | changed:
2026-08-06 17:27:03.689995 | controller | cd+++++++++ helm/
2026-08-06 17:27:03.690060 | controller | cd+++++++++ helm/releases/
2026-08-06 17:27:03.690117 | controller | cd+++++++++ helm/values/
2026-08-06 17:27:03.697325 | 
2026-08-06 17:27:03.697378 | PLAY RECAP
2026-08-06 17:27:03.697425 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-06 17:27:03.697449 | 
2026-08-06 17:27:03.862172 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-06 17:27:03.868047 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-06 17:27:04.549560 | 
2026-08-06 17:27:04.665937 | PLAY [all]
2026-08-06 17:27:04.689035 | 
2026-08-06 17:27:04.689260 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-06 17:27:04.734741 | controller | skipping: Conditional result was False
2026-08-06 17:27:04.766462 | 
2026-08-06 17:27:04.766635 | TASK [fetch-output : Set log path for single node]
2026-08-06 17:27:04.806805 | controller | ok
2026-08-06 17:27:05.023946 | 
2026-08-06 17:27:05.024105 | LOOP [fetch-output : Ensure local output dirs]
2026-08-06 17:27:05.555315 | controller -> localhost | ok: "/var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/logs"
2026-08-06 17:27:05.774021 | controller -> localhost | changed: "/var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/artifacts"
2026-08-06 17:27:06.651210 | controller -> localhost | changed: "/var/lib/zuul/builds/473cdd553193462ba189d8fab6665783/work/docs"
2026-08-06 17:27:06.663868 | 
2026-08-06 17:27:06.664250 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-06 17:27:07.333767 | controller | changed: .d..t...... ./
2026-08-06 17:27:07.334303 | controller | changed: All items complete
2026-08-06 17:27:07.334341 | 
2026-08-06 17:27:09.356306 | controller | changed: .d..t...... ./
2026-08-06 17:27:09.823987 | controller | changed: .d..t...... ./
2026-08-06 17:27:09.857002 | 
2026-08-06 17:27:11.374683 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-06 17:27:11.965686 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.167879
2026-08-06 17:27:12.198573 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008051
2026-08-06 17:27:12.215109 | 
2026-08-06 17:27:12.215251 | PLAY [all]
2026-08-06 17:27:12.220926 | 
2026-08-06 17:27:12.221015 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-06 17:27:12.678471 | controller | changed
2026-08-06 17:27:12.685662 | 
2026-08-06 17:27:12.685753 | PLAY RECAP
2026-08-06 17:27:12.685847 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-06 17:27:12.685882 | 
2026-08-06 17:27:12.819806 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-06 17:27:12.822825 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-06 17:27:13.455765 | 
2026-08-06 17:27:13.456401 | PLAY [localhost]
2026-08-06 17:27:13.466907 | 
2026-08-06 17:27:13.467018 | TASK [Generate Zuul manifest]
2026-08-06 17:27:13.490285 | localhost | ok
2026-08-06 17:27:13.505475 | 
2026-08-06 17:27:13.505643 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-06 17:27:15.659796 | localhost | changed
2026-08-06 17:27:15.912873 | 
2026-08-06 17:27:15.913090 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-06 17:27:15.944244 | localhost | ok
2026-08-06 17:27:15.955388 | 
2026-08-06 17:27:15.955571 | TASK [Upload logs]
2026-08-06 17:27:15.978526 | localhost | ok
2026-08-06 17:27:16.167214 | 
2026-08-06 17:27:16.312779 | TASK [Set zuul-log-path fact]
2026-08-06 17:27:16.338868 | localhost | ok
2026-08-06 17:27:16.354705 | 
2026-08-06 17:27:16.354851 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-06 17:27:16.387873 | localhost | ok
2026-08-06 17:27:16.399918 | 
2026-08-06 17:27:16.400092 | TASK [upload-logs : Create log directories]
2026-08-06 17:27:16.891191 | localhost | changed
2026-08-06 17:27:16.897078 | 
2026-08-06 17:27:16.897162 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-06 17:27:17.362146 | localhost -> localhost | ok: Runtime: 0:00:00.006018
2026-08-06 17:27:17.370297 | 
2026-08-06 17:27:17.370386 | TASK [upload-logs : Upload logs to log server]
2026-08-06 17:27:18.607543 | localhost | Output suppressed because no_log was given
2026-08-06 17:27:18.613688 | 
2026-08-06 17:27:18.613756 | LOOP [upload-logs : Compress console log and json output]
2026-08-06 17:27:18.667540 | localhost | skipping: Conditional result was False
2026-08-06 17:27:18.737913 | localhost | skipping: Conditional result was False
2026-08-06 17:27:18.764698 | 
2026-08-06 17:27:18.764920 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-06 17:27:18.811650 | localhost | skipping: Conditional result was False
2026-08-06 17:27:18.812134 | 
2026-08-06 17:27:18.816492 | localhost | skipping: Conditional result was False
2026-08-06 17:27:18.830216 | 
2026-08-06 17:27:18.830414 | LOOP [upload-logs : Upload console log and json output]