2026-08-22 08:31:15.340465 | Job console starting 2026-08-22 08:31:15.356300 | Updating git repos 2026-08-22 08:31:15.428576 | Cloning repos into workspace 2026-08-22 08:31:15.606334 | Restoring repo states 2026-08-22 08:31:15.622709 | Merging changes 2026-08-22 08:31:16.768152 | Checking out repos 2026-08-22 08:31:16.856797 | Preparing playbooks 2026-08-22 08:31:22.742475 | Running Ansible setup 2026-08-22 08:31:26.435573 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 08:31:27.126740 | 2026-08-22 08:31:27.126878 | PLAY [localhost] 2026-08-22 08:31:27.134493 | 2026-08-22 08:31:27.134566 | TASK [Gathering Facts] 2026-08-22 08:31:28.251921 | localhost | ok 2026-08-22 08:31:28.267791 | 2026-08-22 08:31:28.267882 | TASK [Setup log path fact] 2026-08-22 08:31:28.287938 | localhost | ok 2026-08-22 08:31:28.304610 | 2026-08-22 08:31:28.304775 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 08:31:28.336458 | localhost | ok 2026-08-22 08:31:28.343241 | 2026-08-22 08:31:28.343316 | TASK [emit-job-header : Print job information] 2026-08-22 08:31:28.386659 | # Job Information 2026-08-22 08:31:28.386813 | Ansible Version: 2.16.18 2026-08-22 08:31:28.386860 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-08-22 08:31:28.386895 | Pipeline: check 2026-08-22 08:31:28.386926 | Executor: 2d72f0692154 2026-08-22 08:31:28.386956 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/299 2026-08-22 08:31:28.386990 | Event ID: fbec8120-9e02-11f1-9d98-f7742a714265 2026-08-22 08:31:28.390972 | 2026-08-22 08:31:28.391057 | LOOP [emit-job-header : Print node information] 2026-08-22 08:31:28.473569 | localhost | ok: 2026-08-22 08:31:28.473854 | localhost | # Node Information 2026-08-22 08:31:28.473885 | localhost | Inventory Hostname: controller 2026-08-22 08:31:28.473907 | localhost | Hostname: np0000190454 2026-08-22 08:31:28.473927 | localhost | Username: zuul 2026-08-22 08:31:28.473957 | localhost | Distro: Debian 13.6 2026-08-22 08:31:28.473979 | localhost | Provider: yul1 2026-08-22 08:31:28.473998 | localhost | Region: ca-ymq-1 2026-08-22 08:31:28.474018 | localhost | Label: debian-trixie 2026-08-22 08:31:28.474037 | localhost | Product Name: OpenStack Nova 2026-08-22 08:31:28.474056 | localhost | Interface IP: 199.19.213.199 2026-08-22 08:31:28.488803 | 2026-08-22 08:31:28.489062 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-22 08:31:28.929865 | localhost -> localhost | changed 2026-08-22 08:31:28.937354 | 2026-08-22 08:31:28.937503 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-22 08:31:30.270910 | localhost -> localhost | changed 2026-08-22 08:31:30.280131 | 2026-08-22 08:31:30.280211 | PLAY [all] 2026-08-22 08:31:30.288742 | 2026-08-22 08:31:30.288808 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-22 08:31:30.526324 | controller -> localhost | ok 2026-08-22 08:31:30.531377 | 2026-08-22 08:31:30.531445 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-22 08:31:30.562102 | controller | ok 2026-08-22 08:31:30.578587 | controller | included: /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-22 08:31:30.583933 | 2026-08-22 08:31:30.583995 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-22 08:31:31.959855 | controller -> localhost | Generating public/private rsa key pair. 2026-08-22 08:31:31.960094 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/6e89c57dd7aa400e8864b760c8f05b27_id_rsa 2026-08-22 08:31:31.960138 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/6e89c57dd7aa400e8864b760c8f05b27_id_rsa.pub 2026-08-22 08:31:31.960171 | controller -> localhost | The key fingerprint is: 2026-08-22 08:31:31.960202 | controller -> localhost | SHA256:Wo86nyxDJuvTsaVL8B7UKyIp/9bk47BuE8qzJElcO+0 zuul-build-sshkey 2026-08-22 08:31:31.960248 | controller -> localhost | The key's randomart image is: 2026-08-22 08:31:31.960280 | controller -> localhost | +---[RSA 3072]----+ 2026-08-22 08:31:31.960314 | controller -> localhost | | | 2026-08-22 08:31:31.960345 | controller -> localhost | | | 2026-08-22 08:31:31.960375 | controller -> localhost | | . | 2026-08-22 08:31:31.960405 | controller -> localhost | |. . o . | 2026-08-22 08:31:31.960434 | controller -> localhost | | o o... S | 2026-08-22 08:31:31.960463 | controller -> localhost | |.. .=+=o.+ | 2026-08-22 08:31:31.960491 | controller -> localhost | |+.+.oE*=o . | 2026-08-22 08:31:31.960520 | controller -> localhost | | =+.**@= . | 2026-08-22 08:31:31.960553 | controller -> localhost | | oO=+=B+ | 2026-08-22 08:31:31.960582 | controller -> localhost | +----[SHA256]-----+ 2026-08-22 08:31:31.960653 | controller -> localhost | ok: Runtime: 0:00:00.952521 2026-08-22 08:31:31.966754 | 2026-08-22 08:31:31.966845 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-22 08:31:32.000500 | controller | ok 2026-08-22 08:31:32.010268 | controller | included: /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-22 08:31:32.016679 | 2026-08-22 08:31:32.016752 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-22 08:31:32.042640 | controller | skipping: Conditional result was False 2026-08-22 08:31:32.054122 | 2026-08-22 08:31:32.054353 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-22 08:31:32.619584 | controller | changed 2026-08-22 08:31:32.623757 | 2026-08-22 08:31:32.623867 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-22 08:31:32.839498 | controller | ok 2026-08-22 08:31:32.845338 | 2026-08-22 08:31:32.845422 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-22 08:31:33.467131 | controller | changed 2026-08-22 08:31:33.474428 | 2026-08-22 08:31:33.474558 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-22 08:31:34.010737 | controller | changed 2026-08-22 08:31:34.024220 | 2026-08-22 08:31:34.024377 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-22 08:31:34.049204 | controller | skipping: Conditional result was False 2026-08-22 08:31:34.058417 | 2026-08-22 08:31:34.058477 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-22 08:31:34.466966 | controller -> localhost | changed 2026-08-22 08:31:34.481386 | 2026-08-22 08:31:34.481486 | TASK [add-build-sshkey : Add back temp key] 2026-08-22 08:31:34.774685 | controller -> localhost | Identity added: /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/6e89c57dd7aa400e8864b760c8f05b27_id_rsa (zuul-build-sshkey) 2026-08-22 08:31:34.774916 | controller -> localhost | ok: Runtime: 0:00:00.016708 2026-08-22 08:31:34.779892 | 2026-08-22 08:31:34.779957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-22 08:31:35.137533 | controller | ok 2026-08-22 08:31:35.145393 | 2026-08-22 08:31:35.145881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-22 08:31:35.183276 | controller | skipping: Conditional result was False 2026-08-22 08:31:35.197794 | 2026-08-22 08:31:35.197916 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-22 08:31:35.555983 | controller | ok 2026-08-22 08:31:35.567435 | 2026-08-22 08:31:35.567606 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-22 08:31:36.559743 | controller | Output suppressed because no_log was given 2026-08-22 08:31:36.569585 | 2026-08-22 08:31:36.569676 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-22 08:31:36.798021 | controller | ok: "logs" 2026-08-22 08:31:36.798376 | controller | ok: All items complete 2026-08-22 08:31:36.798437 | 2026-08-22 08:31:37.007944 | controller | ok: "artifacts" 2026-08-22 08:31:37.195332 | controller | ok: "docs" 2026-08-22 08:31:37.216161 | 2026-08-22 08:31:37.216384 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-22 08:31:37.437700 | controller | changed: "logs" 2026-08-22 08:31:37.658726 | controller | changed: "artifacts" 2026-08-22 08:31:37.865732 | controller | changed: "docs" 2026-08-22 08:31:37.879445 | 2026-08-22 08:31:37.879639 | PLAY RECAP 2026-08-22 08:31:37.879716 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-22 08:31:37.879759 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:31:37.879793 | 2026-08-22 08:31:38.148407 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 08:31:38.151805 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 08:31:38.760322 | 2026-08-22 08:31:39.073112 | PLAY [all] 2026-08-22 08:31:39.094116 | 2026-08-22 08:31:39.094314 | TASK [setup-uv : Extract archive] 2026-08-22 08:31:41.519876 | controller | changed 2026-08-22 08:31:41.526992 | 2026-08-22 08:31:41.527090 | TASK [setup-uv : Print version] 2026-08-22 08:31:41.884588 | controller | uv 0.8.13 2026-08-22 08:31:42.059305 | controller | ok: Runtime: 0:00:00.012879 2026-08-22 08:31:42.070153 | 2026-08-22 08:31:42.070228 | TASK [Install Ansible collection siblings] 2026-08-22 08:31:42.487556 | controller | ok: 2026-08-22 08:31:42.487739 | controller | Skipping ansible.posix: no checked-out sibling 2026-08-22 08:31:42.487768 | controller | Skipping community.crypto: no checked-out sibling 2026-08-22 08:31:42.487790 | controller | Skipping community.general: no checked-out sibling 2026-08-22 08:31:42.487810 | controller | Skipping kubernetes.core: no checked-out sibling 2026-08-22 08:31:42.487830 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-08-22 08:31:42.490322 | 2026-08-22 08:31:42.490371 | PLAY RECAP 2026-08-22 08:31:42.490415 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:31:42.490437 | 2026-08-22 08:31:42.628701 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 08:31:42.631537 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-08-22 08:31:43.255633 | 2026-08-22 08:31:43.255759 | PLAY [all] 2026-08-22 08:31:43.265739 | 2026-08-22 08:31:43.265813 | TASK [Update apt cache] 2026-08-22 08:31:47.875190 | controller | ok 2026-08-22 08:31:47.881033 | 2026-08-22 08:31:47.881151 | TASK [Disable firewalld] 2026-08-22 08:31:47.906159 | controller | skipping: Conditional result was False 2026-08-22 08:31:47.915726 | 2026-08-22 08:31:47.915885 | TASK [Install "jq" for log collection] 2026-08-22 08:31:50.113434 | controller | changed 2026-08-22 08:31:50.116569 | 2026-08-22 08:31:50.116645 | PLAY RECAP 2026-08-22 08:31:50.116714 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 08:31:50.116747 | 2026-08-22 08:31:50.275917 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-08-22 08:31:50.277388 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 08:31:50.889184 | 2026-08-22 08:31:50.889316 | PLAY [all] 2026-08-22 08:31:50.899492 | 2026-08-22 08:31:50.899579 | LOOP [Check inventory directories] 2026-08-22 08:31:51.338701 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-08-22 08:31:51.522855 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory" 2026-08-22 08:31:51.712436 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory" 2026-08-22 08:31:51.731570 | 2026-08-22 08:31:51.731819 | LOOP [Copy inventory file for Zuul] 2026-08-22 08:31:52.661565 | controller | changed: 2026-08-22 08:31:52.662113 | controller | { 2026-08-22 08:31:52.662184 | controller | "ansible_loop_var": "item", 2026-08-22 08:31:52.662220 | controller | "changed": false, 2026-08-22 08:31:52.662248 | controller | "failed": false, 2026-08-22 08:31:52.662277 | controller | "invocation": { 2026-08-22 08:31:52.662303 | controller | "module_args": { 2026-08-22 08:31:52.662328 | controller | "checksum_algorithm": "sha1", 2026-08-22 08:31:52.662353 | controller | "follow": true, 2026-08-22 08:31:52.662377 | controller | "get_attributes": true, 2026-08-22 08:31:52.662403 | controller | "get_checksum": true, 2026-08-22 08:31:52.662428 | controller | "get_mime": true, 2026-08-22 08:31:52.662452 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-08-22 08:31:52.662477 | controller | } 2026-08-22 08:31:52.662500 | controller | }, 2026-08-22 08:31:52.662524 | controller | "item": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-08-22 08:31:52.662547 | controller | "stat": { 2026-08-22 08:31:52.662571 | controller | "atime": 1787387496.4269917, 2026-08-22 08:31:52.662667 | controller | "attr_flags": "e", 2026-08-22 08:31:52.662686 | controller | "attributes": [ 2026-08-22 08:31:52.662704 | controller | "extents" 2026-08-22 08:31:52.662721 | controller | ], 2026-08-22 08:31:52.662738 | controller | "block_size": 4096, 2026-08-22 08:31:52.662755 | controller | "blocks": 8, 2026-08-22 08:31:52.662772 | controller | "charset": "unknown", 2026-08-22 08:31:52.662791 | controller | "ctime": 1787387496.4509919, 2026-08-22 08:31:52.662808 | controller | "dev": 65025, 2026-08-22 08:31:52.662825 | controller | "device_type": 0, 2026-08-22 08:31:52.662843 | controller | "executable": true, 2026-08-22 08:31:52.662860 | controller | "exists": true, 2026-08-22 08:31:52.662877 | controller | "gid": 1000, 2026-08-22 08:31:52.662893 | controller | "gr_name": "zuul", 2026-08-22 08:31:52.662910 | controller | "inode": 520215, 2026-08-22 08:31:52.662927 | controller | "isblk": false, 2026-08-22 08:31:52.662944 | controller | "ischr": false, 2026-08-22 08:31:52.662962 | controller | "isdir": true, 2026-08-22 08:31:52.662979 | controller | "isfifo": false, 2026-08-22 08:31:52.662996 | controller | "isgid": false, 2026-08-22 08:31:52.663013 | controller | "islnk": false, 2026-08-22 08:31:52.663086 | controller | "isreg": false, 2026-08-22 08:31:52.663108 | controller | "issock": false, 2026-08-22 08:31:52.663125 | controller | "isuid": false, 2026-08-22 08:31:52.663142 | controller | "mimetype": "unknown", 2026-08-22 08:31:52.663158 | controller | "mode": "0755", 2026-08-22 08:31:52.663175 | controller | "mtime": 1787387475.8116949, 2026-08-22 08:31:52.663191 | controller | "nlink": 14, 2026-08-22 08:31:52.663208 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-08-22 08:31:52.663225 | controller | "pw_name": "zuul", 2026-08-22 08:31:52.663246 | controller | "readable": true, 2026-08-22 08:31:52.663264 | controller | "rgrp": true, 2026-08-22 08:31:52.663281 | controller | "roth": true, 2026-08-22 08:31:52.663298 | controller | "rusr": true, 2026-08-22 08:31:52.663315 | controller | "size": 4096, 2026-08-22 08:31:52.663332 | controller | "uid": 1000, 2026-08-22 08:31:52.663349 | controller | "version": "3496029469", 2026-08-22 08:31:52.663366 | controller | "wgrp": false, 2026-08-22 08:31:52.663384 | controller | "woth": false, 2026-08-22 08:31:52.663401 | controller | "writeable": true, 2026-08-22 08:31:52.663418 | controller | "wusr": true, 2026-08-22 08:31:52.663435 | controller | "xgrp": true, 2026-08-22 08:31:52.663452 | controller | "xoth": true, 2026-08-22 08:31:52.663469 | controller | "xusr": true 2026-08-22 08:31:52.663500 | controller | } 2026-08-22 08:31:52.663518 | controller | } 2026-08-22 08:31:52.663553 | controller | ok: All items complete 2026-08-22 08:31:52.663575 | 2026-08-22 08:31:52.665000 | controller | skipping: Conditional result was False 2026-08-22 08:31:52.665682 | controller | skipping: Conditional result was False 2026-08-22 08:31:52.683877 | 2026-08-22 08:31:52.684061 | LOOP [Switch "ansible_host" to private IP] 2026-08-22 08:31:53.063161 | controller | changed: 1 replacements made 2026-08-22 08:31:53.064865 | controller | skipping: Conditional result was False 2026-08-22 08:31:53.066500 | controller | skipping: Conditional result was False 2026-08-22 08:31:53.083941 | 2026-08-22 08:31:53.084104 | TASK [Run Molecule scenario] 2026-08-22 08:31:53.534875 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-08-22 08:31:53.535000 | controller | Creating virtual environment at: .venv 2026-08-22 08:31:53.787678 | controller | Downloading cryptography (4.3MiB) 2026-08-22 08:31:53.789063 | controller | Downloading ansible-core (2.3MiB) 2026-08-22 08:31:53.789344 | controller | Downloading pygments (1.2MiB) 2026-08-22 08:31:53.944764 | controller | Downloading cryptography 2026-08-22 08:31:54.001782 | controller | Downloading pygments 2026-08-22 08:31:54.172275 | controller | Downloading ansible-core 2026-08-22 08:31:54.220288 | controller | Installed 36 packages in 47ms 2026-08-22 08:31:54.889616 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-08-22 08:31:54.889700 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-08-22 08:31:55.727048 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-08-22 08:31:55.727120 | controller | INFO default scenario not found, disabling shared state. 2026-08-22 08:31:55.727143 | 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 08:31:55.727198 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-08-22 08:32:15.225397 | controller | INFO [upload-helm-chart > dependency] Executing 2026-08-22 08:32:15.225545 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-08-22 08:32:15.225746 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-08-22 08:32:15.226189 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-22 08:32:15.233431 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-08-22 08:32:15.233915 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:32:15.240972 | controller | INFO [upload-helm-chart > destroy] Executing 2026-08-22 08:32:15.241042 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-08-22 08:32:15.241124 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-08-22 08:32:15.247624 | controller | INFO [upload-helm-chart > syntax] Executing 2026-08-22 08:32:16.140578 | controller | 2026-08-22 08:32:16.140770 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-08-22 08:32:16.197279 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-08-22 08:32:16.205719 | controller | INFO [upload-helm-chart > create] Executing 2026-08-22 08:32:16.207801 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:32:16.215469 | controller | INFO [upload-helm-chart > prepare] Executing 2026-08-22 08:32:16.215880 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:32:16.223402 | controller | INFO [upload-helm-chart > converge] Executing 2026-08-22 08:32:17.076362 | controller | 2026-08-22 08:32:17.076633 | controller | PLAY [Converge] **************************************************************** 2026-08-22 08:32:17.076856 | controller | 2026-08-22 08:32:17.077126 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:32:17.077417 | controller | Saturday 22 August 2026 08:32:17 +0000 (0:00:00.035) 0:00:00.035 ******* 2026-08-22 08:32:18.276614 | 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 08:32:18.282706 | controller | ok: [controller] 2026-08-22 08:32:18.282884 | controller | 2026-08-22 08:32:18.283089 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:18.283287 | controller | Saturday 22 August 2026 08:32:18 +0000 (0:00:01.207) 0:00:01.243 ******* 2026-08-22 08:32:18.363198 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:32:18.363324 | controller | 2026-08-22 08:32:18.363516 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:32:18.363773 | controller | Saturday 22 August 2026 08:32:18 +0000 (0:00:00.080) 0:00:01.323 ******* 2026-08-22 08:32:18.996572 | controller | changed: [controller] 2026-08-22 08:32:18.996722 | controller | 2026-08-22 08:32:18.996947 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:18.997154 | controller | Saturday 22 August 2026 08:32:18 +0000 (0:00:00.633) 0:00:01.956 ******* 2026-08-22 08:32:19.049084 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:32:19.049233 | controller | 2026-08-22 08:32:19.049437 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:32:19.049682 | controller | Saturday 22 August 2026 08:32:19 +0000 (0:00:00.052) 0:00:02.009 ******* 2026-08-22 08:32:19.438863 | controller | changed: [controller] 2026-08-22 08:32:19.439006 | controller | 2026-08-22 08:32:19.439277 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:32:19.439479 | controller | Saturday 22 August 2026 08:32:19 +0000 (0:00:00.389) 0:00:02.398 ******* 2026-08-22 08:32:20.499940 | controller | changed: [controller] 2026-08-22 08:32:20.500107 | controller | 2026-08-22 08:32:20.500321 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:32:20.500514 | controller | Saturday 22 August 2026 08:32:20 +0000 (0:00:01.061) 0:00:03.459 ******* 2026-08-22 08:32:20.935403 | controller | ok: [controller] 2026-08-22 08:32:20.935565 | controller | 2026-08-22 08:32:20.935788 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:32:20.935991 | controller | Saturday 22 August 2026 08:32:20 +0000 (0:00:00.435) 0:00:03.895 ******* 2026-08-22 08:32:20.988053 | controller | skipping: [controller] 2026-08-22 08:32:20.988298 | controller | 2026-08-22 08:32:20.988532 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:32:20.988772 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 08:32:20.988978 | controller | 2026-08-22 08:32:20.989158 | controller | 2026-08-22 08:32:20.989391 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:32:20.989672 | controller | Saturday 22 August 2026 08:32:20 +0000 (0:00:00.053) 0:00:03.948 ******* 2026-08-22 08:32:20.989860 | controller | =============================================================================== 2026-08-22 08:32:20.990081 | controller | Gathering Facts --------------------------------------------------------- 1.21s 2026-08-22 08:32:20.990296 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.06s 2026-08-22 08:32:20.990507 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.63s 2026-08-22 08:32:20.990738 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s 2026-08-22 08:32:20.990935 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.39s 2026-08-22 08:32:20.991218 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-08-22 08:32:20.991446 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-08-22 08:32:20.991675 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-08-22 08:32:21.068649 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-08-22 08:32:21.078549 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-08-22 08:32:21.895015 | controller | 2026-08-22 08:32:21.895141 | controller | PLAY [Converge] **************************************************************** 2026-08-22 08:32:21.895350 | controller | 2026-08-22 08:32:21.895553 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:32:21.895760 | controller | Saturday 22 August 2026 08:32:21 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-08-22 08:32:22.961183 | 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 08:32:22.966892 | controller | ok: [controller] 2026-08-22 08:32:22.967068 | controller | 2026-08-22 08:32:22.967274 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:22.967465 | controller | Saturday 22 August 2026 08:32:22 +0000 (0:00:01.072) 0:00:01.083 ******* 2026-08-22 08:32:23.040986 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:32:23.041125 | controller | 2026-08-22 08:32:23.041320 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:32:23.041628 | controller | Saturday 22 August 2026 08:32:23 +0000 (0:00:00.074) 0:00:01.157 ******* 2026-08-22 08:32:23.669405 | controller | ok: [controller] 2026-08-22 08:32:23.669596 | controller | 2026-08-22 08:32:23.669826 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:23.670028 | controller | Saturday 22 August 2026 08:32:23 +0000 (0:00:00.628) 0:00:01.785 ******* 2026-08-22 08:32:23.707652 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:32:23.707766 | controller | 2026-08-22 08:32:23.707967 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:32:23.708154 | controller | Saturday 22 August 2026 08:32:23 +0000 (0:00:00.038) 0:00:01.824 ******* 2026-08-22 08:32:24.100075 | controller | ok: [controller] 2026-08-22 08:32:24.100275 | controller | 2026-08-22 08:32:24.100521 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:32:24.100749 | controller | Saturday 22 August 2026 08:32:24 +0000 (0:00:00.391) 0:00:02.216 ******* 2026-08-22 08:32:25.184321 | controller | ok: [controller] 2026-08-22 08:32:25.184496 | controller | 2026-08-22 08:32:25.184716 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:32:25.184988 | controller | Saturday 22 August 2026 08:32:25 +0000 (0:00:01.083) 0:00:03.299 ******* 2026-08-22 08:32:25.609182 | controller | ok: [controller] 2026-08-22 08:32:25.609294 | controller | 2026-08-22 08:32:25.609572 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:32:25.609622 | controller | Saturday 22 August 2026 08:32:25 +0000 (0:00:00.425) 0:00:03.725 ******* 2026-08-22 08:32:25.651906 | controller | skipping: [controller] 2026-08-22 08:32:25.652097 | controller | 2026-08-22 08:32:25.652386 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:32:25.652634 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 08:32:25.652820 | controller | 2026-08-22 08:32:25.653005 | controller | 2026-08-22 08:32:25.653209 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:32:25.653419 | controller | Saturday 22 August 2026 08:32:25 +0000 (0:00:00.043) 0:00:03.768 ******* 2026-08-22 08:32:25.653695 | controller | =============================================================================== 2026-08-22 08:32:25.653912 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.08s 2026-08-22 08:32:25.654122 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-08-22 08:32:25.654319 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.63s 2026-08-22 08:32:25.654537 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-08-22 08:32:25.654737 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.39s 2026-08-22 08:32:25.654952 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-08-22 08:32:25.655163 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-08-22 08:32:25.655373 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-08-22 08:32:25.739777 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-08-22 08:32:25.751611 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-08-22 08:32:26.639296 | controller | 2026-08-22 08:32:26.639463 | controller | PLAY [Side effect] ************************************************************* 2026-08-22 08:32:26.639644 | controller | 2026-08-22 08:32:26.639844 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:32:26.640057 | controller | Saturday 22 August 2026 08:32:26 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-08-22 08:32:27.684242 | 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 08:32:27.689485 | controller | ok: [controller] 2026-08-22 08:32:27.689677 | controller | 2026-08-22 08:32:27.689896 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:27.690096 | controller | Saturday 22 August 2026 08:32:27 +0000 (0:00:01.050) 0:00:01.061 ******* 2026-08-22 08:32:27.759998 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:32:27.760104 | controller | 2026-08-22 08:32:27.760254 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:32:27.760389 | controller | Saturday 22 August 2026 08:32:27 +0000 (0:00:00.070) 0:00:01.132 ******* 2026-08-22 08:32:28.403533 | controller | changed: [controller] 2026-08-22 08:32:28.403747 | controller | 2026-08-22 08:32:28.404052 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:32:28.404337 | controller | Saturday 22 August 2026 08:32:28 +0000 (0:00:00.643) 0:00:01.775 ******* 2026-08-22 08:32:28.441370 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:32:28.441483 | controller | 2026-08-22 08:32:28.441668 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:32:28.441802 | controller | Saturday 22 August 2026 08:32:28 +0000 (0:00:00.038) 0:00:01.813 ******* 2026-08-22 08:32:28.864950 | controller | ok: [controller] 2026-08-22 08:32:28.864981 | controller | 2026-08-22 08:32:28.864990 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:32:28.864998 | controller | Saturday 22 August 2026 08:32:28 +0000 (0:00:00.421) 0:00:02.235 ******* 2026-08-22 08:32:29.958241 | controller | ok: [controller] 2026-08-22 08:32:29.958267 | controller | 2026-08-22 08:32:29.958275 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:32:29.958280 | controller | Saturday 22 August 2026 08:32:29 +0000 (0:00:01.093) 0:00:03.328 ******* 2026-08-22 08:32:30.364580 | controller | ok: [controller] 2026-08-22 08:32:30.365929 | controller | 2026-08-22 08:32:30.365941 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:32:30.365947 | controller | Saturday 22 August 2026 08:32:30 +0000 (0:00:00.408) 0:00:03.736 ******* 2026-08-22 08:32:30.682075 | controller | changed: [controller] => (item=/file) 2026-08-22 08:32:30.682356 | controller | 2026-08-22 08:32:30.682607 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:32:30.682893 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-08-22 08:32:30.683122 | controller | 2026-08-22 08:32:30.683346 | controller | 2026-08-22 08:32:30.683589 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:32:30.683849 | controller | Saturday 22 August 2026 08:32:30 +0000 (0:00:00.316) 0:00:04.053 ******* 2026-08-22 08:32:30.684085 | controller | =============================================================================== 2026-08-22 08:32:30.684339 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.09s 2026-08-22 08:32:30.684580 | controller | Gathering Facts --------------------------------------------------------- 1.05s 2026-08-22 08:32:30.684824 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.64s 2026-08-22 08:32:30.685138 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s 2026-08-22 08:32:30.685397 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s 2026-08-22 08:32:30.685721 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s 2026-08-22 08:32:30.685984 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-08-22 08:32:30.686242 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-08-22 08:32:30.780252 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-08-22 08:32:30.797751 | controller | INFO [upload-helm-chart > verify] Executing 2026-08-22 08:32:31.640509 | controller | 2026-08-22 08:32:31.640884 | controller | PLAY [Verify] ****************************************************************** 2026-08-22 08:32:31.641201 | controller | 2026-08-22 08:32:31.641753 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:32:31.642074 | controller | Saturday 22 August 2026 08:32:31 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-08-22 08:32:32.702024 | 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 08:32:32.704797 | controller | ok: [controller] 2026-08-22 08:32:32.704811 | controller | 2026-08-22 08:32:32.704816 | controller | TASK [Stat file 1] ************************************************************* 2026-08-22 08:32:32.704821 | controller | Saturday 22 August 2026 08:32:32 +0000 (0:00:01.064) 0:00:01.073 ******* 2026-08-22 08:32:33.098298 | controller | ok: [controller] 2026-08-22 08:32:33.098397 | controller | 2026-08-22 08:32:33.098534 | controller | TASK [Stat file 2] ************************************************************* 2026-08-22 08:32:33.098665 | controller | Saturday 22 August 2026 08:32:33 +0000 (0:00:00.393) 0:00:01.466 ******* 2026-08-22 08:32:33.398513 | controller | ok: [controller] 2026-08-22 08:32:33.398608 | controller | 2026-08-22 08:32:33.398740 | controller | TASK [Stat removed file 1] ***************************************************** 2026-08-22 08:32:33.398923 | controller | Saturday 22 August 2026 08:32:33 +0000 (0:00:00.300) 0:00:01.766 ******* 2026-08-22 08:32:33.694098 | controller | ok: [controller] 2026-08-22 08:32:33.694193 | controller | 2026-08-22 08:32:33.694203 | controller | TASK [Stat removed file 2] ***************************************************** 2026-08-22 08:32:33.694257 | controller | Saturday 22 August 2026 08:32:33 +0000 (0:00:00.293) 0:00:02.060 ******* 2026-08-22 08:32:33.986732 | controller | ok: [controller] 2026-08-22 08:32:33.986781 | controller | 2026-08-22 08:32:33.986857 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-08-22 08:32:33.986952 | controller | Saturday 22 August 2026 08:32:33 +0000 (0:00:00.295) 0:00:02.356 ******* 2026-08-22 08:32:34.020461 | controller | ok: [controller] => { 2026-08-22 08:32:34.020647 | controller | "changed": false, 2026-08-22 08:32:34.020858 | controller | "msg": "All assertions passed" 2026-08-22 08:32:34.021563 | controller | } 2026-08-22 08:32:34.021604 | controller | 2026-08-22 08:32:34.021609 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:32:34.023757 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-08-22 08:32:34.023789 | controller | 2026-08-22 08:32:34.023869 | controller | 2026-08-22 08:32:34.023882 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:32:34.023891 | controller | Saturday 22 August 2026 08:32:34 +0000 (0:00:00.034) 0:00:02.390 ******* 2026-08-22 08:32:34.023900 | controller | =============================================================================== 2026-08-22 08:32:34.023909 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-08-22 08:32:34.023918 | controller | Stat file 1 ------------------------------------------------------------- 0.39s 2026-08-22 08:32:34.023927 | controller | Stat file 2 ------------------------------------------------------------- 0.30s 2026-08-22 08:32:34.023934 | controller | Stat removed file 2 ----------------------------------------------------- 0.30s 2026-08-22 08:32:34.023941 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s 2026-08-22 08:32:34.023948 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-08-22 08:32:34.177924 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-08-22 08:32:34.187262 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-08-22 08:32:34.187721 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:32:34.194821 | controller | INFO [upload-helm-chart > destroy] Executing 2026-08-22 08:32:34.194967 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-08-22 08:32:34.195085 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-08-22 08:32:34.195423 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-08-22 08:32:35.006494 | controller | ok: Runtime: 0:00:40.819546 2026-08-22 08:32:35.011374 | 2026-08-22 08:32:35.011447 | PLAY RECAP 2026-08-22 08:32:35.011518 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:32:35.011569 | 2026-08-22 08:32:35.155625 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 08:32:35.157311 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-08-22 08:32:36.090479 | 2026-08-22 08:32:36.090824 | PLAY [all] 2026-08-22 08:32:36.103353 | 2026-08-22 08:32:36.103497 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-22 08:32:36.497129 | controller | changed 2026-08-22 08:32:36.501752 | 2026-08-22 08:32:36.501859 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-22 08:32:36.911143 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:32:36.911380 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:32:36.920659 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:32:36.922543 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:32:36.923699 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:32:36.927252 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:32:36.927430 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:32:36.929564 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:32:36.930533 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:32:36.933153 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:32:36.933171 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:32:36.934666 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:32:37.030579 | controller | ok: Runtime: 0:00:00.035285 2026-08-22 08:32:37.039232 | 2026-08-22 08:32:37.039403 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-22 08:32:37.264728 | controller | changed 2026-08-22 08:32:37.270810 | 2026-08-22 08:32:37.270912 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-22 08:32:37.513129 | controller | environment: line 5: kubectl: command not found 2026-08-22 08:32:37.513401 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:32:37.514942 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:32:37.515462 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:32:37.804369 | controller | ok: Runtime: 0:00:00.015189 2026-08-22 08:32:37.812520 | 2026-08-22 08:32:37.812588 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-22 08:32:38.452069 | controller | changed: 2026-08-22 08:32:38.452258 | controller | created directory /var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/logs/controller 2026-08-22 08:32:38.452299 | controller | cd+++++++++ objects/ 2026-08-22 08:32:38.452330 | controller | cd+++++++++ objects/cluster/ 2026-08-22 08:32:38.452362 | controller | cd+++++++++ objects/namespaced/ 2026-08-22 08:32:38.462242 | 2026-08-22 08:32:38.462329 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-22 08:32:38.715378 | controller | changed 2026-08-22 08:32:38.719542 | 2026-08-22 08:32:38.719610 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-22 08:32:38.973945 | controller | changed 2026-08-22 08:32:38.979541 | 2026-08-22 08:32:38.979641 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-22 08:32:39.217310 | controller | environment: line 3: kubectl: command not found 2026-08-22 08:32:39.510323 | controller | ok: Runtime: 0:00:00.013678 2026-08-22 08:32:39.517530 | 2026-08-22 08:32:39.517606 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-22 08:32:40.044471 | controller | changed: 2026-08-22 08:32:40.044691 | controller | cd+++++++++ pod-logs/ 2026-08-22 08:32:40.044730 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-08-22 08:32:40.054248 | 2026-08-22 08:32:40.054311 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-22 08:32:40.303524 | controller | changed: "values" 2026-08-22 08:32:40.521565 | controller | changed: "releases" 2026-08-22 08:32:40.540648 | 2026-08-22 08:32:40.540839 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-22 08:32:40.788946 | controller | /bin/bash: line 3: kubectl: command not found 2026-08-22 08:32:41.072590 | controller | ok: Runtime: 0:00:00.009461 2026-08-22 08:32:41.080594 | 2026-08-22 08:32:41.080679 | TASK [helm-release-status : Downloads logs to executor] 2026-08-22 08:32:41.611447 | controller | changed: 2026-08-22 08:32:41.611694 | controller | cd+++++++++ helm/ 2026-08-22 08:32:41.611736 | controller | cd+++++++++ helm/releases/ 2026-08-22 08:32:41.611773 | controller | cd+++++++++ helm/values/ 2026-08-22 08:32:41.619848 | 2026-08-22 08:32:41.619947 | PLAY RECAP 2026-08-22 08:32:41.620016 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:32:41.620048 | 2026-08-22 08:32:41.815098 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-08-22 08:32:41.818063 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 08:32:42.566065 | 2026-08-22 08:32:42.566234 | PLAY [all] 2026-08-22 08:32:42.578032 | 2026-08-22 08:32:42.578124 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-22 08:32:42.623713 | controller | skipping: Conditional result was False 2026-08-22 08:32:42.632290 | 2026-08-22 08:32:42.632407 | TASK [fetch-output : Set log path for single node] 2026-08-22 08:32:42.676786 | controller | ok 2026-08-22 08:32:42.681187 | 2026-08-22 08:32:42.681255 | LOOP [fetch-output : Ensure local output dirs] 2026-08-22 08:32:43.089959 | controller -> localhost | ok: "/var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/logs" 2026-08-22 08:32:43.311000 | controller -> localhost | changed: "/var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/artifacts" 2026-08-22 08:32:43.528225 | controller -> localhost | changed: "/var/lib/zuul/builds/6e89c57dd7aa400e8864b760c8f05b27/work/docs" 2026-08-22 08:32:43.541474 | 2026-08-22 08:32:43.541641 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-22 08:32:44.246421 | controller | changed: .d..t...... ./ 2026-08-22 08:32:44.246627 | controller | changed: All items complete 2026-08-22 08:32:44.246654 | 2026-08-22 08:32:44.731959 | controller | changed: .d..t...... ./ 2026-08-22 08:32:45.206030 | controller | changed: .d..t...... ./ 2026-08-22 08:32:45.231483 | 2026-08-22 08:32:45.231629 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-22 08:32:45.701965 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008367 2026-08-22 08:32:45.929615 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007977 2026-08-22 08:32:45.947905 | 2026-08-22 08:32:45.947971 | PLAY [all] 2026-08-22 08:32:45.952863 | 2026-08-22 08:32:45.952929 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-22 08:32:46.431345 | controller | changed 2026-08-22 08:32:46.439220 | 2026-08-22 08:32:46.439369 | PLAY RECAP 2026-08-22 08:32:46.439442 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 08:32:46.439472 | 2026-08-22 08:32:46.605589 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 08:32:46.609376 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-22 08:32:47.270098 | 2026-08-22 08:32:47.270670 | PLAY [localhost] 2026-08-22 08:32:47.286353 | 2026-08-22 08:32:47.286587 | TASK [Generate Zuul manifest] 2026-08-22 08:32:47.309060 | localhost | ok 2026-08-22 08:32:47.453194 | 2026-08-22 08:32:47.453366 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-22 08:32:47.878866 | localhost | changed 2026-08-22 08:32:47.893555 | 2026-08-22 08:32:47.893677 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-22 08:32:47.923404 | localhost | ok 2026-08-22 08:32:47.932647 | 2026-08-22 08:32:47.932747 | TASK [Upload logs] 2026-08-22 08:32:47.956401 | localhost | ok 2026-08-22 08:32:48.088705 | 2026-08-22 08:32:48.088844 | TASK [Set zuul-log-path fact] 2026-08-22 08:32:48.107056 | localhost | ok 2026-08-22 08:32:48.122207 | 2026-08-22 08:32:48.122355 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 08:32:48.154816 | localhost | ok 2026-08-22 08:32:48.166342 | 2026-08-22 08:32:48.166471 | TASK [upload-logs : Create log directories] 2026-08-22 08:32:48.654300 | localhost | changed 2026-08-22 08:32:48.661434 | 2026-08-22 08:32:48.661556 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-22 08:32:49.098062 | localhost -> localhost | ok: Runtime: 0:00:00.005984 2026-08-22 08:32:49.105522 | 2026-08-22 08:32:49.105608 | TASK [upload-logs : Upload logs to log server] 2026-08-22 08:32:50.231788 | localhost | Output suppressed because no_log was given 2026-08-22 08:32:50.236724 | 2026-08-22 08:32:50.236826 | LOOP [upload-logs : Compress console log and json output] 2026-08-22 08:32:50.292860 | localhost | skipping: Conditional result was False 2026-08-22 08:32:50.346894 | localhost | skipping: Conditional result was False 2026-08-22 08:32:50.365222 | 2026-08-22 08:32:50.365402 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-22 08:32:50.419158 | localhost | skipping: Conditional result was False 2026-08-22 08:32:50.419670 | 2026-08-22 08:32:50.423375 | localhost | skipping: Conditional result was False 2026-08-22 08:32:50.437167 | 2026-08-22 08:32:50.437504 | LOOP [upload-logs : Upload console log and json output]