2026-08-22 08:29:30.030068 | Job console starting 2026-08-22 08:29:30.042635 | Updating git repos 2026-08-22 08:29:30.098048 | Cloning repos into workspace 2026-08-22 08:29:30.140922 | Restoring repo states 2026-08-22 08:29:30.153648 | Merging changes 2026-08-22 08:29:30.997968 | Checking out repos 2026-08-22 08:29:31.225657 | Preparing playbooks 2026-08-22 08:29:34.389942 | Running Ansible setup 2026-08-22 08:29:39.129604 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 08:29:39.818141 | 2026-08-22 08:29:39.818283 | PLAY [localhost] 2026-08-22 08:29:39.825842 | 2026-08-22 08:29:39.825914 | TASK [Gathering Facts] 2026-08-22 08:29:40.709202 | localhost | ok 2026-08-22 08:29:40.721084 | 2026-08-22 08:29:40.721280 | TASK [Setup log path fact] 2026-08-22 08:29:40.740160 | localhost | ok 2026-08-22 08:29:40.753688 | 2026-08-22 08:29:40.753788 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 08:29:40.783862 | localhost | ok 2026-08-22 08:29:40.795274 | 2026-08-22 08:29:40.795363 | TASK [emit-job-header : Print job information] 2026-08-22 08:29:40.835466 | # Job Information 2026-08-22 08:29:40.835638 | Ansible Version: 2.16.18 2026-08-22 08:29:40.835683 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-08-22 08:29:40.835714 | Pipeline: check 2026-08-22 08:29:40.835741 | Executor: 2d72f0692154 2026-08-22 08:29:40.835769 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/298 2026-08-22 08:29:40.835800 | Event ID: dd215b30-9e02-11f1-963c-d62e1728b247 2026-08-22 08:29:40.839630 | 2026-08-22 08:29:40.839721 | LOOP [emit-job-header : Print node information] 2026-08-22 08:29:40.928660 | localhost | ok: 2026-08-22 08:29:40.928837 | localhost | # Node Information 2026-08-22 08:29:40.928866 | localhost | Inventory Hostname: controller 2026-08-22 08:29:40.928888 | localhost | Hostname: np0000190439 2026-08-22 08:29:40.928908 | localhost | Username: zuul 2026-08-22 08:29:40.928931 | localhost | Distro: Debian 13.6 2026-08-22 08:29:40.928972 | localhost | Provider: yul1 2026-08-22 08:29:40.928996 | localhost | Region: ca-ymq-1 2026-08-22 08:29:40.929015 | localhost | Label: debian-trixie 2026-08-22 08:29:40.929033 | localhost | Product Name: OpenStack Nova 2026-08-22 08:29:40.929052 | localhost | Interface IP: 199.19.213.169 2026-08-22 08:29:40.949633 | 2026-08-22 08:29:40.950180 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-22 08:29:41.423022 | localhost -> localhost | changed 2026-08-22 08:29:41.428731 | 2026-08-22 08:29:41.428805 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-22 08:29:42.439565 | localhost -> localhost | changed 2026-08-22 08:29:42.448158 | 2026-08-22 08:29:42.448235 | PLAY [all] 2026-08-22 08:29:42.454754 | 2026-08-22 08:29:42.454826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-22 08:29:42.696777 | controller -> localhost | ok 2026-08-22 08:29:42.703383 | 2026-08-22 08:29:42.703499 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-22 08:29:42.734570 | controller | ok 2026-08-22 08:29:42.750146 | controller | included: /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-22 08:29:42.755161 | 2026-08-22 08:29:42.755234 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-22 08:29:43.925189 | controller -> localhost | Generating public/private rsa key pair. 2026-08-22 08:29:43.925444 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/0044933ea7c04d778eb781b6308b4423_id_rsa 2026-08-22 08:29:43.925492 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/0044933ea7c04d778eb781b6308b4423_id_rsa.pub 2026-08-22 08:29:43.925527 | controller -> localhost | The key fingerprint is: 2026-08-22 08:29:43.925559 | controller -> localhost | SHA256:r9dscc4NHc2WynfeogQmy704yKwWJd2GIbrnfm0HB6U zuul-build-sshkey 2026-08-22 08:29:43.925606 | controller -> localhost | The key's randomart image is: 2026-08-22 08:29:43.925637 | controller -> localhost | +---[RSA 3072]----+ 2026-08-22 08:29:43.925670 | controller -> localhost | | | 2026-08-22 08:29:43.925701 | controller -> localhost | | . . . | 2026-08-22 08:29:43.925729 | controller -> localhost | | . o + o .o| 2026-08-22 08:29:43.925759 | controller -> localhost | | . . + E o+| 2026-08-22 08:29:43.925790 | controller -> localhost | | . o .S.o . .o.| 2026-08-22 08:29:43.925819 | controller -> localhost | | . o ..*...oo.o| 2026-08-22 08:29:43.925847 | controller -> localhost | | o + ooooo.=.+o| 2026-08-22 08:29:43.925875 | controller -> localhost | | o = +ooo+ + +| 2026-08-22 08:29:43.925906 | controller -> localhost | | ooo .o+.... . | 2026-08-22 08:29:43.925937 | controller -> localhost | +----[SHA256]-----+ 2026-08-22 08:29:43.926011 | controller -> localhost | ok: Runtime: 0:00:00.485773 2026-08-22 08:29:43.932205 | 2026-08-22 08:29:43.932314 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-22 08:29:43.964914 | controller | ok 2026-08-22 08:29:43.976210 | controller | included: /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-22 08:29:43.982689 | 2026-08-22 08:29:43.982772 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-22 08:29:44.007548 | controller | skipping: Conditional result was False 2026-08-22 08:29:44.016557 | 2026-08-22 08:29:44.016655 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-22 08:29:44.572166 | controller | changed 2026-08-22 08:29:44.575970 | 2026-08-22 08:29:44.576031 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-22 08:29:44.807636 | controller | ok 2026-08-22 08:29:44.818698 | 2026-08-22 08:29:44.818902 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-22 08:29:45.427688 | controller | changed 2026-08-22 08:29:45.433960 | 2026-08-22 08:29:45.434088 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-22 08:29:45.952728 | controller | changed 2026-08-22 08:29:45.963912 | 2026-08-22 08:29:45.964032 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-22 08:29:45.988589 | controller | skipping: Conditional result was False 2026-08-22 08:29:45.995732 | 2026-08-22 08:29:45.995833 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-22 08:29:46.413043 | controller -> localhost | changed 2026-08-22 08:29:46.427034 | 2026-08-22 08:29:46.427106 | TASK [add-build-sshkey : Add back temp key] 2026-08-22 08:29:46.720731 | controller -> localhost | Identity added: /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/0044933ea7c04d778eb781b6308b4423_id_rsa (zuul-build-sshkey) 2026-08-22 08:29:46.721030 | controller -> localhost | ok: Runtime: 0:00:00.013003 2026-08-22 08:29:46.727264 | 2026-08-22 08:29:46.727349 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-22 08:29:47.102910 | controller | ok 2026-08-22 08:29:47.108397 | 2026-08-22 08:29:47.108542 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-22 08:29:47.147542 | controller | skipping: Conditional result was False 2026-08-22 08:29:47.155675 | 2026-08-22 08:29:47.155797 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-22 08:29:47.533581 | controller | ok 2026-08-22 08:29:47.538154 | 2026-08-22 08:29:47.538216 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-22 08:29:48.549563 | controller | Output suppressed because no_log was given 2026-08-22 08:29:49.046861 | 2026-08-22 08:29:49.047045 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-22 08:29:49.264145 | controller | ok: "logs" 2026-08-22 08:29:49.264473 | controller | ok: All items complete 2026-08-22 08:29:49.264528 | 2026-08-22 08:29:49.454870 | controller | ok: "artifacts" 2026-08-22 08:29:49.650294 | controller | ok: "docs" 2026-08-22 08:29:49.668752 | 2026-08-22 08:29:49.668928 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-22 08:29:49.889718 | controller | changed: "logs" 2026-08-22 08:29:50.078932 | controller | changed: "artifacts" 2026-08-22 08:29:50.272228 | controller | changed: "docs" 2026-08-22 08:29:50.287210 | 2026-08-22 08:29:50.287341 | PLAY RECAP 2026-08-22 08:29:50.287406 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-22 08:29:50.287445 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:29:50.287475 | 2026-08-22 08:29:50.409708 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 08:29:50.412619 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 08:29:51.089047 | 2026-08-22 08:29:51.089207 | PLAY [all] 2026-08-22 08:29:51.099912 | 2026-08-22 08:29:51.100014 | TASK [setup-uv : Extract archive] 2026-08-22 08:29:53.482447 | controller | changed 2026-08-22 08:29:53.488660 | 2026-08-22 08:29:53.488836 | TASK [setup-uv : Print version] 2026-08-22 08:29:53.923018 | controller | uv 0.8.13 2026-08-22 08:29:54.024931 | controller | ok: Runtime: 0:00:00.015450 2026-08-22 08:29:54.032838 | 2026-08-22 08:29:54.032908 | TASK [Install Ansible collection siblings] 2026-08-22 08:29:54.485993 | controller | ok: 2026-08-22 08:29:54.537161 | controller | Skipping ansible.posix: no checked-out sibling 2026-08-22 08:29:54.537385 | controller | Skipping community.crypto: no checked-out sibling 2026-08-22 08:29:54.537445 | controller | Skipping community.general: no checked-out sibling 2026-08-22 08:29:54.537492 | controller | Skipping kubernetes.core: no checked-out sibling 2026-08-22 08:29:54.537537 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-08-22 08:29:54.540537 | 2026-08-22 08:29:54.540601 | PLAY RECAP 2026-08-22 08:29:54.540665 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:29:54.540697 | 2026-08-22 08:29:54.719061 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 08:29:54.731057 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-08-22 08:29:55.401135 | 2026-08-22 08:29:55.401264 | PLAY [all] 2026-08-22 08:29:55.411649 | 2026-08-22 08:29:55.411733 | TASK [Update apt cache] 2026-08-22 08:30:00.208676 | controller | ok 2026-08-22 08:30:00.213751 | 2026-08-22 08:30:00.213959 | TASK [Disable firewalld] 2026-08-22 08:30:00.240087 | controller | skipping: Conditional result was False 2026-08-22 08:30:00.248578 | 2026-08-22 08:30:00.248849 | TASK [Install "jq" for log collection] 2026-08-22 08:30:02.413636 | controller | changed 2026-08-22 08:30:02.416043 | 2026-08-22 08:30:02.416111 | PLAY RECAP 2026-08-22 08:30:02.416177 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 08:30:02.416221 | 2026-08-22 08:30:02.561355 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-08-22 08:30:02.563961 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 08:30:03.252620 | 2026-08-22 08:30:03.252800 | PLAY [all] 2026-08-22 08:30:03.263808 | 2026-08-22 08:30:03.263891 | LOOP [Check inventory directories] 2026-08-22 08:30:03.663001 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-08-22 08:30:03.831473 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory" 2026-08-22 08:30:04.006110 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory" 2026-08-22 08:30:04.020496 | 2026-08-22 08:30:04.020726 | LOOP [Copy inventory file for Zuul] 2026-08-22 08:30:04.914040 | controller | changed: 2026-08-22 08:30:04.914300 | controller | { 2026-08-22 08:30:04.914342 | controller | "ansible_loop_var": "item", 2026-08-22 08:30:04.914376 | controller | "changed": false, 2026-08-22 08:30:04.914404 | controller | "failed": false, 2026-08-22 08:30:04.914437 | controller | "invocation": { 2026-08-22 08:30:04.914465 | controller | "module_args": { 2026-08-22 08:30:04.914491 | controller | "checksum_algorithm": "sha1", 2026-08-22 08:30:04.914517 | controller | "follow": true, 2026-08-22 08:30:04.914543 | controller | "get_attributes": true, 2026-08-22 08:30:04.914570 | controller | "get_checksum": true, 2026-08-22 08:30:04.914596 | controller | "get_mime": true, 2026-08-22 08:30:04.914621 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes" 2026-08-22 08:30:04.914646 | controller | } 2026-08-22 08:30:04.914672 | controller | }, 2026-08-22 08:30:04.914698 | controller | "item": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-08-22 08:30:04.914723 | controller | "stat": { 2026-08-22 08:30:04.914748 | controller | "atime": 1787387388.3975258, 2026-08-22 08:30:04.914773 | controller | "attr_flags": "e", 2026-08-22 08:30:04.914798 | controller | "attributes": [ 2026-08-22 08:30:04.914822 | controller | "extents" 2026-08-22 08:30:04.914848 | controller | ], 2026-08-22 08:30:04.914873 | controller | "block_size": 4096, 2026-08-22 08:30:04.914898 | controller | "blocks": 8, 2026-08-22 08:30:04.914922 | controller | "charset": "unknown", 2026-08-22 08:30:04.914949 | controller | "ctime": 1787387388.4215264, 2026-08-22 08:30:04.914975 | controller | "dev": 65025, 2026-08-22 08:30:04.915000 | controller | "device_type": 0, 2026-08-22 08:30:04.915025 | controller | "executable": true, 2026-08-22 08:30:04.915049 | controller | "exists": true, 2026-08-22 08:30:04.915073 | controller | "gid": 1000, 2026-08-22 08:30:04.915097 | controller | "gr_name": "zuul", 2026-08-22 08:30:04.915122 | controller | "inode": 520215, 2026-08-22 08:30:04.915146 | controller | "isblk": false, 2026-08-22 08:30:04.915173 | controller | "ischr": false, 2026-08-22 08:30:04.915198 | controller | "isdir": true, 2026-08-22 08:30:04.915223 | controller | "isfifo": false, 2026-08-22 08:30:04.915247 | controller | "isgid": false, 2026-08-22 08:30:04.915274 | controller | "islnk": false, 2026-08-22 08:30:04.915311 | controller | "isreg": false, 2026-08-22 08:30:04.915352 | controller | "issock": false, 2026-08-22 08:30:04.915395 | controller | "isuid": false, 2026-08-22 08:30:04.915430 | controller | "mimetype": "unknown", 2026-08-22 08:30:04.915457 | controller | "mode": "0755", 2026-08-22 08:30:04.915481 | controller | "mtime": 1787387370.8332808, 2026-08-22 08:30:04.915506 | controller | "nlink": 15, 2026-08-22 08:30:04.915530 | controller | "path": "src/github.com/vexxhost/ansible-collection-kubernetes", 2026-08-22 08:30:04.915555 | controller | "pw_name": "zuul", 2026-08-22 08:30:04.915585 | controller | "readable": true, 2026-08-22 08:30:04.915611 | controller | "rgrp": true, 2026-08-22 08:30:04.915637 | controller | "roth": true, 2026-08-22 08:30:04.915662 | controller | "rusr": true, 2026-08-22 08:30:04.915688 | controller | "size": 4096, 2026-08-22 08:30:04.915713 | controller | "uid": 1000, 2026-08-22 08:30:04.915738 | controller | "version": "2111848271", 2026-08-22 08:30:04.915762 | controller | "wgrp": false, 2026-08-22 08:30:04.915789 | controller | "woth": false, 2026-08-22 08:30:04.915815 | controller | "writeable": true, 2026-08-22 08:30:04.915841 | controller | "wusr": true, 2026-08-22 08:30:04.915866 | controller | "xgrp": true, 2026-08-22 08:30:04.915890 | controller | "xoth": true, 2026-08-22 08:30:04.915915 | controller | "xusr": true 2026-08-22 08:30:04.915958 | controller | } 2026-08-22 08:30:04.915986 | controller | } 2026-08-22 08:30:04.916036 | controller | ok: All items complete 2026-08-22 08:30:04.916069 | 2026-08-22 08:30:04.930297 | controller | skipping: Conditional result was False 2026-08-22 08:30:04.936173 | controller | skipping: Conditional result was False 2026-08-22 08:30:04.949098 | 2026-08-22 08:30:04.949276 | LOOP [Switch "ansible_host" to private IP] 2026-08-22 08:30:05.316984 | controller | changed: 1 replacements made 2026-08-22 08:30:05.318731 | controller | skipping: Conditional result was False 2026-08-22 08:30:05.319621 | controller | skipping: Conditional result was False 2026-08-22 08:30:05.331694 | 2026-08-22 08:30:05.331863 | TASK [Run Molecule scenario] 2026-08-22 08:30:05.813518 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-08-22 08:30:05.813627 | controller | Creating virtual environment at: .venv 2026-08-22 08:30:06.088396 | controller | Downloading ansible-core (2.3MiB) 2026-08-22 08:30:06.088777 | controller | Downloading cryptography (4.3MiB) 2026-08-22 08:30:06.088979 | controller | Downloading pygments (1.2MiB) 2026-08-22 08:30:06.242840 | controller | Downloading cryptography 2026-08-22 08:30:06.290060 | controller | Downloading pygments 2026-08-22 08:30:06.433696 | controller | Downloading ansible-core 2026-08-22 08:30:06.484706 | controller | Installed 36 packages in 50ms 2026-08-22 08:30:07.209868 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-08-22 08:30:07.209910 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-08-22 08:30:08.097231 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-08-22 08:30:08.097269 | controller | INFO default scenario not found, disabling shared state. 2026-08-22 08:30:08.097303 | 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:30:08.097405 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-08-22 08:30:34.582988 | controller | INFO [upload-helm-chart > dependency] Executing 2026-08-22 08:30:34.583200 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-08-22 08:30:34.583569 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-08-22 08:30:34.583753 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-22 08:30:34.589505 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-08-22 08:30:34.589789 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:30:34.596296 | controller | INFO [upload-helm-chart > destroy] Executing 2026-08-22 08:30:34.596407 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-08-22 08:30:34.596546 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-08-22 08:30:34.601878 | controller | INFO [upload-helm-chart > syntax] Executing 2026-08-22 08:30:35.478310 | controller | 2026-08-22 08:30:35.478537 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-08-22 08:30:35.541322 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-08-22 08:30:35.551766 | controller | INFO [upload-helm-chart > create] Executing 2026-08-22 08:30:35.553327 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:30:35.558652 | controller | INFO [upload-helm-chart > prepare] Executing 2026-08-22 08:30:35.558939 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:30:35.566074 | controller | INFO [upload-helm-chart > converge] Executing 2026-08-22 08:30:36.425137 | controller | 2026-08-22 08:30:36.425314 | controller | PLAY [Converge] **************************************************************** 2026-08-22 08:30:36.425527 | controller | 2026-08-22 08:30:36.425750 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:30:36.426032 | controller | Saturday 22 August 2026 08:30:36 +0000 (0:00:00.031) 0:00:00.031 ******* 2026-08-22 08:30:37.656124 | 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:30:37.659279 | controller | ok: [controller] 2026-08-22 08:30:37.659529 | controller | 2026-08-22 08:30:37.659821 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:37.660205 | controller | Saturday 22 August 2026 08:30:37 +0000 (0:00:01.234) 0:00:01.265 ******* 2026-08-22 08:30:37.749651 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:30:37.749807 | controller | 2026-08-22 08:30:37.750011 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:30:37.750207 | controller | Saturday 22 August 2026 08:30:37 +0000 (0:00:00.090) 0:00:01.356 ******* 2026-08-22 08:30:38.361143 | controller | changed: [controller] 2026-08-22 08:30:38.361338 | controller | 2026-08-22 08:30:38.361567 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:38.361798 | controller | Saturday 22 August 2026 08:30:38 +0000 (0:00:00.610) 0:00:01.966 ******* 2026-08-22 08:30:38.403185 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:30:38.403367 | controller | 2026-08-22 08:30:38.403685 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:30:38.403988 | controller | Saturday 22 August 2026 08:30:38 +0000 (0:00:00.043) 0:00:02.009 ******* 2026-08-22 08:30:38.825370 | controller | changed: [controller] 2026-08-22 08:30:38.825409 | controller | 2026-08-22 08:30:38.825421 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:30:38.825430 | controller | Saturday 22 August 2026 08:30:38 +0000 (0:00:00.421) 0:00:02.430 ******* 2026-08-22 08:30:39.954155 | controller | changed: [controller] 2026-08-22 08:30:39.954182 | controller | 2026-08-22 08:30:39.954190 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:30:39.954196 | controller | Saturday 22 August 2026 08:30:39 +0000 (0:00:01.128) 0:00:03.559 ******* 2026-08-22 08:30:40.363502 | controller | ok: [controller] 2026-08-22 08:30:40.366870 | controller | 2026-08-22 08:30:40.366881 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:30:40.366885 | controller | Saturday 22 August 2026 08:30:40 +0000 (0:00:00.409) 0:00:03.969 ******* 2026-08-22 08:30:40.417942 | controller | skipping: [controller] 2026-08-22 08:30:40.417953 | controller | 2026-08-22 08:30:40.417957 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:30:40.417962 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 08:30:40.417966 | controller | 2026-08-22 08:30:40.417969 | controller | 2026-08-22 08:30:40.417972 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:30:40.417975 | controller | Saturday 22 August 2026 08:30:40 +0000 (0:00:00.054) 0:00:04.023 ******* 2026-08-22 08:30:40.417979 | controller | =============================================================================== 2026-08-22 08:30:40.417982 | controller | Gathering Facts --------------------------------------------------------- 1.23s 2026-08-22 08:30:40.417985 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.13s 2026-08-22 08:30:40.417988 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.61s 2026-08-22 08:30:40.417998 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s 2026-08-22 08:30:40.418002 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s 2026-08-22 08:30:40.418005 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s 2026-08-22 08:30:40.418008 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-08-22 08:30:40.418011 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-08-22 08:30:40.503699 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-08-22 08:30:40.509814 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-08-22 08:30:41.331189 | controller | 2026-08-22 08:30:41.331510 | controller | PLAY [Converge] **************************************************************** 2026-08-22 08:30:41.331767 | controller | 2026-08-22 08:30:41.332086 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:30:41.332387 | controller | Saturday 22 August 2026 08:30:41 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-08-22 08:30:42.427231 | 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:30:42.432944 | controller | ok: [controller] 2026-08-22 08:30:42.433116 | controller | 2026-08-22 08:30:42.433291 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:42.433457 | controller | Saturday 22 August 2026 08:30:42 +0000 (0:00:01.101) 0:00:01.112 ******* 2026-08-22 08:30:42.510253 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:30:42.510526 | controller | 2026-08-22 08:30:42.510790 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:30:42.511044 | controller | Saturday 22 August 2026 08:30:42 +0000 (0:00:00.077) 0:00:01.189 ******* 2026-08-22 08:30:43.170328 | controller | ok: [controller] 2026-08-22 08:30:43.170618 | controller | 2026-08-22 08:30:43.170902 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:43.171169 | controller | Saturday 22 August 2026 08:30:43 +0000 (0:00:00.659) 0:00:01.849 ******* 2026-08-22 08:30:43.215373 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:30:43.215630 | controller | 2026-08-22 08:30:43.215900 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:30:43.216200 | controller | Saturday 22 August 2026 08:30:43 +0000 (0:00:00.045) 0:00:01.895 ******* 2026-08-22 08:30:43.648610 | controller | ok: [controller] 2026-08-22 08:30:43.648903 | controller | 2026-08-22 08:30:43.649219 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:30:43.649515 | controller | Saturday 22 August 2026 08:30:43 +0000 (0:00:00.432) 0:00:02.327 ******* 2026-08-22 08:30:44.754316 | controller | ok: [controller] 2026-08-22 08:30:44.754630 | controller | 2026-08-22 08:30:44.754929 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:30:44.755214 | controller | Saturday 22 August 2026 08:30:44 +0000 (0:00:01.104) 0:00:03.432 ******* 2026-08-22 08:30:45.174837 | controller | ok: [controller] 2026-08-22 08:30:45.175127 | controller | 2026-08-22 08:30:45.175505 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:30:45.175842 | controller | Saturday 22 August 2026 08:30:45 +0000 (0:00:00.421) 0:00:03.854 ******* 2026-08-22 08:30:45.215988 | controller | skipping: [controller] 2026-08-22 08:30:45.216316 | controller | 2026-08-22 08:30:45.216577 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:30:45.216852 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 08:30:45.217087 | controller | 2026-08-22 08:30:45.217314 | controller | 2026-08-22 08:30:45.217560 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:30:45.217825 | controller | Saturday 22 August 2026 08:30:45 +0000 (0:00:00.042) 0:00:03.896 ******* 2026-08-22 08:30:45.218065 | controller | =============================================================================== 2026-08-22 08:30:45.218397 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s 2026-08-22 08:30:45.218649 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-08-22 08:30:45.218982 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.66s 2026-08-22 08:30:45.219274 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s 2026-08-22 08:30:45.219531 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s 2026-08-22 08:30:45.219815 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-08-22 08:30:45.220199 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-08-22 08:30:45.220482 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-08-22 08:30:45.332123 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-08-22 08:30:45.339464 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-08-22 08:30:46.216393 | controller | 2026-08-22 08:30:46.216873 | controller | PLAY [Side effect] ************************************************************* 2026-08-22 08:30:46.217275 | controller | 2026-08-22 08:30:46.217670 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:30:46.217981 | controller | Saturday 22 August 2026 08:30:46 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-08-22 08:30:47.283093 | 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:30:47.288244 | controller | ok: [controller] 2026-08-22 08:30:47.288396 | controller | 2026-08-22 08:30:47.288541 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:47.288680 | controller | Saturday 22 August 2026 08:30:47 +0000 (0:00:01.072) 0:00:01.083 ******* 2026-08-22 08:30:47.362060 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-08-22 08:30:47.362333 | controller | 2026-08-22 08:30:47.362621 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-08-22 08:30:47.362876 | controller | Saturday 22 August 2026 08:30:47 +0000 (0:00:00.073) 0:00:01.157 ******* 2026-08-22 08:30:47.993363 | controller | changed: [controller] 2026-08-22 08:30:47.993665 | controller | 2026-08-22 08:30:47.994003 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-08-22 08:30:47.994332 | controller | Saturday 22 August 2026 08:30:47 +0000 (0:00:00.628) 0:00:01.785 ******* 2026-08-22 08:30:48.037332 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-08-22 08:30:48.037632 | controller | 2026-08-22 08:30:48.037915 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-08-22 08:30:48.038233 | controller | Saturday 22 August 2026 08:30:48 +0000 (0:00:00.046) 0:00:01.832 ******* 2026-08-22 08:30:48.461180 | controller | ok: [controller] 2026-08-22 08:30:48.461473 | controller | 2026-08-22 08:30:48.461766 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-08-22 08:30:48.462076 | controller | Saturday 22 August 2026 08:30:48 +0000 (0:00:00.423) 0:00:02.255 ******* 2026-08-22 08:30:49.573975 | controller | ok: [controller] 2026-08-22 08:30:49.574204 | controller | 2026-08-22 08:30:49.574411 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-08-22 08:30:49.574595 | controller | Saturday 22 August 2026 08:30:49 +0000 (0:00:01.112) 0:00:03.368 ******* 2026-08-22 08:30:50.013057 | controller | ok: [controller] 2026-08-22 08:30:50.013096 | controller | 2026-08-22 08:30:50.013101 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-08-22 08:30:50.013106 | controller | Saturday 22 August 2026 08:30:50 +0000 (0:00:00.436) 0:00:03.804 ******* 2026-08-22 08:30:50.331792 | controller | changed: [controller] => (item=/file) 2026-08-22 08:30:50.331831 | controller | 2026-08-22 08:30:50.331842 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:30:50.331851 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-08-22 08:30:50.331858 | controller | 2026-08-22 08:30:50.331866 | controller | 2026-08-22 08:30:50.331873 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:30:50.331892 | controller | Saturday 22 August 2026 08:30:50 +0000 (0:00:00.317) 0:00:04.122 ******* 2026-08-22 08:30:50.331900 | controller | =============================================================================== 2026-08-22 08:30:50.331907 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s 2026-08-22 08:30:50.331914 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-08-22 08:30:50.331921 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.63s 2026-08-22 08:30:50.331928 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s 2026-08-22 08:30:50.331935 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s 2026-08-22 08:30:50.331944 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s 2026-08-22 08:30:50.331951 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-08-22 08:30:50.331958 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-08-22 08:30:50.474914 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-08-22 08:30:50.483983 | controller | INFO [upload-helm-chart > verify] Executing 2026-08-22 08:30:51.319948 | controller | 2026-08-22 08:30:51.320321 | controller | PLAY [Verify] ****************************************************************** 2026-08-22 08:30:51.320633 | controller | 2026-08-22 08:30:51.320912 | controller | TASK [Gathering Facts] ********************************************************* 2026-08-22 08:30:51.321187 | controller | Saturday 22 August 2026 08:30:51 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-08-22 08:30:52.354175 | 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:30:52.357982 | controller | ok: [controller] 2026-08-22 08:30:52.358227 | controller | 2026-08-22 08:30:52.358481 | controller | TASK [Stat file 1] ************************************************************* 2026-08-22 08:30:52.358736 | controller | Saturday 22 August 2026 08:30:52 +0000 (0:00:01.038) 0:00:01.047 ******* 2026-08-22 08:30:52.788983 | controller | ok: [controller] 2026-08-22 08:30:52.789280 | controller | 2026-08-22 08:30:52.789564 | controller | TASK [Stat file 2] ************************************************************* 2026-08-22 08:30:52.789838 | controller | Saturday 22 August 2026 08:30:52 +0000 (0:00:00.429) 0:00:01.477 ******* 2026-08-22 08:30:53.085115 | controller | ok: [controller] 2026-08-22 08:30:53.085410 | controller | 2026-08-22 08:30:53.085687 | controller | TASK [Stat removed file 1] ***************************************************** 2026-08-22 08:30:53.085961 | controller | Saturday 22 August 2026 08:30:53 +0000 (0:00:00.295) 0:00:01.773 ******* 2026-08-22 08:30:53.372227 | controller | ok: [controller] 2026-08-22 08:30:53.372365 | controller | 2026-08-22 08:30:53.372486 | controller | TASK [Stat removed file 2] ***************************************************** 2026-08-22 08:30:53.372611 | controller | Saturday 22 August 2026 08:30:53 +0000 (0:00:00.288) 0:00:02.061 ******* 2026-08-22 08:30:53.663835 | controller | ok: [controller] 2026-08-22 08:30:53.663911 | controller | 2026-08-22 08:30:53.664100 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-08-22 08:30:53.664229 | controller | Saturday 22 August 2026 08:30:53 +0000 (0:00:00.291) 0:00:02.353 ******* 2026-08-22 08:30:53.696591 | controller | ok: [controller] => { 2026-08-22 08:30:53.699376 | controller | "changed": false, 2026-08-22 08:30:53.699400 | controller | "msg": "All assertions passed" 2026-08-22 08:30:53.699405 | controller | } 2026-08-22 08:30:53.699409 | controller | 2026-08-22 08:30:53.699412 | controller | PLAY RECAP ********************************************************************* 2026-08-22 08:30:53.699416 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-08-22 08:30:53.699420 | controller | 2026-08-22 08:30:53.699430 | controller | 2026-08-22 08:30:53.699434 | controller | TASKS RECAP ******************************************************************** 2026-08-22 08:30:53.699437 | controller | Saturday 22 August 2026 08:30:53 +0000 (0:00:00.030) 0:00:02.384 ******* 2026-08-22 08:30:53.699441 | controller | =============================================================================== 2026-08-22 08:30:53.699444 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-08-22 08:30:53.699447 | controller | Stat file 1 ------------------------------------------------------------- 0.43s 2026-08-22 08:30:53.699450 | controller | Stat file 2 ------------------------------------------------------------- 0.30s 2026-08-22 08:30:53.699453 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s 2026-08-22 08:30:53.699456 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s 2026-08-22 08:30:53.699459 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-08-22 08:30:53.787565 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-08-22 08:30:53.797505 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-08-22 08:30:53.797849 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 08:30:53.803372 | controller | INFO [upload-helm-chart > destroy] Executing 2026-08-22 08:30:53.803493 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-08-22 08:30:53.803582 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-08-22 08:30:53.803858 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-08-22 08:30:54.025976 | controller | ok: Runtime: 0:00:48.145648 2026-08-22 08:30:54.030887 | 2026-08-22 08:30:54.030958 | PLAY RECAP 2026-08-22 08:30:54.031023 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:30:54.031058 | 2026-08-22 08:30:54.179689 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 08:30:54.182867 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-08-22 08:30:54.777027 | 2026-08-22 08:30:54.777160 | PLAY [all] 2026-08-22 08:30:54.787961 | 2026-08-22 08:30:54.788038 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-22 08:30:55.186086 | controller | changed 2026-08-22 08:30:55.191348 | 2026-08-22 08:30:55.191436 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-22 08:30:55.583528 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:30:55.584112 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:30:55.590373 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:30:55.591913 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:30:55.592644 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:30:55.593271 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:30:55.596140 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:30:55.597200 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:30:55.597502 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:30:55.598932 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:30:55.600540 | controller | environment: line 1: kubectl: command not found 2026-08-22 08:30:55.601781 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 08:30:55.724882 | controller | ok: Runtime: 0:00:00.030379 2026-08-22 08:30:55.730634 | 2026-08-22 08:30:55.730754 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-22 08:30:55.967453 | controller | changed 2026-08-22 08:30:55.973515 | 2026-08-22 08:30:55.973609 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-22 08:30:56.213732 | controller | environment: line 5: kubectl: command not found 2026-08-22 08:30:56.214679 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:30:56.215259 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:30:56.215751 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 08:30:56.504003 | controller | ok: Runtime: 0:00:00.011832 2026-08-22 08:30:56.511020 | 2026-08-22 08:30:56.511147 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-22 08:30:57.150570 | controller | changed: 2026-08-22 08:30:57.150824 | controller | created directory /var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/logs/controller 2026-08-22 08:30:57.150899 | controller | cd+++++++++ objects/ 2026-08-22 08:30:57.150949 | controller | cd+++++++++ objects/cluster/ 2026-08-22 08:30:57.150999 | controller | cd+++++++++ objects/namespaced/ 2026-08-22 08:30:57.160423 | 2026-08-22 08:30:57.160499 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-22 08:30:57.397706 | controller | changed 2026-08-22 08:30:57.404332 | 2026-08-22 08:30:57.404435 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-22 08:30:57.653082 | controller | changed 2026-08-22 08:30:57.658885 | 2026-08-22 08:30:57.658973 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-22 08:30:57.885748 | controller | environment: line 3: kubectl: command not found 2026-08-22 08:30:58.190962 | controller | ok: Runtime: 0:00:00.012147 2026-08-22 08:30:58.199421 | 2026-08-22 08:30:58.199778 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-22 08:30:58.689818 | controller | changed: 2026-08-22 08:30:58.690010 | controller | cd+++++++++ pod-logs/ 2026-08-22 08:30:58.690038 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-08-22 08:30:58.697529 | 2026-08-22 08:30:58.697595 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-22 08:30:58.933240 | controller | changed: "values" 2026-08-22 08:30:59.128666 | controller | changed: "releases" 2026-08-22 08:30:59.139391 | 2026-08-22 08:30:59.139621 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-22 08:30:59.366804 | controller | /bin/bash: line 3: kubectl: command not found 2026-08-22 08:30:59.672435 | controller | ok: Runtime: 0:00:00.007415 2026-08-22 08:30:59.677470 | 2026-08-22 08:30:59.677546 | TASK [helm-release-status : Downloads logs to executor] 2026-08-22 08:31:00.136124 | controller | changed: 2026-08-22 08:31:00.136382 | controller | cd+++++++++ helm/ 2026-08-22 08:31:00.136426 | controller | cd+++++++++ helm/releases/ 2026-08-22 08:31:00.136463 | controller | cd+++++++++ helm/values/ 2026-08-22 08:31:00.144725 | 2026-08-22 08:31:00.144866 | PLAY RECAP 2026-08-22 08:31:00.144919 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 08:31:00.144942 | 2026-08-22 08:31:00.306650 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-08-22 08:31:00.309768 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 08:31:00.938634 | 2026-08-22 08:31:00.938810 | PLAY [all] 2026-08-22 08:31:00.950112 | 2026-08-22 08:31:00.950244 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-22 08:31:00.995641 | controller | skipping: Conditional result was False 2026-08-22 08:31:01.001806 | 2026-08-22 08:31:01.001923 | TASK [fetch-output : Set log path for single node] 2026-08-22 08:31:01.042092 | controller | ok 2026-08-22 08:31:01.047472 | 2026-08-22 08:31:01.047567 | LOOP [fetch-output : Ensure local output dirs] 2026-08-22 08:31:01.448516 | controller -> localhost | ok: "/var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/logs" 2026-08-22 08:31:01.662463 | controller -> localhost | changed: "/var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/artifacts" 2026-08-22 08:31:01.866877 | controller -> localhost | changed: "/var/lib/zuul/builds/0044933ea7c04d778eb781b6308b4423/work/docs" 2026-08-22 08:31:01.888782 | 2026-08-22 08:31:01.889016 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-22 08:31:02.530617 | controller | changed: .d..t...... ./ 2026-08-22 08:31:02.530917 | controller | changed: All items complete 2026-08-22 08:31:02.530970 | 2026-08-22 08:31:02.989181 | controller | changed: .d..t...... ./ 2026-08-22 08:31:03.472873 | controller | changed: .d..t...... ./ 2026-08-22 08:31:03.489270 | 2026-08-22 08:31:03.489471 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-22 08:31:03.932499 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007892 2026-08-22 08:31:04.156386 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007517 2026-08-22 08:31:04.172535 | 2026-08-22 08:31:04.172736 | PLAY [all] 2026-08-22 08:31:04.179472 | 2026-08-22 08:31:04.179558 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-22 08:31:04.650544 | controller | changed 2026-08-22 08:31:04.656791 | 2026-08-22 08:31:04.656875 | PLAY RECAP 2026-08-22 08:31:04.656942 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 08:31:04.657058 | 2026-08-22 08:31:04.818217 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 08:31:04.822170 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-22 08:31:05.468379 | 2026-08-22 08:31:05.468546 | PLAY [localhost] 2026-08-22 08:31:05.487571 | 2026-08-22 08:31:05.487824 | TASK [Generate Zuul manifest] 2026-08-22 08:31:05.510965 | localhost | ok 2026-08-22 08:31:05.527182 | 2026-08-22 08:31:05.527286 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-22 08:31:05.943452 | localhost | changed 2026-08-22 08:31:05.957314 | 2026-08-22 08:31:05.957479 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-22 08:31:06.072924 | localhost | ok 2026-08-22 08:31:06.082007 | 2026-08-22 08:31:06.082088 | TASK [Upload logs] 2026-08-22 08:31:06.104587 | localhost | ok 2026-08-22 08:31:06.175446 | 2026-08-22 08:31:06.175606 | TASK [Set zuul-log-path fact] 2026-08-22 08:31:06.193336 | localhost | ok 2026-08-22 08:31:06.208279 | 2026-08-22 08:31:06.208375 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 08:31:06.238235 | localhost | ok 2026-08-22 08:31:06.246902 | 2026-08-22 08:31:06.246976 | TASK [upload-logs : Create log directories] 2026-08-22 08:31:06.727856 | localhost | changed 2026-08-22 08:31:06.734056 | 2026-08-22 08:31:06.734150 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-22 08:31:07.150604 | localhost -> localhost | ok: Runtime: 0:00:00.004840 2026-08-22 08:31:07.158020 | 2026-08-22 08:31:07.158114 | TASK [upload-logs : Upload logs to log server] 2026-08-22 08:31:07.627920 | localhost | Output suppressed because no_log was given 2026-08-22 08:31:07.634504 | 2026-08-22 08:31:07.634712 | LOOP [upload-logs : Compress console log and json output] 2026-08-22 08:31:07.680886 | localhost | skipping: Conditional result was False 2026-08-22 08:31:07.733810 | localhost | skipping: Conditional result was False 2026-08-22 08:31:07.750025 | 2026-08-22 08:31:07.750213 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-22 08:31:07.796521 | localhost | skipping: Conditional result was False 2026-08-22 08:31:07.796765 | 2026-08-22 08:31:07.801660 | localhost | skipping: Conditional result was False 2026-08-22 08:31:07.817708 | 2026-08-22 08:31:07.817880 | LOOP [upload-logs : Upload console log and json output]