2026-07-25 00:49:36.613751 | Job console starting
2026-07-25 00:49:36.633061 | Updating git repos
2026-07-25 00:49:36.678625 | Cloning repos into workspace
2026-07-25 00:49:36.709739 | Restoring repo states
2026-07-25 00:49:36.722914 | Merging changes
2026-07-25 00:49:37.239872 | Checking out repos
2026-07-25 00:49:37.279920 | Preparing playbooks
2026-07-25 00:49:39.525148 | Running Ansible setup
2026-07-25 00:49:43.064907 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 00:49:43.665796 | 
2026-07-25 00:49:43.665907 | PLAY [localhost]
2026-07-25 00:49:43.675389 | 
2026-07-25 00:49:43.675531 | TASK [Gathering Facts]
2026-07-25 00:49:44.494736 | localhost | ok
2026-07-25 00:49:44.504036 | 
2026-07-25 00:49:44.504109 | TASK [Setup log path fact]
2026-07-25 00:49:44.523705 | localhost | ok
2026-07-25 00:49:44.537282 | 
2026-07-25 00:49:44.537370 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 00:49:44.567797 | localhost | ok
2026-07-25 00:49:44.575832 | 
2026-07-25 00:49:44.575917 | TASK [emit-job-header : Print job information]
2026-07-25 00:49:44.616237 | # Job Information
2026-07-25 00:49:44.616424 | Ansible Version: 2.16.18
2026-07-25 00:49:44.616471 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-07-25 00:49:44.616502 | Pipeline: check
2026-07-25 00:49:44.616532 | Executor: 2d72f0692154
2026-07-25 00:49:44.616560 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/293
2026-07-25 00:49:44.616592 | Event ID: 31fa52d0-87c2-11f1-9aa5-095a49956a1f
2026-07-25 00:49:44.620703 | 
2026-07-25 00:49:44.620802 | LOOP [emit-job-header : Print node information]
2026-07-25 00:49:44.703451 | localhost | ok:
2026-07-25 00:49:44.703628 | localhost | # Node Information
2026-07-25 00:49:44.703657 | localhost | Inventory Hostname: controller
2026-07-25 00:49:44.703678 | localhost | Hostname: np0000186730
2026-07-25 00:49:44.703698 | localhost | Username: zuul
2026-07-25 00:49:44.703720 | localhost | Distro: Debian 13.6
2026-07-25 00:49:44.703740 | localhost | Provider: yul1
2026-07-25 00:49:44.703759 | localhost | Region: ca-ymq-1
2026-07-25 00:49:44.703778 | localhost | Label: debian-trixie
2026-07-25 00:49:44.703796 | localhost | Product Name: OpenStack Nova
2026-07-25 00:49:44.703815 | localhost | Interface IP: 199.204.45.22
2026-07-25 00:49:44.720469 | 
2026-07-25 00:49:44.720536 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-25 00:49:45.149291 | localhost -> localhost | changed
2026-07-25 00:49:45.161869 | 
2026-07-25 00:49:45.161948 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-25 00:49:45.953831 | localhost -> localhost | changed
2026-07-25 00:49:45.961522 | 
2026-07-25 00:49:45.961624 | PLAY [all]
2026-07-25 00:49:45.968604 | 
2026-07-25 00:49:45.968699 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-25 00:49:46.196980 | controller -> localhost | ok
2026-07-25 00:49:46.202431 | 
2026-07-25 00:49:46.202501 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-25 00:49:46.232007 | controller | ok
2026-07-25 00:49:46.246252 | controller | included: /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-25 00:49:46.250859 | 
2026-07-25 00:49:46.250922 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-25 00:49:47.530934 | controller -> localhost | Generating public/private rsa key pair.
2026-07-25 00:49:47.531097 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/94142d2904b349aa92830e3d84da80ce_id_rsa
2026-07-25 00:49:47.531127 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/94142d2904b349aa92830e3d84da80ce_id_rsa.pub
2026-07-25 00:49:47.531149 | controller -> localhost | The key fingerprint is:
2026-07-25 00:49:47.531198 | controller -> localhost | SHA256:kG5pgGGsLZ4jBQ7AtiWGaIvMm0lplhi33iA5n/3xbRc zuul-build-sshkey
2026-07-25 00:49:47.531232 | controller -> localhost | The key's randomart image is:
2026-07-25 00:49:47.531253 | controller -> localhost | +---[RSA 3072]----+
2026-07-25 00:49:47.531279 | controller -> localhost | |*.o              |
2026-07-25 00:49:47.531301 | controller -> localhost | |*Bo+   .         |
2026-07-25 00:49:47.531321 | controller -> localhost | |@BO.. o          |
2026-07-25 00:49:47.531341 | controller -> localhost | |O%=  o o         |
2026-07-25 00:49:47.531361 | controller -> localhost | |=B==  = S        |
2026-07-25 00:49:47.531380 | controller -> localhost | |.B+ oo.     E    |
2026-07-25 00:49:47.531399 | controller -> localhost | |. .  . o .   .   |
2026-07-25 00:49:47.531418 | controller -> localhost | |      . . o .    |
2026-07-25 00:49:47.531439 | controller -> localhost | |         . .     |
2026-07-25 00:49:47.531459 | controller -> localhost | +----[SHA256]-----+
2026-07-25 00:49:47.531503 | controller -> localhost | ok: Runtime: 0:00:00.903339
2026-07-25 00:49:47.535464 | 
2026-07-25 00:49:47.535527 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-25 00:49:47.562055 | controller | ok
2026-07-25 00:49:47.569625 | controller | included: /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-25 00:49:47.575896 | 
2026-07-25 00:49:47.575954 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-25 00:49:47.599064 | controller | skipping: Conditional result was False
2026-07-25 00:49:47.606194 | 
2026-07-25 00:49:47.606282 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-25 00:49:48.125966 | controller | changed
2026-07-25 00:49:48.132040 | 
2026-07-25 00:49:48.132117 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-25 00:49:48.364261 | controller | ok
2026-07-25 00:49:48.370913 | 
2026-07-25 00:49:48.370973 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-25 00:49:48.942749 | controller | changed
2026-07-25 00:49:48.947791 | 
2026-07-25 00:49:48.947869 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-25 00:49:49.453287 | controller | changed
2026-07-25 00:49:49.545707 | 
2026-07-25 00:49:49.545854 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-25 00:49:49.569261 | controller | skipping: Conditional result was False
2026-07-25 00:49:49.577941 | 
2026-07-25 00:49:49.578077 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-25 00:49:49.906025 | controller -> localhost | changed
2026-07-25 00:49:49.914449 | 
2026-07-25 00:49:49.914534 | TASK [add-build-sshkey : Add back temp key]
2026-07-25 00:49:50.167823 | controller -> localhost | Identity added: /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/94142d2904b349aa92830e3d84da80ce_id_rsa (zuul-build-sshkey)
2026-07-25 00:49:50.168026 | controller -> localhost | ok: Runtime: 0:00:00.012983
2026-07-25 00:49:50.174366 | 
2026-07-25 00:49:50.174483 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-25 00:49:50.498891 | controller | ok
2026-07-25 00:49:50.504291 | 
2026-07-25 00:49:50.504399 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-25 00:49:50.528327 | controller | skipping: Conditional result was False
2026-07-25 00:49:50.540189 | 
2026-07-25 00:49:50.540271 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-25 00:49:50.871188 | controller | ok
2026-07-25 00:49:50.875743 | 
2026-07-25 00:49:50.875805 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-25 00:49:51.760867 | controller | Output suppressed because no_log was given
2026-07-25 00:49:51.949830 | 
2026-07-25 00:49:51.949931 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-25 00:49:52.191051 | controller | ok: "logs"
2026-07-25 00:49:52.191257 | controller | ok: All items complete
2026-07-25 00:49:52.191296 | 
2026-07-25 00:49:52.378798 | controller | ok: "artifacts"
2026-07-25 00:49:52.559738 | controller | ok: "docs"
2026-07-25 00:49:52.575672 | 
2026-07-25 00:49:52.575826 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-25 00:49:52.783398 | controller | changed: "logs"
2026-07-25 00:49:52.972312 | controller | changed: "artifacts"
2026-07-25 00:49:53.158956 | controller | changed: "docs"
2026-07-25 00:49:53.171949 | 
2026-07-25 00:49:53.172060 | PLAY RECAP
2026-07-25 00:49:53.172121 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-25 00:49:53.172160 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 00:49:53.172189 | 
2026-07-25 00:49:53.276600 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-25 00:49:53.277909 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 00:49:53.862245 | 
2026-07-25 00:49:53.862662 | PLAY [all]
2026-07-25 00:49:53.873568 | 
2026-07-25 00:49:53.873709 | TASK [setup-uv : Extract archive]
2026-07-25 00:49:57.343609 | controller | changed
2026-07-25 00:49:57.350847 | 
2026-07-25 00:49:57.350930 | TASK [setup-uv : Print version]
2026-07-25 00:49:57.696636 | controller | uv 0.8.13
2026-07-25 00:49:57.878829 | controller | ok: Runtime: 0:00:00.016526
2026-07-25 00:49:57.886924 | 
2026-07-25 00:49:57.887016 | TASK [Install Ansible collection siblings]
2026-07-25 00:49:58.273267 | controller | ok:
2026-07-25 00:49:58.273511 | controller | Skipping ansible.posix: no checked-out sibling
2026-07-25 00:49:58.273574 | controller | Skipping community.crypto: no checked-out sibling
2026-07-25 00:49:58.273621 | controller | Skipping community.general: no checked-out sibling
2026-07-25 00:49:58.273667 | controller | Skipping kubernetes.core: no checked-out sibling
2026-07-25 00:49:58.273711 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-07-25 00:49:58.275350 | 
2026-07-25 00:49:58.275394 | PLAY RECAP
2026-07-25 00:49:58.275435 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 00:49:58.275456 | 
2026-07-25 00:49:58.374475 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-25 00:49:58.376326 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-07-25 00:49:58.959992 | 
2026-07-25 00:49:58.960102 | PLAY [all]
2026-07-25 00:49:58.969494 | 
2026-07-25 00:49:58.969571 | TASK [Update apt cache]
2026-07-25 00:50:03.572710 | controller | ok
2026-07-25 00:50:03.719274 | 
2026-07-25 00:50:03.719472 | TASK [Disable firewalld]
2026-07-25 00:50:03.744176 | controller | skipping: Conditional result was False
2026-07-25 00:50:03.751378 | 
2026-07-25 00:50:03.751469 | TASK [Install "jq" for log collection]
2026-07-25 00:50:05.980681 | controller | changed
2026-07-25 00:50:05.983019 | 
2026-07-25 00:50:05.983084 | PLAY RECAP
2026-07-25 00:50:05.983139 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 00:50:05.983168 | 
2026-07-25 00:50:06.081979 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-07-25 00:50:06.084658 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-25 00:50:06.705641 | 
2026-07-25 00:50:06.705767 | PLAY [all]
2026-07-25 00:50:06.715752 | 
2026-07-25 00:50:06.715847 | LOOP [Check inventory directories]
2026-07-25 00:50:07.098312 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-07-25 00:50:07.292069 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory"
2026-07-25 00:50:07.466388 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory"
2026-07-25 00:50:07.483462 | 
2026-07-25 00:50:07.483625 | LOOP [Copy inventory file for Zuul]
2026-07-25 00:50:08.365485 | controller | changed:
2026-07-25 00:50:08.365635 | controller | {
2026-07-25 00:50:08.365664 | controller |   "ansible_loop_var": "item",
2026-07-25 00:50:08.365687 | controller |   "changed": false,
2026-07-25 00:50:08.365707 | controller |   "failed": false,
2026-07-25 00:50:08.365730 | controller |   "invocation": {
2026-07-25 00:50:08.365749 | controller |     "module_args": {
2026-07-25 00:50:08.365769 | controller |       "checksum_algorithm": "sha1",
2026-07-25 00:50:08.365787 | controller |       "follow": true,
2026-07-25 00:50:08.365805 | controller |       "get_attributes": true,
2026-07-25 00:50:08.365825 | controller |       "get_checksum": true,
2026-07-25 00:50:08.365843 | controller |       "get_mime": true,
2026-07-25 00:50:08.365861 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-07-25 00:50:08.365879 | controller |     }
2026-07-25 00:50:08.365897 | controller |   },
2026-07-25 00:50:08.365914 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-07-25 00:50:08.365932 | controller |   "stat": {
2026-07-25 00:50:08.365950 | controller |     "atime": 1784940591.641455,
2026-07-25 00:50:08.365968 | controller |     "attr_flags": "e",
2026-07-25 00:50:08.365986 | controller |     "attributes": [
2026-07-25 00:50:08.366004 | controller |       "extents"
2026-07-25 00:50:08.366021 | controller |     ],
2026-07-25 00:50:08.366039 | controller |     "block_size": 4096,
2026-07-25 00:50:08.366056 | controller |     "blocks": 8,
2026-07-25 00:50:08.366073 | controller |     "charset": "unknown",
2026-07-25 00:50:08.366092 | controller |     "ctime": 1784940591.657455,
2026-07-25 00:50:08.366110 | controller |     "dev": 65025,
2026-07-25 00:50:08.366128 | controller |     "device_type": 0,
2026-07-25 00:50:08.366145 | controller |     "executable": true,
2026-07-25 00:50:08.366163 | controller |     "exists": true,
2026-07-25 00:50:08.366180 | controller |     "gid": 1000,
2026-07-25 00:50:08.366197 | controller |     "gr_name": "zuul",
2026-07-25 00:50:08.366214 | controller |     "inode": 518935,
2026-07-25 00:50:08.366231 | controller |     "isblk": false,
2026-07-25 00:50:08.366249 | controller |     "ischr": false,
2026-07-25 00:50:08.366267 | controller |     "isdir": true,
2026-07-25 00:50:08.366284 | controller |     "isfifo": false,
2026-07-25 00:50:08.366301 | controller |     "isgid": false,
2026-07-25 00:50:08.366318 | controller |     "islnk": false,
2026-07-25 00:50:08.366336 | controller |     "isreg": false,
2026-07-25 00:50:08.366353 | controller |     "issock": false,
2026-07-25 00:50:08.366370 | controller |     "isuid": false,
2026-07-25 00:50:08.366387 | controller |     "mimetype": "unknown",
2026-07-25 00:50:08.366404 | controller |     "mode": "0755",
2026-07-25 00:50:08.366421 | controller |     "mtime": 1784940576.8171937,
2026-07-25 00:50:08.366438 | controller |     "nlink": 14,
2026-07-25 00:50:08.366455 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-07-25 00:50:08.366472 | controller |     "pw_name": "zuul",
2026-07-25 00:50:08.366492 | controller |     "readable": true,
2026-07-25 00:50:08.366510 | controller |     "rgrp": true,
2026-07-25 00:50:08.366527 | controller |     "roth": true,
2026-07-25 00:50:08.366546 | controller |     "rusr": true,
2026-07-25 00:50:08.366563 | controller |     "size": 4096,
2026-07-25 00:50:08.366581 | controller |     "uid": 1000,
2026-07-25 00:50:08.366599 | controller |     "version": "2887511057",
2026-07-25 00:50:08.366617 | controller |     "wgrp": false,
2026-07-25 00:50:08.366636 | controller |     "woth": false,
2026-07-25 00:50:08.366654 | controller |     "writeable": true,
2026-07-25 00:50:08.366672 | controller |     "wusr": true,
2026-07-25 00:50:08.366689 | controller |     "xgrp": true,
2026-07-25 00:50:08.366707 | controller |     "xoth": true,
2026-07-25 00:50:08.366724 | controller |     "xusr": true
2026-07-25 00:50:08.366750 | controller |   }
2026-07-25 00:50:08.366769 | controller | }
2026-07-25 00:50:08.366803 | controller | ok: All items complete
2026-07-25 00:50:08.366826 | 
2026-07-25 00:50:08.368116 | controller | skipping: Conditional result was False
2026-07-25 00:50:08.368696 | controller | skipping: Conditional result was False
2026-07-25 00:50:08.384085 | 
2026-07-25 00:50:08.384222 | LOOP [Switch "ansible_host" to private IP]
2026-07-25 00:50:08.741224 | controller | changed: 1 replacements made
2026-07-25 00:50:08.742447 | controller | skipping: Conditional result was False
2026-07-25 00:50:08.743482 | controller | skipping: Conditional result was False
2026-07-25 00:50:08.762498 | 
2026-07-25 00:50:08.762676 | TASK [Run Molecule scenario]
2026-07-25 00:50:09.192717 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-07-25 00:50:09.192845 | controller | Creating virtual environment at: .venv
2026-07-25 00:50:09.614438 | controller | Downloading pygments (1.2MiB)
2026-07-25 00:50:09.615186 | controller | Downloading cryptography (4.3MiB)
2026-07-25 00:50:09.616698 | controller | Downloading ansible-core (2.3MiB)
2026-07-25 00:50:09.767574 | controller |  Downloading cryptography
2026-07-25 00:50:09.824013 | controller |  Downloading pygments
2026-07-25 00:50:10.005400 | controller |  Downloading ansible-core
2026-07-25 00:50:10.059008 | controller | Installed 36 packages in 52ms
2026-07-25 00:50:10.722791 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-07-25 00:50:10.722887 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-07-25 00:50:11.577922 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-07-25 00:50:11.578004 | controller | INFO     default scenario not found, disabling shared state.
2026-07-25 00:50:11.578047 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-07-25 00:50:11.578065 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-07-25 00:50:30.648031 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-07-25 00:50:30.648301 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-07-25 00:50:30.648600 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-07-25 00:50:30.648779 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-07-25 00:50:30.654533 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-07-25 00:50:30.654863 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-25 00:50:30.660698 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-07-25 00:50:30.660725 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-07-25 00:50:30.660832 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-07-25 00:50:30.666535 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-07-25 00:50:31.534771 | controller |
2026-07-25 00:50:31.535001 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-07-25 00:50:31.589780 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-07-25 00:50:31.601981 | controller | INFO     [upload-helm-chart > create] Executing
2026-07-25 00:50:31.603588 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-25 00:50:31.609136 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-07-25 00:50:31.609446 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-25 00:50:31.614829 | controller | INFO     [upload-helm-chart > converge] Executing
2026-07-25 00:50:32.510628 | controller |
2026-07-25 00:50:32.510792 | controller | PLAY [Converge] ****************************************************************
2026-07-25 00:50:32.510983 | controller |
2026-07-25 00:50:32.511184 | controller | TASK [Gathering Facts] *********************************************************
2026-07-25 00:50:32.511386 | controller | Saturday 25 July 2026  00:50:32 +0000 (0:00:00.030)       0:00:00.030 *********
2026-07-25 00:50:33.866001 | 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-07-25 00:50:33.871878 | controller | ok: [controller]
2026-07-25 00:50:33.871939 | controller |
2026-07-25 00:50:33.872004 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:33.872097 | controller | Saturday 25 July 2026  00:50:33 +0000 (0:00:01.361)       0:00:01.392 *********
2026-07-25 00:50:33.961806 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-07-25 00:50:33.962102 | controller |
2026-07-25 00:50:33.962388 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-07-25 00:50:33.962604 | controller | Saturday 25 July 2026  00:50:33 +0000 (0:00:00.089)       0:00:01.482 *********
2026-07-25 00:50:34.631008 | controller | changed: [controller]
2026-07-25 00:50:34.631189 | controller |
2026-07-25 00:50:34.631493 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:34.631811 | controller | Saturday 25 July 2026  00:50:34 +0000 (0:00:00.668)       0:00:02.151 *********
2026-07-25 00:50:34.678928 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-07-25 00:50:34.679056 | controller |
2026-07-25 00:50:34.679278 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-07-25 00:50:34.679491 | controller | Saturday 25 July 2026  00:50:34 +0000 (0:00:00.048)       0:00:02.199 *********
2026-07-25 00:50:35.143269 | controller | changed: [controller]
2026-07-25 00:50:35.144352 | controller |
2026-07-25 00:50:35.144398 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-07-25 00:50:35.144404 | controller | Saturday 25 July 2026  00:50:35 +0000 (0:00:00.463)       0:00:02.663 *********
2026-07-25 00:50:36.295283 | controller | changed: [controller]
2026-07-25 00:50:36.295461 | controller |
2026-07-25 00:50:36.295694 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-07-25 00:50:36.296005 | controller | Saturday 25 July 2026  00:50:36 +0000 (0:00:01.150)       0:00:03.814 *********
2026-07-25 00:50:36.745260 | controller | ok: [controller]
2026-07-25 00:50:36.745425 | controller |
2026-07-25 00:50:36.745646 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-07-25 00:50:36.745846 | controller | Saturday 25 July 2026  00:50:36 +0000 (0:00:00.447)       0:00:04.261 *********
2026-07-25 00:50:36.799380 | controller | skipping: [controller]
2026-07-25 00:50:36.799523 | controller |
2026-07-25 00:50:36.799710 | controller | PLAY RECAP *********************************************************************
2026-07-25 00:50:36.799991 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-25 00:50:36.800215 | controller |
2026-07-25 00:50:36.800465 | controller |
2026-07-25 00:50:36.800647 | controller | TASKS RECAP ********************************************************************
2026-07-25 00:50:36.800839 | controller | Saturday 25 July 2026  00:50:36 +0000 (0:00:00.059)       0:00:04.320 *********
2026-07-25 00:50:36.800991 | controller | ===============================================================================
2026-07-25 00:50:36.801183 | controller | Gathering Facts --------------------------------------------------------- 1.36s
2026-07-25 00:50:36.801376 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.15s
2026-07-25 00:50:36.801566 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.67s
2026-07-25 00:50:36.801767 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s
2026-07-25 00:50:36.801945 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.45s
2026-07-25 00:50:36.802140 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s
2026-07-25 00:50:36.802337 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-07-25 00:50:36.802534 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-07-25 00:50:36.941279 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-07-25 00:50:36.954130 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-07-25 00:50:37.818130 | controller |
2026-07-25 00:50:37.818214 | controller | PLAY [Converge] ****************************************************************
2026-07-25 00:50:37.818435 | controller |
2026-07-25 00:50:37.818590 | controller | TASK [Gathering Facts] *********************************************************
2026-07-25 00:50:37.818785 | controller | Saturday 25 July 2026  00:50:37 +0000 (0:00:00.011)       0:00:00.011 *********
2026-07-25 00:50:38.909223 | 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-07-25 00:50:38.914796 | controller | ok: [controller]
2026-07-25 00:50:38.914994 | controller |
2026-07-25 00:50:38.915209 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:38.915446 | controller | Saturday 25 July 2026  00:50:38 +0000 (0:00:01.097)       0:00:01.108 *********
2026-07-25 00:50:38.996303 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-07-25 00:50:38.996492 | controller |
2026-07-25 00:50:38.996694 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-07-25 00:50:38.996888 | controller | Saturday 25 July 2026  00:50:38 +0000 (0:00:00.081)       0:00:01.189 *********
2026-07-25 00:50:39.686876 | controller | ok: [controller]
2026-07-25 00:50:39.687026 | controller |
2026-07-25 00:50:39.687253 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:39.687457 | controller | Saturday 25 July 2026  00:50:39 +0000 (0:00:00.690)       0:00:01.879 *********
2026-07-25 00:50:39.735843 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-07-25 00:50:39.736008 | controller |
2026-07-25 00:50:39.736303 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-07-25 00:50:39.736580 | controller | Saturday 25 July 2026  00:50:39 +0000 (0:00:00.049)       0:00:01.929 *********
2026-07-25 00:50:40.167287 | controller | ok: [controller]
2026-07-25 00:50:40.167477 | controller |
2026-07-25 00:50:40.167713 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-07-25 00:50:40.168028 | controller | Saturday 25 July 2026  00:50:40 +0000 (0:00:00.430)       0:00:02.360 *********
2026-07-25 00:50:41.331834 | controller | ok: [controller]
2026-07-25 00:50:41.331982 | controller |
2026-07-25 00:50:41.332222 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-07-25 00:50:41.332491 | controller | Saturday 25 July 2026  00:50:41 +0000 (0:00:01.164)       0:00:03.524 *********
2026-07-25 00:50:41.753622 | controller | ok: [controller]
2026-07-25 00:50:41.753748 | controller |
2026-07-25 00:50:41.754023 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-07-25 00:50:41.754237 | controller | Saturday 25 July 2026  00:50:41 +0000 (0:00:00.421)       0:00:03.946 *********
2026-07-25 00:50:41.797945 | controller | skipping: [controller]
2026-07-25 00:50:41.798151 | controller |
2026-07-25 00:50:41.798350 | controller | PLAY RECAP *********************************************************************
2026-07-25 00:50:41.798566 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-07-25 00:50:41.798739 | controller |
2026-07-25 00:50:41.798909 | controller |
2026-07-25 00:50:41.799087 | controller | TASKS RECAP ********************************************************************
2026-07-25 00:50:41.799280 | controller | Saturday 25 July 2026  00:50:41 +0000 (0:00:00.045)       0:00:03.991 *********
2026-07-25 00:50:41.799457 | controller | ===============================================================================
2026-07-25 00:50:41.799670 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.16s
2026-07-25 00:50:41.800004 | controller | Gathering Facts --------------------------------------------------------- 1.10s
2026-07-25 00:50:41.800256 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.69s
2026-07-25 00:50:41.800517 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s
2026-07-25 00:50:41.800749 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-07-25 00:50:41.800967 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-07-25 00:50:41.801189 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-07-25 00:50:41.801393 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-07-25 00:50:41.909840 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-07-25 00:50:41.920756 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-07-25 00:50:42.846168 | controller |
2026-07-25 00:50:42.846402 | controller | PLAY [Side effect] *************************************************************
2026-07-25 00:50:42.846645 | controller |
2026-07-25 00:50:42.846923 | controller | TASK [Gathering Facts] *********************************************************
2026-07-25 00:50:42.847203 | controller | Saturday 25 July 2026  00:50:42 +0000 (0:00:00.011)       0:00:00.011 *********
2026-07-25 00:50:44.971337 | 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-07-25 00:50:44.977367 | controller | ok: [controller]
2026-07-25 00:50:44.977450 | controller |
2026-07-25 00:50:44.977546 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:44.977633 | controller | Saturday 25 July 2026  00:50:44 +0000 (0:00:02.131)       0:00:02.143 *********
2026-07-25 00:50:45.057959 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-07-25 00:50:45.058117 | controller |
2026-07-25 00:50:45.058328 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-07-25 00:50:45.058524 | controller | Saturday 25 July 2026  00:50:45 +0000 (0:00:00.080)       0:00:02.223 *********
2026-07-25 00:50:45.735837 | controller | changed: [controller]
2026-07-25 00:50:45.735975 | controller |
2026-07-25 00:50:45.736207 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-07-25 00:50:45.736467 | controller | Saturday 25 July 2026  00:50:45 +0000 (0:00:00.677)       0:00:02.901 *********
2026-07-25 00:50:45.781647 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-07-25 00:50:45.781813 | controller |
2026-07-25 00:50:45.782011 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-07-25 00:50:45.782206 | controller | Saturday 25 July 2026  00:50:45 +0000 (0:00:00.046)       0:00:02.947 *********
2026-07-25 00:50:46.209333 | controller | ok: [controller]
2026-07-25 00:50:46.209510 | controller |
2026-07-25 00:50:46.209783 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-07-25 00:50:46.209998 | controller | Saturday 25 July 2026  00:50:46 +0000 (0:00:00.424)       0:00:03.371 *********
2026-07-25 00:50:47.374536 | controller | ok: [controller]
2026-07-25 00:50:47.374574 | controller |
2026-07-25 00:50:47.374581 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-07-25 00:50:47.374587 | controller | Saturday 25 July 2026  00:50:47 +0000 (0:00:01.168)       0:00:04.539 *********
2026-07-25 00:50:47.788770 | controller | ok: [controller]
2026-07-25 00:50:47.788867 | controller |
2026-07-25 00:50:47.789008 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-07-25 00:50:47.789139 | controller | Saturday 25 July 2026  00:50:47 +0000 (0:00:00.410)       0:00:04.950 *********
2026-07-25 00:50:48.114299 | controller | changed: [controller] => (item=/file)
2026-07-25 00:50:48.114363 | controller |
2026-07-25 00:50:48.116333 | controller | PLAY RECAP *********************************************************************
2026-07-25 00:50:48.116362 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-25 00:50:48.116367 | controller |
2026-07-25 00:50:48.116371 | controller |
2026-07-25 00:50:48.116374 | controller | TASKS RECAP ********************************************************************
2026-07-25 00:50:48.116387 | controller | Saturday 25 July 2026  00:50:48 +0000 (0:00:00.330)       0:00:05.280 *********
2026-07-25 00:50:48.116390 | controller | ===============================================================================
2026-07-25 00:50:48.116394 | controller | Gathering Facts --------------------------------------------------------- 2.13s
2026-07-25 00:50:48.116397 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.17s
2026-07-25 00:50:48.116400 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.68s
2026-07-25 00:50:48.116404 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-07-25 00:50:48.116408 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-07-25 00:50:48.116414 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.33s
2026-07-25 00:50:48.116417 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-07-25 00:50:48.116421 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-07-25 00:50:48.248368 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-07-25 00:50:48.256702 | controller | INFO     [upload-helm-chart > verify] Executing
2026-07-25 00:50:49.151690 | controller |
2026-07-25 00:50:49.151820 | controller | PLAY [Verify] ******************************************************************
2026-07-25 00:50:49.152011 | controller |
2026-07-25 00:50:49.152222 | controller | TASK [Gathering Facts] *********************************************************
2026-07-25 00:50:49.152508 | controller | Saturday 25 July 2026  00:50:49 +0000 (0:00:00.009)       0:00:00.009 *********
2026-07-25 00:50:50.233202 | 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-07-25 00:50:50.233352 | controller | ok: [controller]
2026-07-25 00:50:50.233495 | controller |
2026-07-25 00:50:50.233650 | controller | TASK [Stat file 1] *************************************************************
2026-07-25 00:50:50.233808 | controller | Saturday 25 July 2026  00:50:50 +0000 (0:00:01.078)       0:00:01.088 *********
2026-07-25 00:50:50.640971 | controller | ok: [controller]
2026-07-25 00:50:50.641164 | controller |
2026-07-25 00:50:50.641380 | controller | TASK [Stat file 2] *************************************************************
2026-07-25 00:50:50.641578 | controller | Saturday 25 July 2026  00:50:50 +0000 (0:00:00.410)       0:00:01.499 *********
2026-07-25 00:50:50.979186 | controller | ok: [controller]
2026-07-25 00:50:50.979211 | controller |
2026-07-25 00:50:50.979215 | controller | TASK [Stat removed file 1] *****************************************************
2026-07-25 00:50:50.979219 | controller | Saturday 25 July 2026  00:50:50 +0000 (0:00:00.335)       0:00:01.835 *********
2026-07-25 00:50:51.276223 | controller | ok: [controller]
2026-07-25 00:50:51.276403 | controller |
2026-07-25 00:50:51.276650 | controller | TASK [Stat removed file 2] *****************************************************
2026-07-25 00:50:51.276848 | controller | Saturday 25 July 2026  00:50:51 +0000 (0:00:00.299)       0:00:02.134 *********
2026-07-25 00:50:51.571011 | controller | ok: [controller]
2026-07-25 00:50:51.571199 | controller |
2026-07-25 00:50:51.571401 | controller | TASK [ansible.builtin.assert] **************************************************
2026-07-25 00:50:51.571595 | controller | Saturday 25 July 2026  00:50:51 +0000 (0:00:00.295)       0:00:02.429 *********
2026-07-25 00:50:51.601101 | controller | ok: [controller] => {
2026-07-25 00:50:51.601245 | controller |     "changed": false,
2026-07-25 00:50:51.601425 | controller |     "msg": "All assertions passed"
2026-07-25 00:50:51.601602 | controller | }
2026-07-25 00:50:51.601770 | controller |
2026-07-25 00:50:51.601949 | controller | PLAY RECAP *********************************************************************
2026-07-25 00:50:51.602159 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-07-25 00:50:51.602318 | controller |
2026-07-25 00:50:51.602479 | controller |
2026-07-25 00:50:51.602657 | controller | TASKS RECAP ********************************************************************
2026-07-25 00:50:51.602840 | controller | Saturday 25 July 2026  00:50:51 +0000 (0:00:00.031)       0:00:02.461 *********
2026-07-25 00:50:51.603014 | controller | ===============================================================================
2026-07-25 00:50:51.603222 | controller | Gathering Facts --------------------------------------------------------- 1.08s
2026-07-25 00:50:51.603398 | controller | Stat file 1 ------------------------------------------------------------- 0.41s
2026-07-25 00:50:51.603578 | controller | Stat file 2 ------------------------------------------------------------- 0.34s
2026-07-25 00:50:51.603759 | controller | Stat removed file 1 ----------------------------------------------------- 0.30s
2026-07-25 00:50:51.603939 | controller | Stat removed file 2 ----------------------------------------------------- 0.30s
2026-07-25 00:50:51.604119 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-07-25 00:50:51.720069 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-07-25 00:50:51.730786 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-07-25 00:50:51.731103 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-07-25 00:50:51.736515 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-07-25 00:50:51.736545 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-07-25 00:50:51.736611 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-07-25 00:50:51.736920 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-07-25 00:50:52.342183 | controller | ok: Runtime: 0:00:42.722495
2026-07-25 00:50:52.347219 | 
2026-07-25 00:50:52.347282 | PLAY RECAP
2026-07-25 00:50:52.347341 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 00:50:52.347375 | 
2026-07-25 00:50:52.451125 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-25 00:50:52.454255 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-07-25 00:50:53.066293 | 
2026-07-25 00:50:53.066751 | PLAY [all]
2026-07-25 00:50:53.077398 | 
2026-07-25 00:50:53.077507 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-07-25 00:50:53.453467 | controller | changed
2026-07-25 00:50:53.816802 | 
2026-07-25 00:50:53.817132 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-07-25 00:50:54.203365 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 00:50:54.203482 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 00:50:54.212503 | controller | environment: line 1: kubectl: command not found
2026-07-25 00:50:54.214761 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 00:50:54.215851 | controller | environment: line 1: kubectl: command not found
2026-07-25 00:50:54.217720 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 00:50:54.218300 | controller | environment: line 1: kubectl: command not found
2026-07-25 00:50:54.220300 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 00:50:54.221576 | controller | environment: line 1: kubectl: command not found
2026-07-25 00:50:54.223022 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 00:50:54.224575 | controller | environment: line 1: kubectl: command not found
2026-07-25 00:50:54.226517 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-07-25 00:50:54.350377 | controller | ok: Runtime: 0:00:00.038285
2026-07-25 00:50:54.355675 | 
2026-07-25 00:50:54.355764 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-07-25 00:50:54.610878 | controller | changed
2026-07-25 00:50:54.617420 | 
2026-07-25 00:50:54.617540 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-07-25 00:50:54.862310 | controller | environment: line 5: kubectl: command not found
2026-07-25 00:50:54.863015 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 00:50:54.863945 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 00:50:54.864372 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-07-25 00:50:55.148082 | controller | ok: Runtime: 0:00:00.015043
2026-07-25 00:50:55.154984 | 
2026-07-25 00:50:55.155101 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-07-25 00:50:55.754635 | controller | changed:
2026-07-25 00:50:55.754859 | controller | created directory /var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/logs/controller
2026-07-25 00:50:55.754924 | controller | cd+++++++++ objects/
2026-07-25 00:50:55.754974 | controller | cd+++++++++ objects/cluster/
2026-07-25 00:50:55.755026 | controller | cd+++++++++ objects/namespaced/
2026-07-25 00:50:55.765979 | 
2026-07-25 00:50:55.766069 | TASK [gather-pod-logs : creating directory for pod logs]
2026-07-25 00:50:56.010789 | controller | changed
2026-07-25 00:50:56.016750 | 
2026-07-25 00:50:56.016839 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-07-25 00:50:56.262117 | controller | changed
2026-07-25 00:50:56.266530 | 
2026-07-25 00:50:56.266605 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-07-25 00:50:56.506919 | controller | environment: line 3: kubectl: command not found
2026-07-25 00:50:56.792575 | controller | ok: Runtime: 0:00:00.014053
2026-07-25 00:50:56.796410 | 
2026-07-25 00:50:56.796475 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-07-25 00:50:57.252704 | controller | changed:
2026-07-25 00:50:57.252936 | controller | cd+++++++++ pod-logs/
2026-07-25 00:50:57.253027 | controller | cd+++++++++ pod-logs/failed-pods/
2026-07-25 00:50:57.260992 | 
2026-07-25 00:50:57.261055 | LOOP [helm-release-status : creating directory for helm release status]
2026-07-25 00:50:57.493860 | controller | changed: "values"
2026-07-25 00:50:57.698690 | controller | changed: "releases"
2026-07-25 00:50:57.716743 | 
2026-07-25 00:50:57.716858 | TASK [helm-release-status : Gather get release status for helm charts]
2026-07-25 00:50:57.955229 | controller | /bin/bash: line 3: kubectl: command not found
2026-07-25 00:50:58.243898 | controller | ok: Runtime: 0:00:00.008653
2026-07-25 00:50:58.252385 | 
2026-07-25 00:50:58.252450 | TASK [helm-release-status : Downloads logs to executor]
2026-07-25 00:50:59.034507 | controller | changed:
2026-07-25 00:50:59.034756 | controller | cd+++++++++ helm/
2026-07-25 00:50:59.034821 | controller | cd+++++++++ helm/releases/
2026-07-25 00:50:59.034875 | controller | cd+++++++++ helm/values/
2026-07-25 00:50:59.041537 | 
2026-07-25 00:50:59.041604 | PLAY RECAP
2026-07-25 00:50:59.041664 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-25 00:50:59.041694 | 
2026-07-25 00:50:59.161153 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-07-25 00:50:59.163972 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 00:50:59.721863 | 
2026-07-25 00:50:59.721968 | PLAY [all]
2026-07-25 00:50:59.731345 | 
2026-07-25 00:50:59.731419 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-25 00:50:59.775851 | controller | skipping: Conditional result was False
2026-07-25 00:50:59.783236 | 
2026-07-25 00:50:59.783345 | TASK [fetch-output : Set log path for single node]
2026-07-25 00:50:59.824592 | controller | ok
2026-07-25 00:50:59.829302 | 
2026-07-25 00:50:59.829395 | LOOP [fetch-output : Ensure local output dirs]
2026-07-25 00:51:00.178501 | controller -> localhost | ok: "/var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/logs"
2026-07-25 00:51:00.374048 | controller -> localhost | changed: "/var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/artifacts"
2026-07-25 00:51:00.571920 | controller -> localhost | changed: "/var/lib/zuul/builds/94142d2904b349aa92830e3d84da80ce/work/docs"
2026-07-25 00:51:00.586080 | 
2026-07-25 00:51:00.586219 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-25 00:51:01.185300 | controller | changed: .d..t...... ./
2026-07-25 00:51:01.185599 | controller | changed: All items complete
2026-07-25 00:51:01.185660 | 
2026-07-25 00:51:01.606012 | controller | changed: .d..t...... ./
2026-07-25 00:51:02.033182 | controller | changed: .d..t...... ./
2026-07-25 00:51:02.049585 | 
2026-07-25 00:51:02.049706 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-25 00:51:02.439470 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006684
2026-07-25 00:51:02.661649 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.005804
2026-07-25 00:51:02.683824 | 
2026-07-25 00:51:02.683926 | PLAY [all]
2026-07-25 00:51:02.689393 | 
2026-07-25 00:51:02.689457 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-25 00:51:03.188406 | controller | changed
2026-07-25 00:51:03.195611 | 
2026-07-25 00:51:03.195668 | PLAY RECAP
2026-07-25 00:51:03.195716 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-25 00:51:03.195739 | 
2026-07-25 00:51:03.356507 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-25 00:51:03.359290 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-25 00:51:03.949200 | 
2026-07-25 00:51:03.949331 | PLAY [localhost]
2026-07-25 00:51:03.959556 | 
2026-07-25 00:51:03.959638 | TASK [Generate Zuul manifest]
2026-07-25 00:51:03.977999 | localhost | ok
2026-07-25 00:51:03.994764 | 
2026-07-25 00:51:03.994858 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-25 00:51:04.340350 | localhost | changed
2026-07-25 00:51:04.351578 | 
2026-07-25 00:51:04.351656 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-25 00:51:04.493719 | localhost | ok
2026-07-25 00:51:04.503766 | 
2026-07-25 00:51:04.503840 | TASK [Upload logs]
2026-07-25 00:51:04.524806 | localhost | ok
2026-07-25 00:51:04.579402 | 
2026-07-25 00:51:04.579505 | TASK [Set zuul-log-path fact]
2026-07-25 00:51:04.602169 | localhost | ok
2026-07-25 00:51:04.617137 | 
2026-07-25 00:51:04.617213 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-25 00:51:04.648807 | localhost | ok
2026-07-25 00:51:04.660219 | 
2026-07-25 00:51:04.660308 | TASK [upload-logs : Create log directories]
2026-07-25 00:51:05.046961 | localhost | changed
2026-07-25 00:51:05.056025 | 
2026-07-25 00:51:05.056096 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-25 00:51:05.422932 | localhost -> localhost | ok: Runtime: 0:00:00.004773
2026-07-25 00:51:05.429443 | 
2026-07-25 00:51:05.429536 | TASK [upload-logs : Upload logs to log server]
2026-07-25 00:51:05.861705 | localhost | Output suppressed because no_log was given
2026-07-25 00:51:05.865306 | 
2026-07-25 00:51:05.865373 | LOOP [upload-logs : Compress console log and json output]
2026-07-25 00:51:05.907397 | localhost | skipping: Conditional result was False
2026-07-25 00:51:05.946504 | localhost | skipping: Conditional result was False
2026-07-25 00:51:05.958889 | 
2026-07-25 00:51:05.959092 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-25 00:51:05.997287 | localhost | skipping: Conditional result was False
2026-07-25 00:51:05.997679 | 
2026-07-25 00:51:06.001527 | localhost | skipping: Conditional result was False
2026-07-25 00:51:06.011508 | 
2026-07-25 00:51:06.011636 | LOOP [upload-logs : Upload console log and json output]