2026-09-10 21:17:01.003328 | Job console starting 2026-09-10 21:17:01.015374 | Updating git repos 2026-09-10 21:17:01.068755 | Cloning repos into workspace 2026-09-10 21:17:01.110314 | Restoring repo states 2026-09-10 21:17:01.131400 | Merging changes 2026-09-10 21:17:01.992788 | Checking out repos 2026-09-10 21:17:02.316430 | Preparing playbooks 2026-09-10 21:17:04.515827 | Running Ansible setup 2026-09-10 21:17:08.186992 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-10 21:17:08.813033 | 2026-09-10 21:17:08.813266 | PLAY [localhost] 2026-09-10 21:17:08.822381 | 2026-09-10 21:17:08.822586 | TASK [Gathering Facts] 2026-09-10 21:17:09.812367 | localhost | ok 2026-09-10 21:17:09.822420 | 2026-09-10 21:17:09.822523 | TASK [Setup log path fact] 2026-09-10 21:17:09.841265 | localhost | ok 2026-09-10 21:17:09.858343 | 2026-09-10 21:17:09.858439 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 21:17:09.899881 | localhost | ok 2026-09-10 21:17:09.909665 | 2026-09-10 21:17:09.909813 | TASK [emit-job-header : Print job information] 2026-09-10 21:17:09.961124 | # Job Information 2026-09-10 21:17:09.961360 | Ansible Version: 2.16.18 2026-09-10 21:17:09.961413 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-09-10 21:17:09.961449 | Pipeline: check 2026-09-10 21:17:09.961479 | Executor: 2d72f0692154 2026-09-10 21:17:09.961509 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/300 2026-09-10 21:17:09.961542 | Event ID: 628dc250-ad5c-11f1-880f-7bd6db772b47 2026-09-10 21:17:09.965943 | 2026-09-10 21:17:09.966038 | LOOP [emit-job-header : Print node information] 2026-09-10 21:17:10.115056 | localhost | ok: 2026-09-10 21:17:10.115958 | localhost | # Node Information 2026-09-10 21:17:10.116008 | localhost | Inventory Hostname: controller 2026-09-10 21:17:10.116045 | localhost | Hostname: np0000192543 2026-09-10 21:17:10.116077 | localhost | Username: zuul 2026-09-10 21:17:10.116114 | localhost | Distro: Debian 13.6 2026-09-10 21:17:10.116147 | localhost | Provider: yul1 2026-09-10 21:17:10.116177 | localhost | Region: ca-ymq-1 2026-09-10 21:17:10.116208 | localhost | Label: debian-trixie 2026-09-10 21:17:10.116239 | localhost | Product Name: OpenStack Nova 2026-09-10 21:17:10.116269 | localhost | Interface IP: 162.253.55.92 2026-09-10 21:17:10.125097 | 2026-09-10 21:17:10.125207 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-10 21:17:10.513536 | localhost -> localhost | changed 2026-09-10 21:17:10.521728 | 2026-09-10 21:17:10.521828 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-10 21:17:11.457790 | localhost -> localhost | changed 2026-09-10 21:17:11.470096 | 2026-09-10 21:17:11.470230 | PLAY [all] 2026-09-10 21:17:11.492801 | 2026-09-10 21:17:11.493034 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-10 21:17:11.740416 | controller -> localhost | ok 2026-09-10 21:17:11.745611 | 2026-09-10 21:17:11.745679 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-10 21:17:11.773138 | controller | ok 2026-09-10 21:17:11.786288 | controller | included: /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-10 21:17:11.790588 | 2026-09-10 21:17:11.790650 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-10 21:17:13.719896 | controller -> localhost | Generating public/private rsa key pair. 2026-09-10 21:17:13.720181 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/e53123f24fd54425a8f9cbe20cbc3333_id_rsa 2026-09-10 21:17:13.720236 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/e53123f24fd54425a8f9cbe20cbc3333_id_rsa.pub 2026-09-10 21:17:13.720276 | controller -> localhost | The key fingerprint is: 2026-09-10 21:17:13.720314 | controller -> localhost | SHA256:anBZ/9u8QP8DqhGwc1oHV6ZcN4xMBpVZKNtMb+WS6LU zuul-build-sshkey 2026-09-10 21:17:13.720391 | controller -> localhost | The key's randomart image is: 2026-09-10 21:17:13.720431 | controller -> localhost | +---[RSA 3072]----+ 2026-09-10 21:17:13.720474 | controller -> localhost | | .=BB+ | 2026-09-10 21:17:13.720550 | controller -> localhost | | ..*B..o| 2026-09-10 21:17:13.720591 | controller -> localhost | | ... +*..o.| 2026-09-10 21:17:13.720629 | controller -> localhost | | oo.o..o+o.| 2026-09-10 21:17:13.720666 | controller -> localhost | | . ooS+.o...o | 2026-09-10 21:17:13.720703 | controller -> localhost | | o .= oo.oE | 2026-09-10 21:17:13.720740 | controller -> localhost | | o. . + o | 2026-09-10 21:17:13.720778 | controller -> localhost | | . .. = o | 2026-09-10 21:17:13.720822 | controller -> localhost | | .. . +.o| 2026-09-10 21:17:13.720864 | controller -> localhost | +----[SHA256]-----+ 2026-09-10 21:17:13.720959 | controller -> localhost | ok: Runtime: 0:00:01.508098 2026-09-10 21:17:13.728836 | 2026-09-10 21:17:13.728934 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-10 21:17:13.761926 | controller | ok 2026-09-10 21:17:13.770013 | controller | included: /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-10 21:17:13.776590 | 2026-09-10 21:17:13.776736 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-10 21:17:13.798753 | controller | skipping: Conditional result was False 2026-09-10 21:17:13.807704 | 2026-09-10 21:17:13.807864 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-10 21:17:14.441168 | controller | changed 2026-09-10 21:17:14.449504 | 2026-09-10 21:17:14.449637 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-10 21:17:14.680733 | controller | ok 2026-09-10 21:17:14.688613 | 2026-09-10 21:17:14.688739 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-10 21:17:15.318299 | controller | changed 2026-09-10 21:17:15.328776 | 2026-09-10 21:17:15.328876 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-10 21:17:15.879406 | controller | changed 2026-09-10 21:17:15.884807 | 2026-09-10 21:17:15.884873 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-10 21:17:15.900373 | controller | skipping: Conditional result was False 2026-09-10 21:17:15.907461 | 2026-09-10 21:17:15.907527 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-10 21:17:16.373939 | controller -> localhost | changed 2026-09-10 21:17:16.387868 | 2026-09-10 21:17:16.387964 | TASK [add-build-sshkey : Add back temp key] 2026-09-10 21:17:16.681925 | controller -> localhost | Identity added: /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/e53123f24fd54425a8f9cbe20cbc3333_id_rsa (zuul-build-sshkey) 2026-09-10 21:17:16.682300 | controller -> localhost | ok: Runtime: 0:00:00.012266 2026-09-10 21:17:16.694320 | 2026-09-10 21:17:16.694613 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-10 21:17:17.062355 | controller | ok 2026-09-10 21:17:17.066521 | 2026-09-10 21:17:17.066613 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-10 21:17:17.092276 | controller | skipping: Conditional result was False 2026-09-10 21:17:17.107355 | 2026-09-10 21:17:17.107573 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-10 21:17:17.521067 | controller | ok 2026-09-10 21:17:17.534362 | 2026-09-10 21:17:17.535115 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-10 21:17:18.659717 | controller | Output suppressed because no_log was given 2026-09-10 21:17:18.676972 | 2026-09-10 21:17:18.677164 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-10 21:17:18.919360 | controller | ok: "logs" 2026-09-10 21:17:18.919671 | controller | ok: All items complete 2026-09-10 21:17:18.919716 | 2026-09-10 21:17:19.139659 | controller | ok: "artifacts" 2026-09-10 21:17:19.335564 | controller | ok: "docs" 2026-09-10 21:17:19.352321 | 2026-09-10 21:17:19.352604 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-10 21:17:19.583595 | controller | changed: "logs" 2026-09-10 21:17:19.761482 | controller | changed: "artifacts" 2026-09-10 21:17:19.935245 | controller | changed: "docs" 2026-09-10 21:17:19.948647 | 2026-09-10 21:17:19.948829 | PLAY RECAP 2026-09-10 21:17:19.948921 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-10 21:17:19.948975 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 21:17:19.949016 | 2026-09-10 21:17:20.149268 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-10 21:17:20.150503 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-10 21:17:20.838310 | 2026-09-10 21:17:20.838523 | PLAY [all] 2026-09-10 21:17:20.849232 | 2026-09-10 21:17:20.849383 | TASK [setup-uv : Extract archive] 2026-09-10 21:17:23.401058 | controller | changed 2026-09-10 21:17:23.410367 | 2026-09-10 21:17:23.410527 | TASK [setup-uv : Print version] 2026-09-10 21:17:23.857966 | controller | uv 0.8.13 2026-09-10 21:17:23.951256 | controller | ok: Runtime: 0:00:00.018702 2026-09-10 21:17:23.967672 | 2026-09-10 21:17:23.967908 | TASK [Install Ansible collection siblings] 2026-09-10 21:17:24.446812 | controller | ok: 2026-09-10 21:17:24.447079 | controller | Skipping ansible.posix: no checked-out sibling 2026-09-10 21:17:24.447135 | controller | Skipping community.crypto: no checked-out sibling 2026-09-10 21:17:24.447177 | controller | Skipping community.general: no checked-out sibling 2026-09-10 21:17:24.447214 | controller | Skipping kubernetes.core: no checked-out sibling 2026-09-10 21:17:24.447251 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-09-10 21:17:24.450120 | 2026-09-10 21:17:24.450205 | PLAY RECAP 2026-09-10 21:17:24.450287 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 21:17:24.450350 | 2026-09-10 21:17:24.602657 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-10 21:17:24.605433 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-09-10 21:17:25.216242 | 2026-09-10 21:17:25.216385 | PLAY [all] 2026-09-10 21:17:25.226031 | 2026-09-10 21:17:25.226103 | TASK [Update apt cache] 2026-09-10 21:17:30.975720 | controller | ok 2026-09-10 21:17:30.983321 | 2026-09-10 21:17:30.983491 | TASK [Disable firewalld] 2026-09-10 21:17:31.009460 | controller | skipping: Conditional result was False 2026-09-10 21:17:31.017610 | 2026-09-10 21:17:31.017742 | TASK [Install "jq" for log collection] 2026-09-10 21:17:34.181209 | controller | changed 2026-09-10 21:17:34.183043 | 2026-09-10 21:17:34.183092 | PLAY RECAP 2026-09-10 21:17:34.183133 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-10 21:17:34.183151 | 2026-09-10 21:17:34.340681 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-09-10 21:17:34.343245 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-10 21:17:34.910181 | 2026-09-10 21:17:34.910312 | PLAY [all] 2026-09-10 21:17:34.919778 | 2026-09-10 21:17:34.919862 | LOOP [Check inventory directories] 2026-09-10 21:17:35.313076 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-09-10 21:17:35.501124 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory" 2026-09-10 21:17:35.717773 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory" 2026-09-10 21:17:35.734775 | 2026-09-10 21:17:35.735020 | LOOP [Copy inventory file for Zuul] 2026-09-10 21:17:36.760406 | controller | changed: 2026-09-10 21:17:36.760901 | controller | { 2026-09-10 21:17:36.761002 | controller | "ansible_loop_var": "item", 2026-09-10 21:17:36.761055 | controller | "changed": false, 2026-09-10 21:17:36.761127 | controller | "failed": false, 2026-09-10 21:17:36.761218 | controller | "invocation": { 2026-09-10 21:17:36.761260 | controller | "module_args": { 2026-09-10 21:17:36.761350 | controller | "checksum_algorithm": "sha1", 2026-09-10 21:17:36.761434 | controller | "follow": true, 2026-09-10 21:17:36.761495 | controller | "get_attributes": true, 2026-09-10 21:17:36.761542 | controller | "get_checksum": true, 2026-09-10 21:17:36.761619 | controller | "get_mime": true, 2026-09-10 21:17:36.761893 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-09-10 21:17:36.761945 | controller | } 2026-09-10 21:17:36.762013 | controller | }, 2026-09-10 21:17:36.762087 | controller | "item": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-09-10 21:17:36.762128 | controller | "stat": { 2026-09-10 21:17:36.762161 | controller | "atime": 1789075038.5003958, 2026-09-10 21:17:36.762195 | controller | "attr_flags": "e", 2026-09-10 21:17:36.762229 | controller | "attributes": [ 2026-09-10 21:17:36.762262 | controller | "extents" 2026-09-10 21:17:36.762294 | controller | ], 2026-09-10 21:17:36.762368 | controller | "block_size": 4096, 2026-09-10 21:17:36.762410 | controller | "blocks": 8, 2026-09-10 21:17:36.762444 | controller | "charset": "unknown", 2026-09-10 21:17:36.762479 | controller | "ctime": 1789075038.5403967, 2026-09-10 21:17:36.762513 | controller | "dev": 65025, 2026-09-10 21:17:36.762545 | controller | "device_type": 0, 2026-09-10 21:17:36.762577 | controller | "executable": true, 2026-09-10 21:17:36.762668 | controller | "exists": true, 2026-09-10 21:17:36.762701 | controller | "gid": 1000, 2026-09-10 21:17:36.762734 | controller | "gr_name": "zuul", 2026-09-10 21:17:36.762766 | controller | "inode": 521495, 2026-09-10 21:17:36.762798 | controller | "isblk": false, 2026-09-10 21:17:36.762831 | controller | "ischr": false, 2026-09-10 21:17:36.762863 | controller | "isdir": true, 2026-09-10 21:17:36.762897 | controller | "isfifo": false, 2026-09-10 21:17:36.762929 | controller | "isgid": false, 2026-09-10 21:17:36.762960 | controller | "islnk": false, 2026-09-10 21:17:36.763030 | controller | "isreg": false, 2026-09-10 21:17:36.763104 | controller | "issock": false, 2026-09-10 21:17:36.763191 | controller | "isuid": false, 2026-09-10 21:17:36.763229 | controller | "mimetype": "unknown", 2026-09-10 21:17:36.763260 | controller | "mode": "0755", 2026-09-10 21:17:36.763292 | controller | "mtime": 1789075021.2543855, 2026-09-10 21:17:36.763343 | controller | "nlink": 14, 2026-09-10 21:17:36.763401 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-09-10 21:17:36.763485 | controller | "pw_name": "zuul", 2026-09-10 21:17:36.763526 | controller | "readable": true, 2026-09-10 21:17:36.763592 | controller | "rgrp": true, 2026-09-10 21:17:36.763662 | controller | "roth": true, 2026-09-10 21:17:36.763748 | controller | "rusr": true, 2026-09-10 21:17:36.763789 | controller | "size": 4096, 2026-09-10 21:17:36.763851 | controller | "uid": 1000, 2026-09-10 21:17:36.763890 | controller | "version": "1309390622", 2026-09-10 21:17:36.763969 | controller | "wgrp": false, 2026-09-10 21:17:36.764008 | controller | "woth": false, 2026-09-10 21:17:36.764075 | controller | "writeable": true, 2026-09-10 21:17:36.764145 | controller | "wusr": true, 2026-09-10 21:17:36.764227 | controller | "xgrp": true, 2026-09-10 21:17:36.764266 | controller | "xoth": true, 2026-09-10 21:17:36.764341 | controller | "xusr": true 2026-09-10 21:17:36.764445 | controller | } 2026-09-10 21:17:36.764549 | controller | } 2026-09-10 21:17:36.764655 | controller | ok: All items complete 2026-09-10 21:17:36.764742 | 2026-09-10 21:17:36.769219 | controller | skipping: Conditional result was False 2026-09-10 21:17:36.771208 | controller | skipping: Conditional result was False 2026-09-10 21:17:36.779015 | 2026-09-10 21:17:36.779085 | LOOP [Switch "ansible_host" to private IP] 2026-09-10 21:17:37.164989 | controller | changed: 1 replacements made 2026-09-10 21:17:37.169087 | controller | skipping: Conditional result was False 2026-09-10 21:17:37.176203 | controller | skipping: Conditional result was False 2026-09-10 21:17:37.200842 | 2026-09-10 21:17:37.201055 | TASK [Run Molecule scenario] 2026-09-10 21:17:37.690684 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-09-10 21:17:37.690815 | controller | Creating virtual environment at: .venv 2026-09-10 21:17:38.978599 | controller | Downloading cryptography (4.3MiB) 2026-09-10 21:17:38.979449 | controller | Downloading pygments (1.2MiB) 2026-09-10 21:17:38.981254 | controller | Downloading ansible-core (2.3MiB) 2026-09-10 21:17:39.161769 | controller | Downloading cryptography 2026-09-10 21:17:39.219844 | controller | Downloading pygments 2026-09-10 21:17:39.374123 | controller | Downloading ansible-core 2026-09-10 21:17:39.443695 | controller | Installed 36 packages in 68ms 2026-09-10 21:17:40.090257 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-09-10 21:17:40.090314 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-09-10 21:17:40.996143 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-09-10 21:17:40.996202 | controller | INFO default scenario not found, disabling shared state. 2026-09-10 21:17:40.996291 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-10 21:17:40.996357 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-09-10 21:27:45.804138 | controller | INFO [upload-helm-chart > dependency] Executing 2026-09-10 21:27:45.804210 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-09-10 21:27:45.804584 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-09-10 21:27:45.805032 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-10 21:27:45.816940 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-09-10 21:27:45.817597 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 21:27:45.828577 | controller | INFO [upload-helm-chart > destroy] Executing 2026-09-10 21:27:45.828692 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-09-10 21:27:45.828819 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-09-10 21:27:45.838027 | controller | INFO [upload-helm-chart > syntax] Executing 2026-09-10 21:27:46.666320 | controller | 2026-09-10 21:27:46.666564 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-09-10 21:27:46.737157 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-09-10 21:27:46.749282 | controller | INFO [upload-helm-chart > create] Executing 2026-09-10 21:27:46.752259 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 21:27:46.763512 | controller | INFO [upload-helm-chart > prepare] Executing 2026-09-10 21:27:46.764043 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 21:27:46.775047 | controller | INFO [upload-helm-chart > converge] Executing 2026-09-10 21:27:47.607707 | controller | 2026-09-10 21:27:47.607761 | controller | PLAY [Converge] **************************************************************** 2026-09-10 21:27:47.607875 | controller | 2026-09-10 21:27:47.607993 | controller | TASK [Gathering Facts] ********************************************************* 2026-09-10 21:27:47.608114 | controller | Thursday 10 September 2026 21:27:47 +0000 (0:00:00.030) 0:00:00.030 **** 2026-09-10 21:27:48.896967 | 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-09-10 21:27:48.898329 | controller | ok: [controller] 2026-09-10 21:27:48.898520 | controller | 2026-09-10 21:27:48.898709 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:27:48.898893 | controller | Thursday 10 September 2026 21:27:48 +0000 (0:00:01.290) 0:00:01.321 **** 2026-09-10 21:27:49.005777 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-09-10 21:27:49.005920 | controller | 2026-09-10 21:27:49.006102 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-09-10 21:27:49.006280 | controller | Thursday 10 September 2026 21:27:49 +0000 (0:00:00.107) 0:00:01.428 **** 2026-09-10 21:27:49.717299 | controller | changed: [controller] 2026-09-10 21:27:49.717343 | controller | 2026-09-10 21:27:49.717354 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:27:49.717362 | controller | Thursday 10 September 2026 21:27:49 +0000 (0:00:00.709) 0:00:02.137 **** 2026-09-10 21:27:49.772977 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-09-10 21:27:49.773110 | controller | 2026-09-10 21:27:49.773346 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-09-10 21:27:49.773560 | controller | Thursday 10 September 2026 21:27:49 +0000 (0:00:00.057) 0:00:02.195 **** 2026-09-10 21:27:50.200507 | controller | changed: [controller] 2026-09-10 21:27:50.200652 | controller | 2026-09-10 21:27:50.200871 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-09-10 21:27:50.201064 | controller | Thursday 10 September 2026 21:27:50 +0000 (0:00:00.427) 0:00:02.623 **** 2026-09-10 21:27:51.426168 | controller | changed: [controller] 2026-09-10 21:27:51.426201 | controller | 2026-09-10 21:27:51.426209 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-09-10 21:27:51.426214 | controller | Thursday 10 September 2026 21:27:51 +0000 (0:00:01.224) 0:00:03.847 **** 2026-09-10 21:27:51.884999 | controller | ok: [controller] 2026-09-10 21:27:51.885312 | controller | 2026-09-10 21:27:51.885615 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-09-10 21:27:51.885855 | controller | Thursday 10 September 2026 21:27:51 +0000 (0:00:00.459) 0:00:04.307 **** 2026-09-10 21:27:51.958529 | controller | skipping: [controller] 2026-09-10 21:27:51.958760 | controller | 2026-09-10 21:27:51.958984 | controller | PLAY RECAP ********************************************************************* 2026-09-10 21:27:51.959228 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-10 21:27:51.959466 | controller | 2026-09-10 21:27:51.959669 | controller | 2026-09-10 21:27:51.959889 | controller | TASKS RECAP ******************************************************************** 2026-09-10 21:27:51.960113 | controller | Thursday 10 September 2026 21:27:51 +0000 (0:00:00.074) 0:00:04.382 **** 2026-09-10 21:27:51.960324 | controller | =============================================================================== 2026-09-10 21:27:51.960568 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-09-10 21:27:51.960800 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.22s 2026-09-10 21:27:51.961023 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s 2026-09-10 21:27:51.961308 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.46s 2026-09-10 21:27:51.961612 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s 2026-09-10 21:27:51.961872 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.11s 2026-09-10 21:27:51.962125 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.07s 2026-09-10 21:27:51.962356 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-09-10 21:27:52.068557 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-09-10 21:27:52.080055 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-09-10 21:27:52.936768 | controller | 2026-09-10 21:27:52.936841 | controller | PLAY [Converge] **************************************************************** 2026-09-10 21:27:52.937033 | controller | 2026-09-10 21:27:52.937208 | controller | TASK [Gathering Facts] ********************************************************* 2026-09-10 21:27:52.937499 | controller | Thursday 10 September 2026 21:27:52 +0000 (0:00:00.012) 0:00:00.012 **** 2026-09-10 21:27:54.081304 | 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-09-10 21:27:54.088239 | controller | ok: [controller] 2026-09-10 21:27:54.088461 | controller | 2026-09-10 21:27:54.088675 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:27:54.088861 | controller | Thursday 10 September 2026 21:27:54 +0000 (0:00:01.151) 0:00:01.163 **** 2026-09-10 21:27:54.187849 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-09-10 21:27:54.187989 | controller | 2026-09-10 21:27:54.188168 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-09-10 21:27:54.188343 | controller | Thursday 10 September 2026 21:27:54 +0000 (0:00:00.100) 0:00:01.263 **** 2026-09-10 21:27:54.947603 | controller | ok: [controller] 2026-09-10 21:27:54.947786 | controller | 2026-09-10 21:27:54.948027 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:27:54.948251 | controller | Thursday 10 September 2026 21:27:54 +0000 (0:00:00.759) 0:00:02.022 **** 2026-09-10 21:27:55.008404 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-09-10 21:27:55.008600 | controller | 2026-09-10 21:27:55.008832 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-09-10 21:27:55.009056 | controller | Thursday 10 September 2026 21:27:55 +0000 (0:00:00.060) 0:00:02.083 **** 2026-09-10 21:27:55.462759 | controller | ok: [controller] 2026-09-10 21:27:55.462910 | controller | 2026-09-10 21:27:55.463106 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-09-10 21:27:55.463288 | controller | Thursday 10 September 2026 21:27:55 +0000 (0:00:00.454) 0:00:02.537 **** 2026-09-10 21:27:56.697674 | controller | ok: [controller] 2026-09-10 21:27:56.697728 | controller | 2026-09-10 21:27:56.697902 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-09-10 21:27:56.698027 | controller | Thursday 10 September 2026 21:27:56 +0000 (0:00:01.234) 0:00:03.772 **** 2026-09-10 21:27:57.135977 | controller | ok: [controller] 2026-09-10 21:27:57.136018 | controller | 2026-09-10 21:27:57.136132 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-09-10 21:27:57.136236 | controller | Thursday 10 September 2026 21:27:57 +0000 (0:00:00.438) 0:00:04.211 **** 2026-09-10 21:27:57.196599 | controller | skipping: [controller] 2026-09-10 21:27:57.196731 | controller | 2026-09-10 21:27:57.196912 | controller | PLAY RECAP ********************************************************************* 2026-09-10 21:27:57.197135 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-10 21:27:57.197362 | controller | 2026-09-10 21:27:57.197532 | controller | 2026-09-10 21:27:57.197691 | controller | TASKS RECAP ******************************************************************** 2026-09-10 21:27:57.197869 | controller | Thursday 10 September 2026 21:27:57 +0000 (0:00:00.061) 0:00:04.272 **** 2026-09-10 21:27:57.198072 | controller | =============================================================================== 2026-09-10 21:27:57.198270 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.23s 2026-09-10 21:27:57.198491 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-09-10 21:27:57.198669 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.76s 2026-09-10 21:27:57.198837 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.45s 2026-09-10 21:27:57.199006 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s 2026-09-10 21:27:57.199212 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s 2026-09-10 21:27:57.199427 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s 2026-09-10 21:27:57.199608 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-09-10 21:27:57.304704 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-09-10 21:27:57.316307 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-09-10 21:27:58.100870 | controller | 2026-09-10 21:27:58.101050 | controller | PLAY [Side effect] ************************************************************* 2026-09-10 21:27:58.101351 | controller | 2026-09-10 21:27:58.101615 | controller | TASK [Gathering Facts] ********************************************************* 2026-09-10 21:27:58.101844 | controller | Thursday 10 September 2026 21:27:58 +0000 (0:00:00.010) 0:00:00.010 **** 2026-09-10 21:27:59.211385 | 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-09-10 21:27:59.220546 | controller | ok: [controller] 2026-09-10 21:27:59.220720 | controller | 2026-09-10 21:27:59.220926 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:27:59.221107 | controller | Thursday 10 September 2026 21:27:59 +0000 (0:00:01.119) 0:00:01.129 **** 2026-09-10 21:27:59.315450 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-09-10 21:27:59.315553 | controller | 2026-09-10 21:27:59.315814 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-09-10 21:27:59.316039 | controller | Thursday 10 September 2026 21:27:59 +0000 (0:00:00.095) 0:00:01.224 **** 2026-09-10 21:28:00.025161 | controller | changed: [controller] 2026-09-10 21:28:00.025352 | controller | 2026-09-10 21:28:00.025595 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-09-10 21:28:00.025806 | controller | Thursday 10 September 2026 21:28:00 +0000 (0:00:00.709) 0:00:01.933 **** 2026-09-10 21:28:00.089913 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-09-10 21:28:00.090040 | controller | 2026-09-10 21:28:00.090228 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-09-10 21:28:00.093362 | controller | Thursday 10 September 2026 21:28:00 +0000 (0:00:00.063) 0:00:01.996 **** 2026-09-10 21:28:00.546501 | controller | ok: [controller] 2026-09-10 21:28:00.546542 | controller | 2026-09-10 21:28:00.546551 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-09-10 21:28:00.546559 | controller | Thursday 10 September 2026 21:28:00 +0000 (0:00:00.457) 0:00:02.454 **** 2026-09-10 21:28:01.765911 | controller | ok: [controller] 2026-09-10 21:28:01.766054 | controller | 2026-09-10 21:28:01.766263 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-09-10 21:28:01.766463 | controller | Thursday 10 September 2026 21:28:01 +0000 (0:00:01.217) 0:00:03.672 **** 2026-09-10 21:28:02.195879 | controller | ok: [controller] 2026-09-10 21:28:02.195966 | controller | 2026-09-10 21:28:02.196170 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-09-10 21:28:02.196369 | controller | Thursday 10 September 2026 21:28:02 +0000 (0:00:00.432) 0:00:04.104 **** 2026-09-10 21:28:02.567586 | controller | changed: [controller] => (item=/file) 2026-09-10 21:28:02.567627 | controller | 2026-09-10 21:28:02.567634 | controller | PLAY RECAP ********************************************************************* 2026-09-10 21:28:02.567640 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-10 21:28:02.567644 | controller | 2026-09-10 21:28:02.567649 | controller | 2026-09-10 21:28:02.567653 | controller | TASKS RECAP ******************************************************************** 2026-09-10 21:28:02.567666 | controller | Thursday 10 September 2026 21:28:02 +0000 (0:00:00.368) 0:00:04.473 **** 2026-09-10 21:28:02.567671 | controller | =============================================================================== 2026-09-10 21:28:02.567675 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.22s 2026-09-10 21:28:02.567679 | controller | Gathering Facts --------------------------------------------------------- 1.12s 2026-09-10 21:28:02.567683 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s 2026-09-10 21:28:02.567687 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s 2026-09-10 21:28:02.567692 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-09-10 21:28:02.567697 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.37s 2026-09-10 21:28:02.567701 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s 2026-09-10 21:28:02.567705 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s 2026-09-10 21:28:02.670758 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-09-10 21:28:02.682521 | controller | INFO [upload-helm-chart > verify] Executing 2026-09-10 21:28:03.507185 | controller | 2026-09-10 21:28:03.507510 | controller | PLAY [Verify] ****************************************************************** 2026-09-10 21:28:03.507717 | controller | 2026-09-10 21:28:03.507937 | controller | TASK [Gathering Facts] ********************************************************* 2026-09-10 21:28:03.508160 | controller | Thursday 10 September 2026 21:28:03 +0000 (0:00:00.009) 0:00:00.009 **** 2026-09-10 21:28:05.614998 | 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-09-10 21:28:05.625896 | controller | ok: [controller] 2026-09-10 21:28:05.626035 | controller | 2026-09-10 21:28:05.626211 | controller | TASK [Stat file 1] ************************************************************* 2026-09-10 21:28:05.626409 | controller | Thursday 10 September 2026 21:28:05 +0000 (0:00:02.114) 0:00:02.124 **** 2026-09-10 21:28:06.056983 | controller | ok: [controller] 2026-09-10 21:28:06.057119 | controller | 2026-09-10 21:28:06.057601 | controller | TASK [Stat file 2] ************************************************************* 2026-09-10 21:28:06.057643 | controller | Thursday 10 September 2026 21:28:06 +0000 (0:00:00.434) 0:00:02.559 **** 2026-09-10 21:28:06.377172 | controller | ok: [controller] 2026-09-10 21:28:06.377726 | controller | 2026-09-10 21:28:06.377748 | controller | TASK [Stat removed file 1] ***************************************************** 2026-09-10 21:28:06.377758 | controller | Thursday 10 September 2026 21:28:06 +0000 (0:00:00.320) 0:00:02.879 **** 2026-09-10 21:28:06.685519 | controller | ok: [controller] 2026-09-10 21:28:06.685579 | controller | 2026-09-10 21:28:06.685695 | controller | TASK [Stat removed file 2] ***************************************************** 2026-09-10 21:28:06.685823 | controller | Thursday 10 September 2026 21:28:06 +0000 (0:00:00.308) 0:00:03.188 **** 2026-09-10 21:28:07.006231 | controller | ok: [controller] 2026-09-10 21:28:07.006273 | controller | 2026-09-10 21:28:07.006312 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-09-10 21:28:07.006324 | controller | Thursday 10 September 2026 21:28:07 +0000 (0:00:00.319) 0:00:03.507 **** 2026-09-10 21:28:07.057400 | controller | ok: [controller] => { 2026-09-10 21:28:07.057444 | controller | "changed": false, 2026-09-10 21:28:07.057450 | controller | "msg": "All assertions passed" 2026-09-10 21:28:07.057456 | controller | } 2026-09-10 21:28:07.059942 | controller | 2026-09-10 21:28:07.059993 | controller | PLAY RECAP ********************************************************************* 2026-09-10 21:28:07.060005 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-10 21:28:07.060013 | controller | 2026-09-10 21:28:07.060032 | controller | 2026-09-10 21:28:07.060040 | controller | TASKS RECAP ******************************************************************** 2026-09-10 21:28:07.060047 | controller | Thursday 10 September 2026 21:28:07 +0000 (0:00:00.052) 0:00:03.559 **** 2026-09-10 21:28:07.060054 | controller | =============================================================================== 2026-09-10 21:28:07.060061 | controller | Gathering Facts --------------------------------------------------------- 2.11s 2026-09-10 21:28:07.060068 | controller | Stat file 1 ------------------------------------------------------------- 0.43s 2026-09-10 21:28:07.060075 | controller | Stat file 2 ------------------------------------------------------------- 0.32s 2026-09-10 21:28:07.060082 | controller | Stat removed file 2 ----------------------------------------------------- 0.32s 2026-09-10 21:28:07.060089 | controller | Stat removed file 1 ----------------------------------------------------- 0.31s 2026-09-10 21:28:07.060096 | controller | ansible.builtin.assert -------------------------------------------------- 0.05s 2026-09-10 21:28:07.168494 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-09-10 21:28:07.180165 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-09-10 21:28:07.180833 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 21:28:07.191765 | controller | INFO [upload-helm-chart > destroy] Executing 2026-09-10 21:28:07.191952 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-09-10 21:28:07.192124 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-09-10 21:28:07.192631 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-09-10 21:28:07.595366 | controller | ok: Runtime: 0:10:29.678210 2026-09-10 21:28:07.600938 | 2026-09-10 21:28:07.601026 | PLAY RECAP 2026-09-10 21:28:07.601105 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 21:28:07.601147 | 2026-09-10 21:28:07.706254 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-10 21:28:07.709979 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-09-10 21:28:08.310413 | 2026-09-10 21:28:08.310566 | PLAY [all] 2026-09-10 21:28:08.321661 | 2026-09-10 21:28:08.321728 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-10 21:28:08.758284 | controller | changed 2026-09-10 21:28:08.766536 | 2026-09-10 21:28:08.766693 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-10 21:28:09.198531 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 21:28:09.198635 | controller | 2026-09-10 21:28:09.206529 | controller | environment: line 1: kubectl: command not found 2026-09-10 21:28:09.208666 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 21:28:09.210536 | controller | environment: line 1: kubectl: command not found 2026-09-10 21:28:09.212774 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 21:28:09.213741 | controller | environment: line 1: kubectl: command not found 2026-09-10 21:28:09.215775 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 21:28:09.219202 | controller | environment: line 1: kubectl: command not found 2026-09-10 21:28:09.221288 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 21:28:09.223338 | controller | environment: line 1: kubectl: command not found 2026-09-10 21:28:09.225562 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 21:28:09.332658 | controller | ok: Runtime: 0:00:00.044738 2026-09-10 21:28:09.340283 | 2026-09-10 21:28:09.340408 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-10 21:28:09.596250 | controller | changed 2026-09-10 21:28:09.603940 | 2026-09-10 21:28:09.604131 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-10 21:28:09.900891 | controller | environment: line 5: kubectl: command not found 2026-09-10 21:28:09.902494 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 21:28:09.902536 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 21:28:09.903002 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 21:28:10.145146 | controller | ok: Runtime: 0:00:00.013259 2026-09-10 21:28:10.154909 | 2026-09-10 21:28:10.155077 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-10 21:28:10.863160 | controller | changed: 2026-09-10 21:28:10.863412 | controller | created directory /var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/logs/controller 2026-09-10 21:28:10.863472 | controller | cd+++++++++ objects/ 2026-09-10 21:28:10.863515 | controller | cd+++++++++ objects/cluster/ 2026-09-10 21:28:10.863561 | controller | cd+++++++++ objects/namespaced/ 2026-09-10 21:28:10.877846 | 2026-09-10 21:28:10.877975 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-10 21:28:11.155650 | controller | changed 2026-09-10 21:28:11.165401 | 2026-09-10 21:28:11.165531 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-10 21:28:11.455038 | controller | changed 2026-09-10 21:28:11.463684 | 2026-09-10 21:28:11.463923 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-10 21:28:11.767289 | controller | environment: line 3: kubectl: command not found 2026-09-10 21:28:12.003185 | controller | ok: Runtime: 0:00:00.014413 2026-09-10 21:28:12.011779 | 2026-09-10 21:28:12.011899 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-10 21:28:12.539535 | controller | changed: 2026-09-10 21:28:12.539707 | controller | cd+++++++++ pod-logs/ 2026-09-10 21:28:12.539745 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-09-10 21:28:12.548416 | 2026-09-10 21:28:12.548517 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-10 21:28:12.803816 | controller | changed: "values" 2026-09-10 21:28:13.048023 | controller | changed: "releases" 2026-09-10 21:28:13.055261 | 2026-09-10 21:28:13.055408 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-10 21:28:13.354838 | controller | /bin/bash: line 3: kubectl: command not found 2026-09-10 21:28:13.585284 | controller | ok: Runtime: 0:00:00.010479 2026-09-10 21:28:13.592674 | 2026-09-10 21:28:13.592804 | TASK [helm-release-status : Downloads logs to executor] 2026-09-10 21:28:14.151027 | controller | changed: 2026-09-10 21:28:14.151340 | controller | cd+++++++++ helm/ 2026-09-10 21:28:14.151421 | controller | cd+++++++++ helm/releases/ 2026-09-10 21:28:14.151489 | controller | cd+++++++++ helm/values/ 2026-09-10 21:28:14.160989 | 2026-09-10 21:28:14.161088 | PLAY RECAP 2026-09-10 21:28:14.161182 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 21:28:14.161259 | 2026-09-10 21:28:14.358847 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-09-10 21:28:14.361452 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 21:28:15.020857 | 2026-09-10 21:28:15.020994 | PLAY [all] 2026-09-10 21:28:15.032553 | 2026-09-10 21:28:15.032668 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-10 21:28:15.097399 | controller | skipping: Conditional result was False 2026-09-10 21:28:15.104332 | 2026-09-10 21:28:15.104485 | TASK [fetch-output : Set log path for single node] 2026-09-10 21:28:15.149116 | controller | ok 2026-09-10 21:28:15.154571 | 2026-09-10 21:28:15.154667 | LOOP [fetch-output : Ensure local output dirs] 2026-09-10 21:28:15.580561 | controller -> localhost | ok: "/var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/logs" 2026-09-10 21:28:15.805867 | controller -> localhost | changed: "/var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/artifacts" 2026-09-10 21:28:16.038775 | controller -> localhost | changed: "/var/lib/zuul/builds/e53123f24fd54425a8f9cbe20cbc3333/work/docs" 2026-09-10 21:28:16.050297 | 2026-09-10 21:28:16.050409 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-10 21:28:16.729842 | controller | changed: .d..t...... ./ 2026-09-10 21:28:16.730202 | controller | changed: All items complete 2026-09-10 21:28:16.730277 | 2026-09-10 21:28:17.205013 | controller | changed: .d..t...... ./ 2026-09-10 21:28:17.708592 | controller | changed: .d..t...... ./ 2026-09-10 21:28:17.732113 | 2026-09-10 21:28:17.732341 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-10 21:28:18.193943 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008906 2026-09-10 21:28:18.438442 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008548 2026-09-10 21:28:18.451894 | 2026-09-10 21:28:18.452066 | PLAY [all] 2026-09-10 21:28:18.461337 | 2026-09-10 21:28:18.461454 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-10 21:28:18.953646 | controller | changed 2026-09-10 21:28:18.962106 | 2026-09-10 21:28:18.962246 | PLAY RECAP 2026-09-10 21:28:18.962334 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-10 21:28:18.962377 | 2026-09-10 21:28:19.123250 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 21:28:19.125848 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-10 21:28:19.683844 | 2026-09-10 21:28:19.683964 | PLAY [localhost] 2026-09-10 21:28:19.693496 | 2026-09-10 21:28:19.693574 | TASK [Generate Zuul manifest] 2026-09-10 21:28:19.710747 | localhost | ok 2026-09-10 21:28:19.725392 | 2026-09-10 21:28:19.725472 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-10 21:28:20.151249 | localhost | changed 2026-09-10 21:28:20.172742 | 2026-09-10 21:28:20.172886 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-10 21:28:20.215801 | localhost | ok 2026-09-10 21:28:20.229483 | 2026-09-10 21:28:20.229611 | TASK [Upload logs] 2026-09-10 21:28:20.251618 | localhost | ok 2026-09-10 21:28:20.325203 | 2026-09-10 21:28:20.325333 | TASK [Set zuul-log-path fact] 2026-09-10 21:28:20.342392 | localhost | ok 2026-09-10 21:28:20.353582 | 2026-09-10 21:28:20.353646 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 21:28:20.382178 | localhost | ok 2026-09-10 21:28:20.391550 | 2026-09-10 21:28:20.391633 | TASK [upload-logs : Create log directories] 2026-09-10 21:28:20.779477 | localhost | changed 2026-09-10 21:28:20.788389 | 2026-09-10 21:28:20.788581 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-10 21:28:21.225555 | localhost -> localhost | ok: Runtime: 0:00:00.004976 2026-09-10 21:28:21.234820 | 2026-09-10 21:28:21.234941 | TASK [upload-logs : Upload logs to log server] 2026-09-10 21:28:21.733291 | localhost | Output suppressed because no_log was given 2026-09-10 21:28:21.740752 | 2026-09-10 21:28:21.740884 | LOOP [upload-logs : Compress console log and json output] 2026-09-10 21:28:21.803224 | localhost | skipping: Conditional result was False 2026-09-10 21:28:21.856183 | localhost | skipping: Conditional result was False 2026-09-10 21:28:21.872671 | 2026-09-10 21:28:21.872976 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-10 21:28:21.935502 | localhost | skipping: Conditional result was False 2026-09-10 21:28:21.935915 | 2026-09-10 21:28:21.940969 | localhost | skipping: Conditional result was False 2026-09-10 21:28:21.959564 | 2026-09-10 21:28:21.959879 | LOOP [upload-logs : Upload console log and json output]