2026-10-21 12:47:20.022679 | Job console starting 2026-10-21 12:47:20.032479 | Updating git repos 2026-10-21 12:47:20.084414 | Cloning repos into workspace 2026-10-21 12:47:20.168056 | Restoring repo states 2026-10-21 12:47:20.185087 | Merging changes 2026-10-21 12:47:20.876927 | Checking out repos 2026-10-21 12:47:21.098286 | Preparing playbooks 2026-10-21 12:47:23.195090 | Running Ansible setup 2026-10-21 12:47:27.885204 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-21 12:47:28.509878 | 2026-10-21 12:47:28.510665 | PLAY [localhost] 2026-10-21 12:47:28.518909 | 2026-10-21 12:47:28.518991 | TASK [Gathering Facts] 2026-10-21 12:47:29.395006 | localhost | ok 2026-10-21 12:47:29.408911 | 2026-10-21 12:47:29.409130 | TASK [Setup log path fact] 2026-10-21 12:47:29.430792 | localhost | ok 2026-10-21 12:47:29.452109 | 2026-10-21 12:47:29.452225 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-21 12:47:29.483513 | localhost | ok 2026-10-21 12:47:29.498390 | 2026-10-21 12:47:29.498587 | TASK [emit-job-header : Print job information] 2026-10-21 12:47:29.550337 | # Job Information 2026-10-21 12:47:29.550588 | Ansible Version: 2.16.18 2026-10-21 12:47:29.550650 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-10-21 12:47:29.550693 | Pipeline: check 2026-10-21 12:47:29.550732 | Executor: 2d72f0692154 2026-10-21 12:47:29.550772 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/302 2026-10-21 12:47:29.550815 | Event ID: d97935c4-cd4c-11f1-83f3-08027d6310fe 2026-10-21 12:47:29.556378 | 2026-10-21 12:47:29.556548 | LOOP [emit-job-header : Print node information] 2026-10-21 12:47:29.656668 | localhost | ok: 2026-10-21 12:47:29.656986 | localhost | # Node Information 2026-10-21 12:47:29.657080 | localhost | Inventory Hostname: controller 2026-10-21 12:47:29.657157 | localhost | Hostname: np0000196256 2026-10-21 12:47:29.657225 | localhost | Username: zuul 2026-10-21 12:47:29.657301 | localhost | Distro: Debian 13.7 2026-10-21 12:47:29.657369 | localhost | Provider: yul1 2026-10-21 12:47:29.657430 | localhost | Region: ca-ymq-1 2026-10-21 12:47:29.657489 | localhost | Label: debian-trixie 2026-10-21 12:47:29.657548 | localhost | Product Name: OpenStack Nova 2026-10-21 12:47:29.657606 | localhost | Interface IP: 162.253.55.189 2026-10-21 12:47:29.669114 | 2026-10-21 12:47:29.719889 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-21 12:47:30.171007 | localhost -> localhost | changed 2026-10-21 12:47:30.176428 | 2026-10-21 12:47:30.176556 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-21 12:47:31.034680 | localhost -> localhost | changed 2026-10-21 12:47:31.046656 | 2026-10-21 12:47:31.046809 | PLAY [all] 2026-10-21 12:47:31.064752 | 2026-10-21 12:47:31.064995 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-21 12:47:31.302977 | controller -> localhost | ok 2026-10-21 12:47:31.316086 | 2026-10-21 12:47:31.316244 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-21 12:47:31.362490 | controller | ok 2026-10-21 12:47:31.392356 | controller | included: /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-21 12:47:31.399183 | 2026-10-21 12:47:31.399284 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-21 12:47:32.849493 | controller -> localhost | Generating public/private rsa key pair. 2026-10-21 12:47:32.849792 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/2f35b80321c843c2acc90de4e69a5794_id_rsa 2026-10-21 12:47:32.849850 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/2f35b80321c843c2acc90de4e69a5794_id_rsa.pub 2026-10-21 12:47:32.849892 | controller -> localhost | The key fingerprint is: 2026-10-21 12:47:32.849931 | controller -> localhost | SHA256:k5bEcAvf2+tCcxTu+42ztqjqSnmGPDH5hNXrMTCosHc zuul-build-sshkey 2026-10-21 12:47:32.850020 | controller -> localhost | The key's randomart image is: 2026-10-21 12:47:32.850082 | controller -> localhost | +---[RSA 3072]----+ 2026-10-21 12:47:32.850145 | controller -> localhost | | o . | 2026-10-21 12:47:32.850188 | controller -> localhost | | B + . | 2026-10-21 12:47:32.850225 | controller -> localhost | | . . O o. . | 2026-10-21 12:47:32.850263 | controller -> localhost | | o . = = +o | 2026-10-21 12:47:32.850300 | controller -> localhost | | . o E S =o. | 2026-10-21 12:47:32.850336 | controller -> localhost | | . o O oooo. | 2026-10-21 12:47:32.850372 | controller -> localhost | | * +..o.. | 2026-10-21 12:47:32.850408 | controller -> localhost | | . + ....oo | 2026-10-21 12:47:32.850450 | controller -> localhost | | .oo..ooo=+.| 2026-10-21 12:47:32.850487 | controller -> localhost | +----[SHA256]-----+ 2026-10-21 12:47:32.850579 | controller -> localhost | ok: Runtime: 0:00:00.985762 2026-10-21 12:47:32.858567 | 2026-10-21 12:47:32.858692 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-21 12:47:32.891232 | controller | ok 2026-10-21 12:47:32.905984 | controller | included: /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-21 12:47:32.918102 | 2026-10-21 12:47:32.918180 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-21 12:47:32.943472 | controller | skipping: Conditional result was False 2026-10-21 12:47:32.951922 | 2026-10-21 12:47:32.952070 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-21 12:47:33.538972 | controller | changed 2026-10-21 12:47:33.546753 | 2026-10-21 12:47:33.546876 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-21 12:47:33.788662 | controller | ok 2026-10-21 12:47:33.792458 | 2026-10-21 12:47:33.792537 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-21 12:47:34.340665 | controller | changed 2026-10-21 12:47:34.344210 | 2026-10-21 12:47:34.344265 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-21 12:47:34.892280 | controller | changed 2026-10-21 12:47:34.896671 | 2026-10-21 12:47:34.896748 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-21 12:47:34.909406 | controller | skipping: Conditional result was False 2026-10-21 12:47:34.917241 | 2026-10-21 12:47:34.917342 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-21 12:47:35.342042 | controller -> localhost | changed 2026-10-21 12:47:35.358886 | 2026-10-21 12:47:35.359031 | TASK [add-build-sshkey : Add back temp key] 2026-10-21 12:47:35.674755 | controller -> localhost | Identity added: /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/2f35b80321c843c2acc90de4e69a5794_id_rsa (zuul-build-sshkey) 2026-10-21 12:47:35.675069 | controller -> localhost | ok: Runtime: 0:00:00.014651 2026-10-21 12:47:35.682688 | 2026-10-21 12:47:35.682808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-21 12:47:36.029964 | controller | ok 2026-10-21 12:47:36.037807 | 2026-10-21 12:47:36.037960 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-21 12:47:36.084018 | controller | skipping: Conditional result was False 2026-10-21 12:47:36.098278 | 2026-10-21 12:47:36.098416 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-10-21 12:47:36.480483 | controller | ok 2026-10-21 12:47:36.489471 | 2026-10-21 12:47:36.489600 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-10-21 12:47:37.756363 | controller | Output suppressed because no_log was given 2026-10-21 12:47:37.769920 | 2026-10-21 12:47:37.770077 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-10-21 12:47:38.002220 | controller | ok: "logs" 2026-10-21 12:47:38.002708 | controller | ok: All items complete 2026-10-21 12:47:38.002793 | 2026-10-21 12:47:38.202958 | controller | ok: "artifacts" 2026-10-21 12:47:38.372136 | controller | ok: "docs" 2026-10-21 12:47:38.391984 | 2026-10-21 12:47:38.392186 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-10-21 12:47:38.606529 | controller | changed: "logs" 2026-10-21 12:47:38.784027 | controller | changed: "artifacts" 2026-10-21 12:47:38.983784 | controller | changed: "docs" 2026-10-21 12:47:39.001182 | 2026-10-21 12:47:39.001311 | PLAY RECAP 2026-10-21 12:47:39.001375 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-21 12:47:39.001411 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-21 12:47:39.001437 | 2026-10-21 12:47:39.172996 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-10-21 12:47:39.175498 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-10-21 12:47:39.724287 | 2026-10-21 12:47:39.724422 | PLAY [all] 2026-10-21 12:47:39.733369 | 2026-10-21 12:47:39.733456 | TASK [setup-uv : Extract archive] 2026-10-21 12:47:42.273839 | controller | changed 2026-10-21 12:47:42.286585 | 2026-10-21 12:47:42.286856 | TASK [setup-uv : Print version] 2026-10-21 12:47:42.677825 | controller | uv 0.8.13 2026-10-21 12:47:42.826572 | controller | ok: Runtime: 0:00:00.015679 2026-10-21 12:47:42.840407 | 2026-10-21 12:47:42.840575 | TASK [Install Ansible collection siblings] 2026-10-21 12:47:43.311559 | controller | ok: 2026-10-21 12:47:43.311834 | controller | Skipping ansible.posix: no checked-out sibling 2026-10-21 12:47:43.311890 | controller | Skipping community.crypto: no checked-out sibling 2026-10-21 12:47:43.311930 | controller | Skipping community.general: no checked-out sibling 2026-10-21 12:47:43.311997 | controller | Skipping kubernetes.core: no checked-out sibling 2026-10-21 12:47:43.312035 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-10-21 12:47:43.316853 | 2026-10-21 12:47:43.316970 | PLAY RECAP 2026-10-21 12:47:43.317058 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-21 12:47:43.317101 | 2026-10-21 12:47:43.466318 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-10-21 12:47:43.467834 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-10-21 12:47:44.072516 | 2026-10-21 12:47:44.072662 | PLAY [all] 2026-10-21 12:47:44.081985 | 2026-10-21 12:47:44.082071 | TASK [Update apt cache] 2026-10-21 12:47:49.290651 | controller | ok 2026-10-21 12:47:49.294234 | 2026-10-21 12:47:49.294298 | TASK [Disable firewalld] 2026-10-21 12:47:49.307763 | controller | skipping: Conditional result was False 2026-10-21 12:47:49.311482 | 2026-10-21 12:47:49.311541 | TASK [Install "jq" for log collection] 2026-10-21 12:47:51.908700 | controller | changed 2026-10-21 12:47:51.911313 | 2026-10-21 12:47:51.911398 | PLAY RECAP 2026-10-21 12:47:51.911476 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-10-21 12:47:51.911518 | 2026-10-21 12:47:52.028369 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-10-21 12:47:52.031217 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-10-21 12:47:52.611000 | 2026-10-21 12:47:52.611125 | PLAY [all] 2026-10-21 12:47:52.620116 | 2026-10-21 12:47:52.620186 | LOOP [Check inventory directories] 2026-10-21 12:47:53.013136 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-10-21 12:47:53.217717 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory" 2026-10-21 12:47:53.409476 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory" 2026-10-21 12:47:53.422298 | 2026-10-21 12:47:53.422582 | LOOP [Copy inventory file for Zuul] 2026-10-21 12:47:54.389507 | controller | changed: 2026-10-21 12:47:54.389708 | controller | { 2026-10-21 12:47:54.389734 | controller | "ansible_loop_var": "item", 2026-10-21 12:47:54.389756 | controller | "changed": false, 2026-10-21 12:47:54.389774 | controller | "failed": false, 2026-10-21 12:47:54.389793 | controller | "invocation": { 2026-10-21 12:47:54.389810 | controller | "module_args": { 2026-10-21 12:47:54.389826 | controller | "checksum_algorithm": "sha1", 2026-10-21 12:47:54.389842 | controller | "follow": true, 2026-10-21 12:47:54.389858 | controller | "get_attributes": true, 2026-10-21 12:47:54.389875 | controller | "get_checksum": true, 2026-10-21 12:47:54.389891 | controller | "get_mime": true, 2026-10-21 12:47:54.389906 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-10-21 12:47:54.389922 | controller | } 2026-10-21 12:47:54.389937 | controller | }, 2026-10-21 12:47:54.389965 | controller | "item": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-10-21 12:47:54.389981 | controller | "stat": { 2026-10-21 12:47:54.389996 | controller | "atime": 1792586857.5474775, 2026-10-21 12:47:54.390011 | controller | "attr_flags": "e", 2026-10-21 12:47:54.390026 | controller | "attributes": [ 2026-10-21 12:47:54.390042 | controller | "extents" 2026-10-21 12:47:54.390057 | controller | ], 2026-10-21 12:47:54.390072 | controller | "block_size": 4096, 2026-10-21 12:47:54.390087 | controller | "blocks": 8, 2026-10-21 12:47:54.390102 | controller | "charset": "unknown", 2026-10-21 12:47:54.390118 | controller | "ctime": 1792586857.6554754, 2026-10-21 12:47:54.390134 | controller | "dev": 65025, 2026-10-21 12:47:54.390149 | controller | "device_type": 0, 2026-10-21 12:47:54.390165 | controller | "executable": true, 2026-10-21 12:47:54.390180 | controller | "exists": true, 2026-10-21 12:47:54.390195 | controller | "gid": 1000, 2026-10-21 12:47:54.390210 | controller | "gr_name": "zuul", 2026-10-21 12:47:54.390225 | controller | "inode": 521239, 2026-10-21 12:47:54.390240 | controller | "isblk": false, 2026-10-21 12:47:54.390256 | controller | "ischr": false, 2026-10-21 12:47:54.390271 | controller | "isdir": true, 2026-10-21 12:47:54.390286 | controller | "isfifo": false, 2026-10-21 12:47:54.390301 | controller | "isgid": false, 2026-10-21 12:47:54.390316 | controller | "islnk": false, 2026-10-21 12:47:54.390331 | controller | "isreg": false, 2026-10-21 12:47:54.390347 | controller | "issock": false, 2026-10-21 12:47:54.390362 | controller | "isuid": false, 2026-10-21 12:47:54.390377 | controller | "mimetype": "unknown", 2026-10-21 12:47:54.390393 | controller | "mode": "0755", 2026-10-21 12:47:54.390407 | controller | "mtime": 1792586840.3036904, 2026-10-21 12:47:54.390423 | controller | "nlink": 14, 2026-10-21 12:47:54.390438 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-10-21 12:47:54.390453 | controller | "pw_name": "zuul", 2026-10-21 12:47:54.390472 | controller | "readable": true, 2026-10-21 12:47:54.390488 | controller | "rgrp": true, 2026-10-21 12:47:54.390503 | controller | "roth": true, 2026-10-21 12:47:54.390518 | controller | "rusr": true, 2026-10-21 12:47:54.390533 | controller | "size": 4096, 2026-10-21 12:47:54.390548 | controller | "uid": 1000, 2026-10-21 12:47:54.390563 | controller | "version": "3134179837", 2026-10-21 12:47:54.390578 | controller | "wgrp": false, 2026-10-21 12:47:54.390595 | controller | "woth": false, 2026-10-21 12:47:54.390611 | controller | "writeable": true, 2026-10-21 12:47:54.390626 | controller | "wusr": true, 2026-10-21 12:47:54.390642 | controller | "xgrp": true, 2026-10-21 12:47:54.390657 | controller | "xoth": true, 2026-10-21 12:47:54.390671 | controller | "xusr": true 2026-10-21 12:47:54.390700 | controller | } 2026-10-21 12:47:54.390717 | controller | } 2026-10-21 12:47:54.390750 | controller | ok: All items complete 2026-10-21 12:47:54.390769 | 2026-10-21 12:47:54.392177 | controller | skipping: Conditional result was False 2026-10-21 12:47:54.399366 | controller | skipping: Conditional result was False 2026-10-21 12:47:54.415128 | 2026-10-21 12:47:54.415338 | LOOP [Switch "ansible_host" to private IP] 2026-10-21 12:47:54.849523 | controller | changed: 1 replacements made 2026-10-21 12:47:54.851901 | controller | skipping: Conditional result was False 2026-10-21 12:47:54.853326 | controller | skipping: Conditional result was False 2026-10-21 12:47:54.871568 | 2026-10-21 12:47:54.871877 | TASK [Run Molecule scenario] 2026-10-21 12:47:55.387181 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-10-21 12:47:55.387299 | controller | Creating virtual environment at: .venv 2026-10-21 12:47:55.654241 | controller | Downloading ansible-core (2.3MiB) 2026-10-21 12:47:55.654405 | controller | Downloading pygments (1.2MiB) 2026-10-21 12:47:55.658149 | controller | Downloading cryptography (4.3MiB) 2026-10-21 12:47:55.812706 | controller | Downloading cryptography 2026-10-21 12:47:55.866035 | controller | Downloading pygments 2026-10-21 12:47:56.032727 | controller | Downloading ansible-core 2026-10-21 12:47:56.100257 | controller | Installed 36 packages in 66ms 2026-10-21 12:47:56.758165 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-10-21 12:47:56.758227 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-10-21 12:47:57.650615 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-10-21 12:47:57.650672 | controller | INFO default scenario not found, disabling shared state. 2026-10-21 12:47:57.650690 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-10-21 12:47:57.650698 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-10-21 12:48:48.268921 | controller | INFO [upload-helm-chart > dependency] Executing 2026-10-21 12:48:48.269257 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-10-21 12:48:48.269661 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-10-21 12:48:48.269867 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-10-21 12:48:48.280801 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-10-21 12:48:48.281460 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-10-21 12:48:48.292139 | controller | INFO [upload-helm-chart > destroy] Executing 2026-10-21 12:48:48.292261 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-10-21 12:48:48.292471 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-10-21 12:48:48.302746 | controller | INFO [upload-helm-chart > syntax] Executing 2026-10-21 12:48:49.185498 | controller | 2026-10-21 12:48:49.185775 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-10-21 12:48:49.247168 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-10-21 12:48:49.258730 | controller | INFO [upload-helm-chart > create] Executing 2026-10-21 12:48:49.261589 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-10-21 12:48:49.272278 | controller | INFO [upload-helm-chart > prepare] Executing 2026-10-21 12:48:49.272865 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-10-21 12:48:49.283463 | controller | INFO [upload-helm-chart > converge] Executing 2026-10-21 12:48:50.166625 | controller | 2026-10-21 12:48:50.166669 | controller | PLAY [Converge] **************************************************************** 2026-10-21 12:48:50.166680 | controller | 2026-10-21 12:48:50.166690 | controller | TASK [Gathering Facts] ********************************************************* 2026-10-21 12:48:50.166701 | controller | Wednesday 21 October 2026 12:48:50 +0000 (0:00:00.029) 0:00:00.029 ***** 2026-10-21 12:48:51.432781 | 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-10-21 12:48:51.440797 | controller | ok: [controller] 2026-10-21 12:48:51.440817 | controller | 2026-10-21 12:48:51.440826 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:48:51.440834 | controller | Wednesday 21 October 2026 12:48:51 +0000 (0:00:01.275) 0:00:01.305 ***** 2026-10-21 12:48:51.552593 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-10-21 12:48:51.553022 | controller | 2026-10-21 12:48:51.553266 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-10-21 12:48:51.553530 | controller | Wednesday 21 October 2026 12:48:51 +0000 (0:00:00.112) 0:00:01.418 ***** 2026-10-21 12:48:52.236965 | controller | changed: [controller] 2026-10-21 12:48:52.237221 | controller | 2026-10-21 12:48:52.237516 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:48:52.237757 | controller | Wednesday 21 October 2026 12:48:52 +0000 (0:00:00.683) 0:00:02.101 ***** 2026-10-21 12:48:52.293483 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-10-21 12:48:52.293518 | controller | 2026-10-21 12:48:52.293527 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-10-21 12:48:52.293535 | controller | Wednesday 21 October 2026 12:48:52 +0000 (0:00:00.056) 0:00:02.157 ***** 2026-10-21 12:48:52.734014 | controller | changed: [controller] 2026-10-21 12:48:52.734270 | controller | 2026-10-21 12:48:52.734638 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-10-21 12:48:52.734910 | controller | Wednesday 21 October 2026 12:48:52 +0000 (0:00:00.440) 0:00:02.598 ***** 2026-10-21 12:48:53.864802 | controller | changed: [controller] 2026-10-21 12:48:53.865100 | controller | 2026-10-21 12:48:53.865439 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-10-21 12:48:53.865726 | controller | Wednesday 21 October 2026 12:48:53 +0000 (0:00:01.127) 0:00:03.725 ***** 2026-10-21 12:48:54.306691 | controller | ok: [controller] 2026-10-21 12:48:54.306738 | controller | 2026-10-21 12:48:54.306750 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-10-21 12:48:54.306767 | controller | Wednesday 21 October 2026 12:48:54 +0000 (0:00:00.444) 0:00:04.170 ***** 2026-10-21 12:48:54.377019 | controller | skipping: [controller] 2026-10-21 12:48:54.377247 | controller | 2026-10-21 12:48:54.377482 | controller | PLAY RECAP ********************************************************************* 2026-10-21 12:48:54.377702 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-10-21 12:48:54.377890 | controller | 2026-10-21 12:48:54.378075 | controller | 2026-10-21 12:48:54.378288 | controller | TASKS RECAP ******************************************************************** 2026-10-21 12:48:54.378497 | controller | Wednesday 21 October 2026 12:48:54 +0000 (0:00:00.072) 0:00:04.242 ***** 2026-10-21 12:48:54.378706 | controller | =============================================================================== 2026-10-21 12:48:54.378893 | controller | Gathering Facts --------------------------------------------------------- 1.28s 2026-10-21 12:48:54.379084 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.13s 2026-10-21 12:48:54.379262 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.68s 2026-10-21 12:48:54.379545 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s 2026-10-21 12:48:54.379717 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s 2026-10-21 12:48:54.379908 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.11s 2026-10-21 12:48:54.380100 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.07s 2026-10-21 12:48:54.380281 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-10-21 12:48:54.478983 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-10-21 12:48:54.490288 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-10-21 12:48:55.313041 | controller | 2026-10-21 12:48:55.313198 | controller | PLAY [Converge] **************************************************************** 2026-10-21 12:48:55.313357 | controller | 2026-10-21 12:48:55.313558 | controller | TASK [Gathering Facts] ********************************************************* 2026-10-21 12:48:55.313748 | controller | Wednesday 21 October 2026 12:48:55 +0000 (0:00:00.009) 0:00:00.009 ***** 2026-10-21 12:48:56.379947 | 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-10-21 12:48:56.387431 | controller | ok: [controller] 2026-10-21 12:48:56.387583 | controller | 2026-10-21 12:48:56.387759 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:48:56.387937 | controller | Wednesday 21 October 2026 12:48:56 +0000 (0:00:01.073) 0:00:01.083 ***** 2026-10-21 12:48:56.482073 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-10-21 12:48:56.482198 | controller | 2026-10-21 12:48:56.482377 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-10-21 12:48:56.482607 | controller | Wednesday 21 October 2026 12:48:56 +0000 (0:00:00.095) 0:00:01.179 ***** 2026-10-21 12:48:57.151069 | controller | ok: [controller] 2026-10-21 12:48:57.153749 | controller | 2026-10-21 12:48:57.153768 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:48:57.153777 | controller | Wednesday 21 October 2026 12:48:57 +0000 (0:00:00.666) 0:00:01.846 ***** 2026-10-21 12:48:57.204614 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-10-21 12:48:57.204767 | controller | 2026-10-21 12:48:57.204944 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-10-21 12:48:57.205118 | controller | Wednesday 21 October 2026 12:48:57 +0000 (0:00:00.055) 0:00:01.901 ***** 2026-10-21 12:48:57.637741 | controller | ok: [controller] 2026-10-21 12:48:57.637890 | controller | 2026-10-21 12:48:57.638092 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-10-21 12:48:57.638309 | controller | Wednesday 21 October 2026 12:48:57 +0000 (0:00:00.432) 0:00:02.333 ***** 2026-10-21 12:48:58.696004 | controller | ok: [controller] 2026-10-21 12:48:58.696184 | controller | 2026-10-21 12:48:58.696364 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-10-21 12:48:58.696589 | controller | Wednesday 21 October 2026 12:48:58 +0000 (0:00:01.058) 0:00:03.392 ***** 2026-10-21 12:48:59.108581 | controller | ok: [controller] 2026-10-21 12:48:59.108771 | controller | 2026-10-21 12:48:59.109039 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-10-21 12:48:59.109269 | controller | Wednesday 21 October 2026 12:48:59 +0000 (0:00:00.412) 0:00:03.804 ***** 2026-10-21 12:48:59.164105 | controller | skipping: [controller] 2026-10-21 12:48:59.164305 | controller | 2026-10-21 12:48:59.164568 | controller | PLAY RECAP ********************************************************************* 2026-10-21 12:48:59.164810 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-10-21 12:48:59.165013 | controller | 2026-10-21 12:48:59.165224 | controller | 2026-10-21 12:48:59.165465 | controller | TASKS RECAP ******************************************************************** 2026-10-21 12:48:59.165733 | controller | Wednesday 21 October 2026 12:48:59 +0000 (0:00:00.056) 0:00:03.861 ***** 2026-10-21 12:48:59.165951 | controller | =============================================================================== 2026-10-21 12:48:59.166169 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-10-21 12:48:59.166456 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.06s 2026-10-21 12:48:59.166757 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.67s 2026-10-21 12:48:59.166970 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s 2026-10-21 12:48:59.167229 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s 2026-10-21 12:48:59.167488 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s 2026-10-21 12:48:59.167736 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s 2026-10-21 12:48:59.167975 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-10-21 12:48:59.256014 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-10-21 12:48:59.267420 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-10-21 12:49:00.059413 | controller | 2026-10-21 12:49:00.059631 | controller | PLAY [Side effect] ************************************************************* 2026-10-21 12:49:00.059844 | controller | 2026-10-21 12:49:00.060069 | controller | TASK [Gathering Facts] ********************************************************* 2026-10-21 12:49:00.060291 | controller | Wednesday 21 October 2026 12:49:00 +0000 (0:00:00.009) 0:00:00.009 ***** 2026-10-21 12:49:01.148257 | 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-10-21 12:49:01.155546 | controller | ok: [controller] 2026-10-21 12:49:01.155674 | controller | 2026-10-21 12:49:01.155909 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:49:01.156041 | controller | Wednesday 21 October 2026 12:49:01 +0000 (0:00:01.095) 0:00:01.105 ***** 2026-10-21 12:49:01.252934 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-10-21 12:49:01.253040 | controller | 2026-10-21 12:49:01.253211 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-10-21 12:49:01.253382 | controller | Wednesday 21 October 2026 12:49:01 +0000 (0:00:00.097) 0:00:01.203 ***** 2026-10-21 12:49:01.947818 | controller | changed: [controller] 2026-10-21 12:49:01.947958 | controller | 2026-10-21 12:49:01.948168 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-10-21 12:49:01.948359 | controller | Wednesday 21 October 2026 12:49:01 +0000 (0:00:00.694) 0:00:01.897 ***** 2026-10-21 12:49:02.004121 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-10-21 12:49:02.004236 | controller | 2026-10-21 12:49:02.004558 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-10-21 12:49:02.004616 | controller | Wednesday 21 October 2026 12:49:02 +0000 (0:00:00.055) 0:00:01.953 ***** 2026-10-21 12:49:02.444146 | controller | ok: [controller] 2026-10-21 12:49:02.444183 | controller | 2026-10-21 12:49:02.444192 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-10-21 12:49:02.444200 | controller | Wednesday 21 October 2026 12:49:02 +0000 (0:00:00.439) 0:00:02.392 ***** 2026-10-21 12:49:03.547279 | controller | ok: [controller] 2026-10-21 12:49:03.547413 | controller | 2026-10-21 12:49:03.547629 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-10-21 12:49:03.547804 | controller | Wednesday 21 October 2026 12:49:03 +0000 (0:00:01.100) 0:00:03.493 ***** 2026-10-21 12:49:04.014372 | controller | ok: [controller] 2026-10-21 12:49:04.014402 | controller | 2026-10-21 12:49:04.014412 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-10-21 12:49:04.014420 | controller | Wednesday 21 October 2026 12:49:04 +0000 (0:00:00.469) 0:00:03.963 ***** 2026-10-21 12:49:04.390932 | controller | changed: [controller] => (item=/file) 2026-10-21 12:49:04.391068 | controller | 2026-10-21 12:49:04.391180 | controller | PLAY RECAP ********************************************************************* 2026-10-21 12:49:04.391299 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-10-21 12:49:04.391399 | controller | 2026-10-21 12:49:04.391515 | controller | 2026-10-21 12:49:04.391620 | controller | TASKS RECAP ******************************************************************** 2026-10-21 12:49:04.391737 | controller | Wednesday 21 October 2026 12:49:04 +0000 (0:00:00.374) 0:00:04.337 ***** 2026-10-21 12:49:04.391837 | controller | =============================================================================== 2026-10-21 12:49:04.391945 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s 2026-10-21 12:49:04.392048 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-10-21 12:49:04.392152 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.69s 2026-10-21 12:49:04.392256 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.47s 2026-10-21 12:49:04.392363 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s 2026-10-21 12:49:04.392483 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.37s 2026-10-21 12:49:04.392591 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s 2026-10-21 12:49:04.392697 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-10-21 12:49:04.476691 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-10-21 12:49:04.482019 | controller | INFO [upload-helm-chart > verify] Executing 2026-10-21 12:49:05.329191 | controller | 2026-10-21 12:49:05.329517 | controller | PLAY [Verify] ****************************************************************** 2026-10-21 12:49:05.329766 | controller | 2026-10-21 12:49:05.330013 | controller | TASK [Gathering Facts] ********************************************************* 2026-10-21 12:49:05.330262 | controller | Wednesday 21 October 2026 12:49:05 +0000 (0:00:00.008) 0:00:00.008 ***** 2026-10-21 12:49:07.472744 | 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-10-21 12:49:07.480002 | controller | ok: [controller] 2026-10-21 12:49:07.480025 | controller | 2026-10-21 12:49:07.480035 | controller | TASK [Stat file 1] ************************************************************* 2026-10-21 12:49:07.480044 | controller | Wednesday 21 October 2026 12:49:07 +0000 (0:00:02.150) 0:00:02.158 ***** 2026-10-21 12:49:07.945096 | controller | ok: [controller] 2026-10-21 12:49:07.945379 | controller | 2026-10-21 12:49:07.945642 | controller | TASK [Stat file 2] ************************************************************* 2026-10-21 12:49:07.945877 | controller | Wednesday 21 October 2026 12:49:07 +0000 (0:00:00.463) 0:00:02.621 ***** 2026-10-21 12:49:08.261549 | controller | ok: [controller] 2026-10-21 12:49:08.261827 | controller | 2026-10-21 12:49:08.262075 | controller | TASK [Stat removed file 1] ***************************************************** 2026-10-21 12:49:08.262315 | controller | Wednesday 21 October 2026 12:49:08 +0000 (0:00:00.318) 0:00:02.939 ***** 2026-10-21 12:49:08.599233 | controller | ok: [controller] 2026-10-21 12:49:08.599511 | controller | 2026-10-21 12:49:08.599750 | controller | TASK [Stat removed file 2] ***************************************************** 2026-10-21 12:49:08.599994 | controller | Wednesday 21 October 2026 12:49:08 +0000 (0:00:00.334) 0:00:03.274 ***** 2026-10-21 12:49:08.925371 | controller | ok: [controller] 2026-10-21 12:49:08.925447 | controller | 2026-10-21 12:49:08.925459 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-10-21 12:49:08.925532 | controller | Wednesday 21 October 2026 12:49:08 +0000 (0:00:00.330) 0:00:03.604 ***** 2026-10-21 12:49:08.975095 | controller | ok: [controller] => { 2026-10-21 12:49:08.975223 | controller | "changed": false, 2026-10-21 12:49:08.975404 | controller | "msg": "All assertions passed" 2026-10-21 12:49:08.975591 | controller | } 2026-10-21 12:49:08.975749 | controller | 2026-10-21 12:49:08.975922 | controller | PLAY RECAP ********************************************************************* 2026-10-21 12:49:08.976110 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-10-21 12:49:08.976249 | controller | 2026-10-21 12:49:08.976396 | controller | 2026-10-21 12:49:08.976577 | controller | TASKS RECAP ******************************************************************** 2026-10-21 12:49:08.977938 | controller | Wednesday 21 October 2026 12:49:08 +0000 (0:00:00.048) 0:00:03.653 ***** 2026-10-21 12:49:08.977978 | controller | =============================================================================== 2026-10-21 12:49:08.977984 | controller | Gathering Facts --------------------------------------------------------- 2.15s 2026-10-21 12:49:08.977989 | controller | Stat file 1 ------------------------------------------------------------- 0.46s 2026-10-21 12:49:08.977994 | controller | Stat removed file 1 ----------------------------------------------------- 0.33s 2026-10-21 12:49:08.977998 | controller | Stat removed file 2 ----------------------------------------------------- 0.33s 2026-10-21 12:49:08.978003 | controller | Stat file 2 ------------------------------------------------------------- 0.32s 2026-10-21 12:49:08.978008 | controller | ansible.builtin.assert -------------------------------------------------- 0.05s 2026-10-21 12:49:09.145481 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-10-21 12:49:09.157211 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-10-21 12:49:09.157858 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-10-21 12:49:09.168821 | controller | INFO [upload-helm-chart > destroy] Executing 2026-10-21 12:49:09.169059 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-10-21 12:49:09.169234 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-10-21 12:49:09.169770 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-10-21 12:49:09.491052 | controller | ok: Runtime: 0:01:14.008929 2026-10-21 12:49:09.497010 | 2026-10-21 12:49:09.497117 | PLAY RECAP 2026-10-21 12:49:09.497207 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-21 12:49:09.497253 | 2026-10-21 12:49:09.633450 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-10-21 12:49:09.635419 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-10-21 12:49:10.196961 | 2026-10-21 12:49:10.197101 | PLAY [all] 2026-10-21 12:49:10.207218 | 2026-10-21 12:49:10.207294 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-10-21 12:49:10.640309 | controller | changed 2026-10-21 12:49:10.651548 | 2026-10-21 12:49:10.651792 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-10-21 12:49:11.072065 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-10-21 12:49:11.072165 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-10-21 12:49:11.080103 | controller | environment: line 1: kubectl: command not found 2026-10-21 12:49:11.082295 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-10-21 12:49:11.083857 | controller | environment: line 1: kubectl: command not found 2026-10-21 12:49:11.085905 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-10-21 12:49:11.087464 | controller | environment: line 1: kubectl: command not found 2026-10-21 12:49:11.089663 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-10-21 12:49:11.091445 | controller | environment: line 1: kubectl: command not found 2026-10-21 12:49:11.093369 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-10-21 12:49:11.095100 | controller | environment: line 1: kubectl: command not found 2026-10-21 12:49:11.097112 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-10-21 12:49:11.196253 | controller | ok: Runtime: 0:00:00.039552 2026-10-21 12:49:11.204568 | 2026-10-21 12:49:11.204706 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-10-21 12:49:11.460421 | controller | changed 2026-10-21 12:49:11.467907 | 2026-10-21 12:49:11.468074 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-10-21 12:49:11.750117 | controller | environment: line 5: kubectl: command not found 2026-10-21 12:49:11.751290 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-10-21 12:49:11.752343 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-10-21 12:49:11.752608 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-10-21 12:49:12.004780 | controller | ok: Runtime: 0:00:00.014504 2026-10-21 12:49:12.013605 | 2026-10-21 12:49:12.013745 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-10-21 12:49:12.644294 | controller | changed: 2026-10-21 12:49:12.644591 | controller | created directory /var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/logs/controller 2026-10-21 12:49:12.644653 | controller | cd+++++++++ objects/ 2026-10-21 12:49:12.644697 | controller | cd+++++++++ objects/cluster/ 2026-10-21 12:49:12.644744 | controller | cd+++++++++ objects/namespaced/ 2026-10-21 12:49:12.658461 | 2026-10-21 12:49:12.658597 | TASK [gather-pod-logs : creating directory for pod logs] 2026-10-21 12:49:12.929301 | controller | changed 2026-10-21 12:49:12.937707 | 2026-10-21 12:49:12.937842 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-10-21 12:49:13.172328 | controller | changed 2026-10-21 12:49:13.179807 | 2026-10-21 12:49:13.179964 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-10-21 12:49:13.456341 | controller | environment: line 3: kubectl: command not found 2026-10-21 12:49:13.716652 | controller | ok: Runtime: 0:00:00.014459 2026-10-21 12:49:13.724049 | 2026-10-21 12:49:13.724175 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-10-21 12:49:14.222316 | controller | changed: 2026-10-21 12:49:14.222631 | controller | cd+++++++++ pod-logs/ 2026-10-21 12:49:14.222690 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-10-21 12:49:14.236900 | 2026-10-21 12:49:14.237090 | LOOP [helm-release-status : creating directory for helm release status] 2026-10-21 12:49:14.513132 | controller | changed: "values" 2026-10-21 12:49:14.732100 | controller | changed: "releases" 2026-10-21 12:49:14.743704 | 2026-10-21 12:49:14.743942 | TASK [helm-release-status : Gather get release status for helm charts] 2026-10-21 12:49:15.050872 | controller | /bin/bash: line 7: helm: command not found 2026-10-21 12:49:15.055157 | controller | /bin/bash: line 11: kubectl: command not found 2026-10-21 12:49:15.284225 | controller | ok: Runtime: 0:00:00.014096 2026-10-21 12:49:15.292785 | 2026-10-21 12:49:15.293045 | TASK [helm-release-status : Downloads logs to executor] 2026-10-21 12:49:15.843739 | controller | changed: 2026-10-21 12:49:15.844057 | controller | cd+++++++++ helm/ 2026-10-21 12:49:15.844120 | controller | cd+++++++++ helm/releases/ 2026-10-21 12:49:15.844175 | controller | cd+++++++++ helm/values/ 2026-10-21 12:49:15.853625 | 2026-10-21 12:49:15.853739 | PLAY RECAP 2026-10-21 12:49:15.853832 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-21 12:49:15.853880 | 2026-10-21 12:49:16.001669 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-10-21 12:49:16.004350 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-21 12:49:16.606621 | 2026-10-21 12:49:16.606784 | PLAY [all] 2026-10-21 12:49:16.616636 | 2026-10-21 12:49:16.616711 | TASK [fetch-output : Set log path for multiple nodes] 2026-10-21 12:49:16.671330 | controller | skipping: Conditional result was False 2026-10-21 12:49:16.679088 | 2026-10-21 12:49:16.679259 | TASK [fetch-output : Set log path for single node] 2026-10-21 12:49:16.720095 | controller | ok 2026-10-21 12:49:16.727011 | 2026-10-21 12:49:16.727155 | LOOP [fetch-output : Ensure local output dirs] 2026-10-21 12:49:17.152056 | controller -> localhost | ok: "/var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/logs" 2026-10-21 12:49:17.378843 | controller -> localhost | changed: "/var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/artifacts" 2026-10-21 12:49:17.604203 | controller -> localhost | changed: "/var/lib/zuul/builds/2f35b80321c843c2acc90de4e69a5794/work/docs" 2026-10-21 12:49:17.629150 | 2026-10-21 12:49:17.629341 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-21 12:49:18.314024 | controller | changed: .d..t...... ./ 2026-10-21 12:49:18.314403 | controller | changed: All items complete 2026-10-21 12:49:18.314461 | 2026-10-21 12:49:18.821490 | controller | changed: .d..t...... ./ 2026-10-21 12:49:19.316385 | controller | changed: .d..t...... ./ 2026-10-21 12:49:19.335008 | 2026-10-21 12:49:19.335205 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-21 12:49:19.780931 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008265 2026-10-21 12:49:20.039896 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007894 2026-10-21 12:49:20.055216 | 2026-10-21 12:49:20.055336 | PLAY [all] 2026-10-21 12:49:20.061651 | 2026-10-21 12:49:20.061735 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-21 12:49:20.529249 | controller | changed 2026-10-21 12:49:20.538926 | 2026-10-21 12:49:20.539071 | PLAY RECAP 2026-10-21 12:49:20.539178 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-10-21 12:49:20.539233 | 2026-10-21 12:49:20.668234 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-10-21 12:49:20.670816 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-21 12:49:21.166876 | 2026-10-21 12:49:21.167007 | PLAY [localhost] 2026-10-21 12:49:21.175685 | 2026-10-21 12:49:21.175750 | TASK [Generate Zuul manifest] 2026-10-21 12:49:21.191787 | localhost | ok 2026-10-21 12:49:21.204485 | 2026-10-21 12:49:21.204574 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-21 12:49:21.575419 | localhost | changed 2026-10-21 12:49:21.588269 | 2026-10-21 12:49:21.588369 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-21 12:49:21.616203 | localhost | ok 2026-10-21 12:49:21.623943 | 2026-10-21 12:49:21.624034 | TASK [Upload logs] 2026-10-21 12:49:21.641224 | localhost | ok 2026-10-21 12:49:21.695347 | 2026-10-21 12:49:21.695437 | TASK [Set zuul-log-path fact] 2026-10-21 12:49:21.711434 | localhost | ok 2026-10-21 12:49:21.720908 | 2026-10-21 12:49:21.720987 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-21 12:49:21.747164 | localhost | ok 2026-10-21 12:49:21.755713 | 2026-10-21 12:49:21.755793 | TASK [upload-logs : Create log directories] 2026-10-21 12:49:22.149793 | localhost | changed 2026-10-21 12:49:22.158143 | 2026-10-21 12:49:22.158277 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-21 12:49:22.595630 | localhost -> localhost | ok: Runtime: 0:00:00.004715 2026-10-21 12:49:22.604769 | 2026-10-21 12:49:22.604897 | TASK [upload-logs : Upload logs to log server] 2026-10-21 12:49:23.072199 | localhost | Output suppressed because no_log was given 2026-10-21 12:49:23.079248 | 2026-10-21 12:49:23.079376 | LOOP [upload-logs : Compress console log and json output] 2026-10-21 12:49:23.141352 | localhost | skipping: Conditional result was False 2026-10-21 12:49:23.183127 | localhost | skipping: Conditional result was False 2026-10-21 12:49:23.194303 | 2026-10-21 12:49:23.194515 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-21 12:49:23.253584 | localhost | skipping: Conditional result was False 2026-10-21 12:49:23.254032 | 2026-10-21 12:49:23.258513 | localhost | skipping: Conditional result was False 2026-10-21 12:49:23.267786 | 2026-10-21 12:49:23.267986 | LOOP [upload-logs : Upload console log and json output]