2026-08-22 09:44:11.572238 | Job console starting
2026-08-22 09:44:11.589740 | Updating git repos
2026-08-22 09:44:11.633539 | Cloning repos into workspace
2026-08-22 09:44:11.676305 | Restoring repo states
2026-08-22 09:44:11.695934 | Merging changes
2026-08-22 09:44:12.299322 | Checking out repos
2026-08-22 09:44:12.344643 | Preparing playbooks
2026-08-22 09:44:15.883887 | Running Ansible setup
2026-08-22 09:44:20.425036 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 09:44:21.091130 | 
2026-08-22 09:44:21.091744 | PLAY [localhost]
2026-08-22 09:44:21.100122 | 
2026-08-22 09:44:21.100197 | TASK [Gathering Facts]
2026-08-22 09:44:21.985274 | localhost | ok
2026-08-22 09:44:21.994453 | 
2026-08-22 09:44:21.994540 | TASK [Setup log path fact]
2026-08-22 09:44:22.015654 | localhost | ok
2026-08-22 09:44:22.031734 | 
2026-08-22 09:44:22.031817 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 09:44:22.064251 | localhost | ok
2026-08-22 09:44:22.072788 | 
2026-08-22 09:44:22.072867 | TASK [emit-job-header : Print job information]
2026-08-22 09:44:22.113459 | # Job Information
2026-08-22 09:44:22.113685 | Ansible Version: 2.16.18
2026-08-22 09:44:22.113749 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-08-22 09:44:22.113800 | Pipeline: check
2026-08-22 09:44:22.113845 | Executor: 2d72f0692154
2026-08-22 09:44:22.113889 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/298
2026-08-22 09:44:22.113937 | Event ID: d2568e00-9e0c-11f1-9788-11ee75b72ba0
2026-08-22 09:44:22.118506 | 
2026-08-22 09:44:22.118601 | LOOP [emit-job-header : Print node information]
2026-08-22 09:44:22.205975 | localhost | ok:
2026-08-22 09:44:22.206230 | localhost | # Node Information
2026-08-22 09:44:22.206276 | localhost | Inventory Hostname: controller
2026-08-22 09:44:22.206319 | localhost | Hostname: np0000190508
2026-08-22 09:44:22.206357 | localhost | Username: zuul
2026-08-22 09:44:22.206403 | localhost | Distro: Debian 13.6
2026-08-22 09:44:22.206440 | localhost | Provider: yul1
2026-08-22 09:44:22.206475 | localhost | Region: ca-ymq-1
2026-08-22 09:44:22.206509 | localhost | Label: debian-trixie
2026-08-22 09:44:22.206545 | localhost | Product Name: OpenStack Nova
2026-08-22 09:44:22.206580 | localhost | Interface IP: 199.204.45.109
2026-08-22 09:44:22.217624 | 
2026-08-22 09:44:22.217780 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 09:44:22.627880 | localhost -> localhost | changed
2026-08-22 09:44:22.636421 | 
2026-08-22 09:44:22.636543 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 09:44:23.461354 | localhost -> localhost | changed
2026-08-22 09:44:23.467953 | 
2026-08-22 09:44:23.468012 | PLAY [all]
2026-08-22 09:44:23.480745 | 
2026-08-22 09:44:23.480813 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 09:44:23.717098 | controller -> localhost | ok
2026-08-22 09:44:23.723593 | 
2026-08-22 09:44:23.723677 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 09:44:23.753911 | controller | ok
2026-08-22 09:44:23.770126 | controller | included: /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 09:44:23.775203 | 
2026-08-22 09:44:23.775265 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 09:44:24.749699 | controller -> localhost | Generating public/private rsa key pair.
2026-08-22 09:44:24.749976 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/d0ea5da880c045ceabeb9414e1a772fd_id_rsa
2026-08-22 09:44:24.750007 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/d0ea5da880c045ceabeb9414e1a772fd_id_rsa.pub
2026-08-22 09:44:24.750030 | controller -> localhost | The key fingerprint is:
2026-08-22 09:44:24.750051 | controller -> localhost | SHA256:WpMa6ERJjFx/Su2Yufu9xyEii81anngDCSDFR93LLYY zuul-build-sshkey
2026-08-22 09:44:24.750089 | controller -> localhost | The key's randomart image is:
2026-08-22 09:44:24.750110 | controller -> localhost | +---[RSA 3072]----+
2026-08-22 09:44:24.750136 | controller -> localhost | | +.=+. .         |
2026-08-22 09:44:24.750159 | controller -> localhost | |o +.oo...        |
2026-08-22 09:44:24.750179 | controller -> localhost | |.. .o oooo       |
2026-08-22 09:44:24.750199 | controller -> localhost | |  .. oEB=..      |
2026-08-22 09:44:24.750219 | controller -> localhost | |   .o.*.S.       |
2026-08-22 09:44:24.750238 | controller -> localhost | |   oo .*... .    |
2026-08-22 09:44:24.750257 | controller -> localhost | |    .==o . o .   |
2026-08-22 09:44:24.750277 | controller -> localhost | |    .+*o .  o    |
2026-08-22 09:44:24.750298 | controller -> localhost | |    oo+o. oo     |
2026-08-22 09:44:24.750318 | controller -> localhost | +----[SHA256]-----+
2026-08-22 09:44:24.750371 | controller -> localhost | ok: Runtime: 0:00:00.563571
2026-08-22 09:44:24.754663 | 
2026-08-22 09:44:24.754726 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 09:44:24.783160 | controller | ok
2026-08-22 09:44:24.790918 | controller | included: /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 09:44:24.797286 | 
2026-08-22 09:44:24.797353 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 09:44:24.822309 | controller | skipping: Conditional result was False
2026-08-22 09:44:24.827632 | 
2026-08-22 09:44:24.827718 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 09:44:25.373847 | controller | changed
2026-08-22 09:44:25.377853 | 
2026-08-22 09:44:25.377918 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 09:44:25.593123 | controller | ok
2026-08-22 09:44:25.597843 | 
2026-08-22 09:44:25.597907 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 09:44:26.128415 | controller | changed
2026-08-22 09:44:26.134847 | 
2026-08-22 09:44:26.134936 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 09:44:26.704444 | controller | changed
2026-08-22 09:44:26.710412 | 
2026-08-22 09:44:26.710497 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 09:44:26.735855 | controller | skipping: Conditional result was False
2026-08-22 09:44:26.742703 | 
2026-08-22 09:44:26.742797 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 09:44:27.114567 | controller -> localhost | changed
2026-08-22 09:44:27.131137 | 
2026-08-22 09:44:27.131212 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 09:44:27.425985 | controller -> localhost | Identity added: /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/d0ea5da880c045ceabeb9414e1a772fd_id_rsa (zuul-build-sshkey)
2026-08-22 09:44:27.426232 | controller -> localhost | ok: Runtime: 0:00:00.014370
2026-08-22 09:44:27.431772 | 
2026-08-22 09:44:27.431855 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 09:44:27.789618 | controller | ok
2026-08-22 09:44:27.793911 | 
2026-08-22 09:44:27.793976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 09:44:27.820585 | controller | skipping: Conditional result was False
2026-08-22 09:44:27.829675 | 
2026-08-22 09:44:27.829739 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 09:44:28.203604 | controller | ok
2026-08-22 09:44:28.208495 | 
2026-08-22 09:44:28.208560 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 09:44:29.164914 | controller | Output suppressed because no_log was given
2026-08-22 09:44:29.172175 | 
2026-08-22 09:44:29.172256 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 09:44:29.383857 | controller | ok: "logs"
2026-08-22 09:44:29.384195 | controller | ok: All items complete
2026-08-22 09:44:29.384240 | 
2026-08-22 09:44:29.567217 | controller | ok: "artifacts"
2026-08-22 09:44:29.765102 | controller | ok: "docs"
2026-08-22 09:44:29.783205 | 
2026-08-22 09:44:29.783381 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 09:44:30.016526 | controller | changed: "logs"
2026-08-22 09:44:30.213520 | controller | changed: "artifacts"
2026-08-22 09:44:30.394196 | controller | changed: "docs"
2026-08-22 09:44:30.405585 | 
2026-08-22 09:44:30.405728 | PLAY RECAP
2026-08-22 09:44:30.405783 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 09:44:30.405812 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 09:44:30.405837 | 
2026-08-22 09:44:30.581530 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 09:44:30.584504 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 09:44:31.214034 | 
2026-08-22 09:44:31.214190 | PLAY [all]
2026-08-22 09:44:31.224850 | 
2026-08-22 09:44:31.225037 | TASK [setup-uv : Extract archive]
2026-08-22 09:44:33.664284 | controller | changed
2026-08-22 09:44:33.671161 | 
2026-08-22 09:44:33.671287 | TASK [setup-uv : Print version]
2026-08-22 09:44:34.027577 | controller | uv 0.8.13
2026-08-22 09:44:34.200636 | controller | ok: Runtime: 0:00:00.014713
2026-08-22 09:44:34.209204 | 
2026-08-22 09:44:34.209317 | TASK [Install Ansible collection siblings]
2026-08-22 09:44:34.618538 | controller | ok:
2026-08-22 09:44:34.618875 | controller | Skipping ansible.posix: no checked-out sibling
2026-08-22 09:44:34.618944 | controller | Skipping community.crypto: no checked-out sibling
2026-08-22 09:44:34.618995 | controller | Skipping community.general: no checked-out sibling
2026-08-22 09:44:34.619042 | controller | Skipping kubernetes.core: no checked-out sibling
2026-08-22 09:44:34.619103 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-08-22 09:44:34.622618 | 
2026-08-22 09:44:34.622753 | PLAY RECAP
2026-08-22 09:44:34.622851 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 09:44:34.622902 | 
2026-08-22 09:44:34.768692 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 09:44:34.772644 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-22 09:44:35.423432 | 
2026-08-22 09:44:35.423566 | PLAY [all]
2026-08-22 09:44:35.433863 | 
2026-08-22 09:44:35.433934 | TASK [Update apt cache]
2026-08-22 09:44:40.212917 | controller | ok
2026-08-22 09:44:40.217385 | 
2026-08-22 09:44:40.217469 | TASK [Disable firewalld]
2026-08-22 09:44:40.233518 | controller | skipping: Conditional result was False
2026-08-22 09:44:40.243108 | 
2026-08-22 09:44:40.243180 | TASK [Install "jq" for log collection]
2026-08-22 09:44:42.289060 | controller | changed
2026-08-22 09:44:42.291518 | 
2026-08-22 09:44:42.291585 | PLAY RECAP
2026-08-22 09:44:42.291648 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 09:44:42.291679 | 
2026-08-22 09:44:42.464935 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-22 09:44:42.467851 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 09:44:43.083323 | 
2026-08-22 09:44:43.083474 | PLAY [all]
2026-08-22 09:44:43.093349 | 
2026-08-22 09:44:43.093425 | LOOP [Check inventory directories]
2026-08-22 09:44:43.467658 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-22 09:44:43.647874 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory"
2026-08-22 09:44:43.821845 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory"
2026-08-22 09:44:43.835633 | 
2026-08-22 09:44:43.836058 | LOOP [Copy inventory file for Zuul]
2026-08-22 09:44:44.716200 | controller | changed:
2026-08-22 09:44:44.716486 | controller | {
2026-08-22 09:44:44.716531 | controller |   "ansible_loop_var": "item",
2026-08-22 09:44:44.716567 | controller |   "changed": false,
2026-08-22 09:44:44.716598 | controller |   "failed": false,
2026-08-22 09:44:44.716633 | controller |   "invocation": {
2026-08-22 09:44:44.716661 | controller |     "module_args": {
2026-08-22 09:44:44.716689 | controller |       "checksum_algorithm": "sha1",
2026-08-22 09:44:44.716717 | controller |       "follow": true,
2026-08-22 09:44:44.716745 | controller |       "get_attributes": true,
2026-08-22 09:44:44.716785 | controller |       "get_checksum": true,
2026-08-22 09:44:44.716826 | controller |       "get_mime": true,
2026-08-22 09:44:44.716856 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-22 09:44:44.716886 | controller |     }
2026-08-22 09:44:44.716920 | controller |   },
2026-08-22 09:44:44.717810 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-22 09:44:44.717885 | controller |   "stat": {
2026-08-22 09:44:44.717924 | controller |     "atime": 1787391869.0284684,
2026-08-22 09:44:44.717959 | controller |     "attr_flags": "e",
2026-08-22 09:44:44.717992 | controller |     "attributes": [
2026-08-22 09:44:44.718020 | controller |       "extents"
2026-08-22 09:44:44.718048 | controller |     ],
2026-08-22 09:44:44.718075 | controller |     "block_size": 4096,
2026-08-22 09:44:44.718101 | controller |     "blocks": 8,
2026-08-22 09:44:44.718128 | controller |     "charset": "unknown",
2026-08-22 09:44:44.718157 | controller |     "ctime": 1787391869.0524683,
2026-08-22 09:44:44.718185 | controller |     "dev": 65025,
2026-08-22 09:44:44.718211 | controller |     "device_type": 0,
2026-08-22 09:44:44.718237 | controller |     "executable": true,
2026-08-22 09:44:44.718263 | controller |     "exists": true,
2026-08-22 09:44:44.718288 | controller |     "gid": 1000,
2026-08-22 09:44:44.718316 | controller |     "gr_name": "zuul",
2026-08-22 09:44:44.718341 | controller |     "inode": 520215,
2026-08-22 09:44:44.718367 | controller |     "isblk": false,
2026-08-22 09:44:44.718394 | controller |     "ischr": false,
2026-08-22 09:44:44.718420 | controller |     "isdir": true,
2026-08-22 09:44:44.718446 | controller |     "isfifo": false,
2026-08-22 09:44:44.718472 | controller |     "isgid": false,
2026-08-22 09:44:44.718497 | controller |     "islnk": false,
2026-08-22 09:44:44.718523 | controller |     "isreg": false,
2026-08-22 09:44:44.718549 | controller |     "issock": false,
2026-08-22 09:44:44.718575 | controller |     "isuid": false,
2026-08-22 09:44:44.718600 | controller |     "mimetype": "unknown",
2026-08-22 09:44:44.718625 | controller |     "mode": "0755",
2026-08-22 09:44:44.718650 | controller |     "mtime": 1787391852.2535338,
2026-08-22 09:44:44.718675 | controller |     "nlink": 15,
2026-08-22 09:44:44.718701 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-22 09:44:44.718726 | controller |     "pw_name": "zuul",
2026-08-22 09:44:44.718760 | controller |     "readable": true,
2026-08-22 09:44:44.718798 | controller |     "rgrp": true,
2026-08-22 09:44:44.718828 | controller |     "roth": true,
2026-08-22 09:44:44.718855 | controller |     "rusr": true,
2026-08-22 09:44:44.718882 | controller |     "size": 4096,
2026-08-22 09:44:44.718908 | controller |     "uid": 1000,
2026-08-22 09:44:44.718934 | controller |     "version": "4179862119",
2026-08-22 09:44:44.718961 | controller |     "wgrp": false,
2026-08-22 09:44:44.718989 | controller |     "woth": false,
2026-08-22 09:44:44.719018 | controller |     "writeable": true,
2026-08-22 09:44:44.719060 | controller |     "wusr": true,
2026-08-22 09:44:44.719360 | controller |     "xgrp": true,
2026-08-22 09:44:44.719404 | controller |     "xoth": true,
2026-08-22 09:44:44.719442 | controller |     "xusr": true
2026-08-22 09:44:44.719585 | controller |   }
2026-08-22 09:44:44.720428 | controller | }
2026-08-22 09:44:44.720490 | controller | ok: All items complete
2026-08-22 09:44:44.720524 | 
2026-08-22 09:44:44.722148 | controller | skipping: Conditional result was False
2026-08-22 09:44:44.722796 | controller | skipping: Conditional result was False
2026-08-22 09:44:44.740446 | 
2026-08-22 09:44:44.740633 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 09:44:45.098997 | controller | changed: 1 replacements made
2026-08-22 09:44:45.101068 | controller | skipping: Conditional result was False
2026-08-22 09:44:45.103410 | controller | skipping: Conditional result was False
2026-08-22 09:44:45.119991 | 
2026-08-22 09:44:45.120157 | TASK [Run Molecule scenario]
2026-08-22 09:44:45.581415 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-08-22 09:44:45.581589 | controller | Creating virtual environment at: .venv
2026-08-22 09:44:45.846072 | controller | Downloading cryptography (4.3MiB)
2026-08-22 09:44:45.846390 | controller | Downloading ansible-core (2.3MiB)
2026-08-22 09:44:45.847418 | controller | Downloading pygments (1.2MiB)
2026-08-22 09:44:46.012101 | controller |  Downloading cryptography
2026-08-22 09:44:46.060482 | controller |  Downloading pygments
2026-08-22 09:44:46.211598 | controller |  Downloading ansible-core
2026-08-22 09:44:46.259487 | controller | Installed 36 packages in 47ms
2026-08-22 09:44:46.929521 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-08-22 09:44:46.929621 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-22 09:44:47.797269 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-08-22 09:44:47.797343 | controller | INFO     default scenario not found, disabling shared state.
2026-08-22 09:44:47.797425 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 09:44:47.797495 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-08-22 09:45:07.869360 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-08-22 09:45:07.869447 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-08-22 09:45:07.869559 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-08-22 09:45:07.869668 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 09:45:07.874946 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-08-22 09:45:07.875262 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 09:45:07.880615 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-08-22 09:45:07.880707 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-08-22 09:45:07.880720 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-08-22 09:45:07.885835 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-08-22 09:45:08.745704 | controller |
2026-08-22 09:45:08.745978 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-08-22 09:45:08.813873 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-08-22 09:45:08.825472 | controller | INFO     [upload-helm-chart > create] Executing
2026-08-22 09:45:08.826887 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 09:45:08.832208 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-08-22 09:45:08.832482 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 09:45:08.837712 | controller | INFO     [upload-helm-chart > converge] Executing
2026-08-22 09:45:09.688936 | controller |
2026-08-22 09:45:09.689009 | controller | PLAY [Converge] ****************************************************************
2026-08-22 09:45:09.689150 | controller |
2026-08-22 09:45:09.689280 | controller | TASK [Gathering Facts] *********************************************************
2026-08-22 09:45:09.689413 | controller | Saturday 22 August 2026  09:45:09 +0000 (0:00:00.031)       0:00:00.031 *******
2026-08-22 09:45:11.990788 | 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-22 09:45:11.996226 | controller | ok: [controller]
2026-08-22 09:45:11.996414 | controller |
2026-08-22 09:45:11.996647 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:11.996834 | controller | Saturday 22 August 2026  09:45:11 +0000 (0:00:02.307)       0:00:02.338 *******
2026-08-22 09:45:12.093550 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-08-22 09:45:12.093712 | controller |
2026-08-22 09:45:12.093931 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-08-22 09:45:12.094137 | controller | Saturday 22 August 2026  09:45:12 +0000 (0:00:00.096)       0:00:02.435 *******
2026-08-22 09:45:12.787098 | controller | changed: [controller]
2026-08-22 09:45:12.787243 | controller |
2026-08-22 09:45:12.787498 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:12.787820 | controller | Saturday 22 August 2026  09:45:12 +0000 (0:00:00.693)       0:00:03.129 *******
2026-08-22 09:45:12.833217 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-08-22 09:45:12.833388 | controller |
2026-08-22 09:45:12.833592 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-08-22 09:45:12.833843 | controller | Saturday 22 August 2026  09:45:12 +0000 (0:00:00.046)       0:00:03.175 *******
2026-08-22 09:45:13.250985 | controller | changed: [controller]
2026-08-22 09:45:13.251010 | controller |
2026-08-22 09:45:13.251017 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-08-22 09:45:13.251023 | controller | Saturday 22 August 2026  09:45:13 +0000 (0:00:00.415)       0:00:03.590 *******
2026-08-22 09:45:14.358808 | controller | changed: [controller]
2026-08-22 09:45:14.358919 | controller |
2026-08-22 09:45:14.359119 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-08-22 09:45:14.359306 | controller | Saturday 22 August 2026  09:45:14 +0000 (0:00:01.105)       0:00:04.696 *******
2026-08-22 09:45:14.756774 | controller | ok: [controller]
2026-08-22 09:45:14.756864 | controller |
2026-08-22 09:45:14.757064 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-08-22 09:45:14.757264 | controller | Saturday 22 August 2026  09:45:14 +0000 (0:00:00.402)       0:00:05.098 *******
2026-08-22 09:45:14.811027 | controller | skipping: [controller]
2026-08-22 09:45:14.811095 | controller |
2026-08-22 09:45:14.811141 | controller | PLAY RECAP *********************************************************************
2026-08-22 09:45:14.811255 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 09:45:14.811346 | controller |
2026-08-22 09:45:14.811407 | controller |
2026-08-22 09:45:14.811513 | controller | TASKS RECAP ********************************************************************
2026-08-22 09:45:14.811590 | controller | Saturday 22 August 2026  09:45:14 +0000 (0:00:00.055)       0:00:05.154 *******
2026-08-22 09:45:14.811672 | controller | ===============================================================================
2026-08-22 09:45:14.811784 | controller | Gathering Facts --------------------------------------------------------- 2.31s
2026-08-22 09:45:14.811879 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s
2026-08-22 09:45:14.811969 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.69s
2026-08-22 09:45:14.812081 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-08-22 09:45:14.812143 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-08-22 09:45:14.812233 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s
2026-08-22 09:45:14.812325 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-08-22 09:45:14.812417 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-08-22 09:45:14.920454 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-08-22 09:45:14.926032 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-08-22 09:45:15.756582 | controller |
2026-08-22 09:45:15.756645 | controller | PLAY [Converge] ****************************************************************
2026-08-22 09:45:15.756650 | controller |
2026-08-22 09:45:15.756656 | controller | TASK [Gathering Facts] *********************************************************
2026-08-22 09:45:15.756679 | controller | Saturday 22 August 2026  09:45:15 +0000 (0:00:00.010)       0:00:00.010 *******
2026-08-22 09:45:16.812096 | 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-22 09:45:16.818949 | controller | ok: [controller]
2026-08-22 09:45:16.819053 | controller |
2026-08-22 09:45:16.819186 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:16.819310 | controller | Saturday 22 August 2026  09:45:16 +0000 (0:00:01.063)       0:00:01.074 *******
2026-08-22 09:45:16.896496 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-08-22 09:45:16.896688 | controller |
2026-08-22 09:45:16.896888 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-08-22 09:45:16.897084 | controller | Saturday 22 August 2026  09:45:16 +0000 (0:00:00.077)       0:00:01.151 *******
2026-08-22 09:45:17.545409 | controller | ok: [controller]
2026-08-22 09:45:17.545518 | controller |
2026-08-22 09:45:17.545746 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:17.545948 | controller | Saturday 22 August 2026  09:45:17 +0000 (0:00:00.648)       0:00:01.800 *******
2026-08-22 09:45:17.589913 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-08-22 09:45:17.590079 | controller |
2026-08-22 09:45:17.590281 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-08-22 09:45:17.590476 | controller | Saturday 22 August 2026  09:45:17 +0000 (0:00:00.045)       0:00:01.845 *******
2026-08-22 09:45:18.029666 | controller | ok: [controller]
2026-08-22 09:45:18.029743 | controller |
2026-08-22 09:45:18.029978 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-08-22 09:45:18.030182 | controller | Saturday 22 August 2026  09:45:18 +0000 (0:00:00.438)       0:00:02.284 *******
2026-08-22 09:45:20.129185 | controller | ok: [controller]
2026-08-22 09:45:20.129255 | controller |
2026-08-22 09:45:20.129386 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-08-22 09:45:20.129600 | controller | Saturday 22 August 2026  09:45:20 +0000 (0:00:02.099)       0:00:04.383 *******
2026-08-22 09:45:20.540031 | controller | ok: [controller]
2026-08-22 09:45:20.540143 | controller |
2026-08-22 09:45:20.540419 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-08-22 09:45:20.540638 | controller | Saturday 22 August 2026  09:45:20 +0000 (0:00:00.411)       0:00:04.794 *******
2026-08-22 09:45:20.582039 | controller | skipping: [controller]
2026-08-22 09:45:20.582243 | controller |
2026-08-22 09:45:20.582524 | controller | PLAY RECAP *********************************************************************
2026-08-22 09:45:20.582854 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 09:45:20.583105 | controller |
2026-08-22 09:45:20.583354 | controller |
2026-08-22 09:45:20.583628 | controller | TASKS RECAP ********************************************************************
2026-08-22 09:45:20.583977 | controller | Saturday 22 August 2026  09:45:20 +0000 (0:00:00.043)       0:00:04.837 *******
2026-08-22 09:45:20.584270 | controller | ===============================================================================
2026-08-22 09:45:20.584539 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.10s
2026-08-22 09:45:20.584802 | controller | Gathering Facts --------------------------------------------------------- 1.06s
2026-08-22 09:45:20.585057 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.65s
2026-08-22 09:45:20.585276 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-08-22 09:45:20.587824 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-08-22 09:45:20.587882 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-08-22 09:45:20.587887 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-08-22 09:45:20.587891 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-08-22 09:45:20.667833 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-08-22 09:45:20.707372 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-08-22 09:45:21.555203 | controller |
2026-08-22 09:45:21.555526 | controller | PLAY [Side effect] *************************************************************
2026-08-22 09:45:21.555817 | controller |
2026-08-22 09:45:21.556128 | controller | TASK [Gathering Facts] *********************************************************
2026-08-22 09:45:21.556391 | controller | Saturday 22 August 2026  09:45:21 +0000 (0:00:00.011)       0:00:00.011 *******
2026-08-22 09:45:22.584250 | 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-22 09:45:22.592300 | controller | ok: [controller]
2026-08-22 09:45:22.592376 | controller |
2026-08-22 09:45:22.592479 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:22.592571 | controller | Saturday 22 August 2026  09:45:22 +0000 (0:00:01.034)       0:00:01.046 *******
2026-08-22 09:45:22.670105 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-08-22 09:45:22.670158 | controller |
2026-08-22 09:45:22.670177 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-08-22 09:45:22.670258 | controller | Saturday 22 August 2026  09:45:22 +0000 (0:00:00.079)       0:00:01.126 *******
2026-08-22 09:45:23.329349 | controller | changed: [controller]
2026-08-22 09:45:23.329417 | controller |
2026-08-22 09:45:23.329537 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-08-22 09:45:23.329661 | controller | Saturday 22 August 2026  09:45:23 +0000 (0:00:00.659)       0:00:01.785 *******
2026-08-22 09:45:23.373095 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-08-22 09:45:23.373138 | controller |
2026-08-22 09:45:23.373147 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-08-22 09:45:23.373155 | controller | Saturday 22 August 2026  09:45:23 +0000 (0:00:00.041)       0:00:01.826 *******
2026-08-22 09:45:23.788176 | controller | ok: [controller]
2026-08-22 09:45:23.788235 | controller |
2026-08-22 09:45:23.788301 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-08-22 09:45:23.788389 | controller | Saturday 22 August 2026  09:45:23 +0000 (0:00:00.415)       0:00:02.242 *******
2026-08-22 09:45:24.985547 | controller | ok: [controller]
2026-08-22 09:45:24.985610 | controller |
2026-08-22 09:45:24.985878 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-08-22 09:45:24.985906 | controller | Saturday 22 August 2026  09:45:24 +0000 (0:00:01.197)       0:00:03.439 *******
2026-08-22 09:45:25.404604 | controller | ok: [controller]
2026-08-22 09:45:25.404894 | controller |
2026-08-22 09:45:25.405173 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-08-22 09:45:25.405430 | controller | Saturday 22 August 2026  09:45:25 +0000 (0:00:00.418)       0:00:03.858 *******
2026-08-22 09:45:25.732293 | controller | changed: [controller] => (item=/file)
2026-08-22 09:45:25.732368 | controller |
2026-08-22 09:45:25.732433 | controller | PLAY RECAP *********************************************************************
2026-08-22 09:45:25.732564 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-22 09:45:25.732640 | controller |
2026-08-22 09:45:25.732724 | controller |
2026-08-22 09:45:25.732824 | controller | TASKS RECAP ********************************************************************
2026-08-22 09:45:25.732920 | controller | Saturday 22 August 2026  09:45:25 +0000 (0:00:00.327)       0:00:04.185 *******
2026-08-22 09:45:25.733004 | controller | ===============================================================================
2026-08-22 09:45:25.733104 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.20s
2026-08-22 09:45:25.733198 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2026-08-22 09:45:25.733279 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.66s
2026-08-22 09:45:25.733369 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-08-22 09:45:25.733459 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-08-22 09:45:25.733557 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.33s
2026-08-22 09:45:25.733647 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-08-22 09:45:25.733740 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-08-22 09:45:25.827964 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-08-22 09:45:25.838182 | controller | INFO     [upload-helm-chart > verify] Executing
2026-08-22 09:45:26.720229 | controller |
2026-08-22 09:45:26.720297 | controller | PLAY [Verify] ******************************************************************
2026-08-22 09:45:26.720513 | controller |
2026-08-22 09:45:26.720714 | controller | TASK [Gathering Facts] *********************************************************
2026-08-22 09:45:26.720878 | controller | Saturday 22 August 2026  09:45:26 +0000 (0:00:00.010)       0:00:00.010 *******
2026-08-22 09:45:28.795888 | 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-22 09:45:28.803371 | controller | ok: [controller]
2026-08-22 09:45:28.803550 | controller |
2026-08-22 09:45:28.803774 | controller | TASK [Stat file 1] *************************************************************
2026-08-22 09:45:28.804061 | controller | Saturday 22 August 2026  09:45:28 +0000 (0:00:02.082)       0:00:02.093 *******
2026-08-22 09:45:29.239440 | controller | ok: [controller]
2026-08-22 09:45:29.239500 | controller |
2026-08-22 09:45:29.239840 | controller | TASK [Stat file 2] *************************************************************
2026-08-22 09:45:29.240077 | controller | Saturday 22 August 2026  09:45:29 +0000 (0:00:00.435)       0:00:02.529 *******
2026-08-22 09:45:29.559829 | controller | ok: [controller]
2026-08-22 09:45:29.559887 | controller |
2026-08-22 09:45:29.560188 | controller | TASK [Stat removed file 1] *****************************************************
2026-08-22 09:45:29.560223 | controller | Saturday 22 August 2026  09:45:29 +0000 (0:00:00.321)       0:00:02.850 *******
2026-08-22 09:45:29.892158 | controller | ok: [controller]
2026-08-22 09:45:29.892231 | controller |
2026-08-22 09:45:29.892300 | controller | TASK [Stat removed file 2] *****************************************************
2026-08-22 09:45:29.892451 | controller | Saturday 22 August 2026  09:45:29 +0000 (0:00:00.328)       0:00:03.178 *******
2026-08-22 09:45:30.183815 | controller | ok: [controller]
2026-08-22 09:45:30.183894 | controller |
2026-08-22 09:45:30.184127 | controller | TASK [ansible.builtin.assert] **************************************************
2026-08-22 09:45:30.184158 | controller | Saturday 22 August 2026  09:45:30 +0000 (0:00:00.295)       0:00:03.474 *******
2026-08-22 09:45:30.220131 | controller | ok: [controller] => {
2026-08-22 09:45:30.220403 | controller |     "changed": false,
2026-08-22 09:45:30.220657 | controller |     "msg": "All assertions passed"
2026-08-22 09:45:30.220898 | controller | }
2026-08-22 09:45:30.221127 | controller |
2026-08-22 09:45:30.221369 | controller | PLAY RECAP *********************************************************************
2026-08-22 09:45:30.221633 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-08-22 09:45:30.221860 | controller |
2026-08-22 09:45:30.222093 | controller |
2026-08-22 09:45:30.222333 | controller | TASKS RECAP ********************************************************************
2026-08-22 09:45:30.222578 | controller | Saturday 22 August 2026  09:45:30 +0000 (0:00:00.034)       0:00:03.508 *******
2026-08-22 09:45:30.222814 | controller | ===============================================================================
2026-08-22 09:45:30.223054 | controller | Gathering Facts --------------------------------------------------------- 2.08s
2026-08-22 09:45:30.223300 | controller | Stat file 1 ------------------------------------------------------------- 0.44s
2026-08-22 09:45:30.223558 | controller | Stat removed file 1 ----------------------------------------------------- 0.33s
2026-08-22 09:45:30.223852 | controller | Stat file 2 ------------------------------------------------------------- 0.32s
2026-08-22 09:45:30.224136 | controller | Stat removed file 2 ----------------------------------------------------- 0.30s
2026-08-22 09:45:30.224405 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-08-22 09:45:30.365955 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-08-22 09:45:30.376324 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-08-22 09:45:30.376564 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 09:45:30.381826 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-08-22 09:45:30.381874 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-08-22 09:45:30.381978 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-08-22 09:45:30.382230 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-08-22 09:45:30.701600 | controller | ok: Runtime: 0:00:44.960163
2026-08-22 09:45:30.707281 | 
2026-08-22 09:45:30.707357 | PLAY RECAP
2026-08-22 09:45:30.707427 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 09:45:30.707470 | 
2026-08-22 09:45:30.883136 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 09:45:31.018990 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-22 09:45:31.713387 | 
2026-08-22 09:45:31.713518 | PLAY [all]
2026-08-22 09:45:31.724563 | 
2026-08-22 09:45:31.724650 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 09:45:32.183818 | controller | changed
2026-08-22 09:45:32.227126 | 
2026-08-22 09:45:32.227381 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 09:45:32.676326 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 09:45:32.676777 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 09:45:32.684403 | controller | environment: line 1: kubectl: command not found
2026-08-22 09:45:32.685935 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 09:45:32.687473 | controller | environment: line 1: kubectl: command not found
2026-08-22 09:45:32.688757 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 09:45:32.691819 | controller | environment: line 1: kubectl: command not found
2026-08-22 09:45:32.693656 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 09:45:32.695433 | controller | environment: line 1: kubectl: command not found
2026-08-22 09:45:32.697766 | controller | environment: line 1: kubectl: command not found
2026-08-22 09:45:32.697784 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 09:45:32.698817 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 09:45:32.767309 | controller | ok: Runtime: 0:00:00.037653
2026-08-22 09:45:32.772804 | 
2026-08-22 09:45:32.772875 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 09:45:33.007192 | controller | changed
2026-08-22 09:45:33.015434 | 
2026-08-22 09:45:33.015519 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 09:45:33.252701 | controller | environment: line 5: kubectl: command not found
2026-08-22 09:45:33.253131 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 09:45:33.254411 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 09:45:33.255534 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 09:45:33.546144 | controller | ok: Runtime: 0:00:00.015216
2026-08-22 09:45:33.553131 | 
2026-08-22 09:45:33.553232 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 09:45:34.280637 | controller | changed:
2026-08-22 09:45:34.280878 | controller | created directory /var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/logs/controller
2026-08-22 09:45:34.280970 | controller | cd+++++++++ objects/
2026-08-22 09:45:34.281027 | controller | cd+++++++++ objects/cluster/
2026-08-22 09:45:34.281078 | controller | cd+++++++++ objects/namespaced/
2026-08-22 09:45:34.290010 | 
2026-08-22 09:45:34.290074 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 09:45:34.551037 | controller | changed
2026-08-22 09:45:34.555059 | 
2026-08-22 09:45:34.555129 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 09:45:34.797333 | controller | changed
2026-08-22 09:45:34.802226 | 
2026-08-22 09:45:34.802296 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 09:45:35.046638 | controller | environment: line 3: kubectl: command not found
2026-08-22 09:45:35.333243 | controller | ok: Runtime: 0:00:00.014150
2026-08-22 09:45:35.338234 | 
2026-08-22 09:45:35.338297 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 09:45:35.948169 | controller | changed:
2026-08-22 09:45:35.948365 | controller | cd+++++++++ pod-logs/
2026-08-22 09:45:35.948403 | controller | cd+++++++++ pod-logs/failed-pods/
2026-08-22 09:45:35.958369 | 
2026-08-22 09:45:35.958438 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 09:45:36.224667 | controller | changed: "values"
2026-08-22 09:45:36.434274 | controller | changed: "releases"
2026-08-22 09:45:36.473897 | 
2026-08-22 09:45:36.474183 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 09:45:36.730943 | controller | /bin/bash: line 3: kubectl: command not found
2026-08-22 09:45:37.010935 | controller | ok: Runtime: 0:00:00.010313
2026-08-22 09:45:37.017532 | 
2026-08-22 09:45:37.017632 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 09:45:37.506361 | controller | changed:
2026-08-22 09:45:37.506693 | controller | cd+++++++++ helm/
2026-08-22 09:45:37.506791 | controller | cd+++++++++ helm/releases/
2026-08-22 09:45:37.506850 | controller | cd+++++++++ helm/values/
2026-08-22 09:45:37.513723 | 
2026-08-22 09:45:37.513791 | PLAY RECAP
2026-08-22 09:45:37.513852 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 09:45:37.513883 | 
2026-08-22 09:45:37.645481 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-22 09:45:37.876121 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 09:45:38.513679 | 
2026-08-22 09:45:38.513845 | PLAY [all]
2026-08-22 09:45:38.524387 | 
2026-08-22 09:45:38.524466 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 09:45:38.569644 | controller | skipping: Conditional result was False
2026-08-22 09:45:38.578004 | 
2026-08-22 09:45:38.578123 | TASK [fetch-output : Set log path for single node]
2026-08-22 09:45:38.620976 | controller | ok
2026-08-22 09:45:38.626375 | 
2026-08-22 09:45:38.626444 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 09:45:39.022857 | controller -> localhost | ok: "/var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/logs"
2026-08-22 09:45:39.260300 | controller -> localhost | changed: "/var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/artifacts"
2026-08-22 09:45:39.466365 | controller -> localhost | changed: "/var/lib/zuul/builds/d0ea5da880c045ceabeb9414e1a772fd/work/docs"
2026-08-22 09:45:39.483628 | 
2026-08-22 09:45:39.483821 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 09:45:40.136932 | controller | changed: .d..t...... ./
2026-08-22 09:45:40.137241 | controller | changed: All items complete
2026-08-22 09:45:40.137285 | 
2026-08-22 09:45:40.605188 | controller | changed: .d..t...... ./
2026-08-22 09:45:41.346608 | controller | changed: .d..t...... ./
2026-08-22 09:45:41.369126 | 
2026-08-22 09:45:41.369303 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 09:45:41.798925 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007652
2026-08-22 09:45:42.044806 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007141
2026-08-22 09:45:42.065299 | 
2026-08-22 09:45:42.065471 | PLAY [all]
2026-08-22 09:45:42.071321 | 
2026-08-22 09:45:42.071393 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 09:45:42.610416 | controller | changed
2026-08-22 09:45:42.617535 | 
2026-08-22 09:45:42.617604 | PLAY RECAP
2026-08-22 09:45:42.617667 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 09:45:42.617696 | 
2026-08-22 09:45:42.765572 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 09:45:42.768928 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 09:45:43.355237 | 
2026-08-22 09:45:43.355359 | PLAY [localhost]
2026-08-22 09:45:43.365492 | 
2026-08-22 09:45:43.365569 | TASK [Generate Zuul manifest]
2026-08-22 09:45:43.387389 | localhost | ok
2026-08-22 09:45:43.404307 | 
2026-08-22 09:45:43.404431 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 09:45:43.801361 | localhost | changed
2026-08-22 09:45:43.895604 | 
2026-08-22 09:45:43.895833 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 09:45:43.926544 | localhost | ok
2026-08-22 09:45:43.935602 | 
2026-08-22 09:45:43.935692 | TASK [Upload logs]
2026-08-22 09:45:43.961935 | localhost | ok
2026-08-22 09:45:44.027086 | 
2026-08-22 09:45:44.027241 | TASK [Set zuul-log-path fact]
2026-08-22 09:45:44.049945 | localhost | ok
2026-08-22 09:45:44.062945 | 
2026-08-22 09:45:44.063031 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 09:45:44.096833 | localhost | ok
2026-08-22 09:45:44.107618 | 
2026-08-22 09:45:44.107718 | TASK [upload-logs : Create log directories]
2026-08-22 09:45:44.677638 | localhost | changed
2026-08-22 09:45:44.684650 | 
2026-08-22 09:45:44.684746 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 09:45:45.113847 | localhost -> localhost | ok: Runtime: 0:00:00.006715
2026-08-22 09:45:45.119139 | 
2026-08-22 09:45:45.119206 | TASK [upload-logs : Upload logs to log server]
2026-08-22 09:45:45.629530 | localhost | Output suppressed because no_log was given
2026-08-22 09:45:45.634919 | 
2026-08-22 09:45:45.635013 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 09:45:45.683140 | localhost | skipping: Conditional result was False
2026-08-22 09:45:45.832203 | localhost | skipping: Conditional result was False
2026-08-22 09:45:45.841358 | 
2026-08-22 09:45:45.841535 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 09:45:45.887733 | localhost | skipping: Conditional result was False
2026-08-22 09:45:45.888318 | 
2026-08-22 09:45:45.891959 | localhost | skipping: Conditional result was False
2026-08-22 09:45:45.907925 | 
2026-08-22 09:45:45.908184 | LOOP [upload-logs : Upload console log and json output]