2026-10-27 17:40:23.804194 | Job console starting
2026-10-27 17:40:23.815815 | Updating git repos
2026-10-27 17:40:23.867310 | Cloning repos into workspace
2026-10-27 17:40:23.938867 | Restoring repo states
2026-10-27 17:40:23.951031 | Merging changes
2026-10-27 17:40:24.809410 | Checking out repos
2026-10-27 17:40:25.026859 | Preparing playbooks
2026-10-27 17:40:27.298216 | Running Ansible setup
2026-10-27 17:40:30.957689 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-27 17:40:31.490555 | 
2026-10-27 17:40:31.490678 | PLAY [localhost]
2026-10-27 17:40:31.497511 | 
2026-10-27 17:40:31.497588 | TASK [Gathering Facts]
2026-10-27 17:40:32.360915 | localhost | ok
2026-10-27 17:40:32.369240 | 
2026-10-27 17:40:32.369306 | TASK [Setup log path fact]
2026-10-27 17:40:32.384749 | localhost | ok
2026-10-27 17:40:32.394471 | 
2026-10-27 17:40:32.394540 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-27 17:40:32.421204 | localhost | ok
2026-10-27 17:40:32.426278 | 
2026-10-27 17:40:32.426340 | TASK [emit-job-header : Print job information]
2026-10-27 17:40:32.452089 | # Job Information
2026-10-27 17:40:32.452188 | Ansible Version: 2.16.18
2026-10-27 17:40:32.452218 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-10-27 17:40:32.452238 | Pipeline: check
2026-10-27 17:40:32.452257 | Executor: 2d72f0692154
2026-10-27 17:40:32.452275 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/316
2026-10-27 17:40:32.452295 | Event ID: 9866ebd0-d229-11f1-9b70-7805d7973bd3
2026-10-27 17:40:32.454703 | 
2026-10-27 17:40:32.454761 | LOOP [emit-job-header : Print node information]
2026-10-27 17:40:32.520911 | localhost | ok:
2026-10-27 17:40:32.521334 | localhost | # Node Information
2026-10-27 17:40:32.521363 | localhost | Inventory Hostname: controller
2026-10-27 17:40:32.521382 | localhost | Hostname: np0000197194
2026-10-27 17:40:32.521400 | localhost | Username: zuul
2026-10-27 17:40:32.521421 | localhost | Distro: Debian 13.7
2026-10-27 17:40:32.521438 | localhost | Provider: yul1
2026-10-27 17:40:32.521454 | localhost | Region: ca-ymq-1
2026-10-27 17:40:32.521470 | localhost | Label: debian-trixie
2026-10-27 17:40:32.521486 | localhost | Product Name: OpenStack Nova
2026-10-27 17:40:32.521503 | localhost | Interface IP: 162.253.55.76
2026-10-27 17:40:32.536203 | 
2026-10-27 17:40:32.536328 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-10-27 17:40:33.086060 | localhost -> localhost | changed
2026-10-27 17:40:33.099849 | 
2026-10-27 17:40:33.100069 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-10-27 17:40:34.070414 | localhost -> localhost | changed
2026-10-27 17:40:34.077961 | 
2026-10-27 17:40:34.078034 | PLAY [all]
2026-10-27 17:40:34.091819 | 
2026-10-27 17:40:34.092250 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-10-27 17:40:34.308052 | controller -> localhost | ok
2026-10-27 17:40:34.317460 | 
2026-10-27 17:40:34.317592 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-10-27 17:40:34.340574 | controller | ok
2026-10-27 17:40:34.364801 | controller | included: /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-10-27 17:40:34.370951 | 
2026-10-27 17:40:34.371027 | TASK [add-build-sshkey : Create Temp SSH key]
2026-10-27 17:40:35.412764 | controller -> localhost | Generating public/private rsa key pair.
2026-10-27 17:40:35.413003 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/214ae42e7cb6432da9ec733cab58b309_id_rsa
2026-10-27 17:40:35.413047 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/214ae42e7cb6432da9ec733cab58b309_id_rsa.pub
2026-10-27 17:40:35.413094 | controller -> localhost | The key fingerprint is:
2026-10-27 17:40:35.413126 | controller -> localhost | SHA256:8vrxYSnGdsucTGIKQczB7lp1KA/NaMP5unulFN8AypQ zuul-build-sshkey
2026-10-27 17:40:35.413179 | controller -> localhost | The key's randomart image is:
2026-10-27 17:40:35.413213 | controller -> localhost | +---[RSA 3072]----+
2026-10-27 17:40:35.413304 | controller -> localhost | |   ...           |
2026-10-27 17:40:35.413355 | controller -> localhost | |   oE..          |
2026-10-27 17:40:35.413389 | controller -> localhost | |   =+* o         |
2026-10-27 17:40:35.413419 | controller -> localhost | |   .% * o        |
2026-10-27 17:40:35.413496 | controller -> localhost | |   o.B.+So       |
2026-10-27 17:40:35.413537 | controller -> localhost | |    o.++o ..     |
2026-10-27 17:40:35.413569 | controller -> localhost | |   o.o oX *      |
2026-10-27 17:40:35.413612 | controller -> localhost | |  . ..o* % +     |
2026-10-27 17:40:35.413659 | controller -> localhost | |    o+o.. B      |
2026-10-27 17:40:35.413688 | controller -> localhost | +----[SHA256]-----+
2026-10-27 17:40:35.413751 | controller -> localhost | ok: Runtime: 0:00:00.683669
2026-10-27 17:40:35.420701 | 
2026-10-27 17:40:35.420872 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-10-27 17:40:35.450209 | controller | ok
2026-10-27 17:40:35.461710 | controller | included: /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-10-27 17:40:35.472240 | 
2026-10-27 17:40:35.472364 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-10-27 17:40:35.488560 | controller | skipping: Conditional result was False
2026-10-27 17:40:35.495071 | 
2026-10-27 17:40:35.495185 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-10-27 17:40:36.044777 | controller | changed
2026-10-27 17:40:36.054288 | 
2026-10-27 17:40:36.054434 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-10-27 17:40:36.266773 | controller | ok
2026-10-27 17:40:36.271904 | 
2026-10-27 17:40:36.271982 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-10-27 17:40:36.826609 | controller | changed
2026-10-27 17:40:36.836370 | 
2026-10-27 17:40:36.836520 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-10-27 17:40:37.388832 | controller | changed
2026-10-27 17:40:37.399542 | 
2026-10-27 17:40:37.399699 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-10-27 17:40:37.423943 | controller | skipping: Conditional result was False
2026-10-27 17:40:37.432460 | 
2026-10-27 17:40:37.432640 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-10-27 17:40:37.817743 | controller -> localhost | changed
2026-10-27 17:40:37.842314 | 
2026-10-27 17:40:37.842477 | TASK [add-build-sshkey : Add back temp key]
2026-10-27 17:40:38.158729 | controller -> localhost | Identity added: /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/214ae42e7cb6432da9ec733cab58b309_id_rsa (zuul-build-sshkey)
2026-10-27 17:40:38.159091 | controller -> localhost | ok: Runtime: 0:00:00.013233
2026-10-27 17:40:38.165721 | 
2026-10-27 17:40:38.165895 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-10-27 17:40:38.511030 | controller | ok
2026-10-27 17:40:38.521121 | 
2026-10-27 17:40:38.521442 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-10-27 17:40:38.561757 | controller | skipping: Conditional result was False
2026-10-27 17:40:38.592217 | 
2026-10-27 17:40:38.592427 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-10-27 17:40:38.963984 | controller | ok
2026-10-27 17:40:38.972637 | 
2026-10-27 17:40:38.972759 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-10-27 17:40:40.339197 | controller | Output suppressed because no_log was given
2026-10-27 17:40:40.353910 | 
2026-10-27 17:40:40.354038 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-10-27 17:40:40.606358 | controller | ok: "logs"
2026-10-27 17:40:40.606609 | controller | ok: All items complete
2026-10-27 17:40:40.606656 | 
2026-10-27 17:40:40.805746 | controller | ok: "artifacts"
2026-10-27 17:40:41.005435 | controller | ok: "docs"
2026-10-27 17:40:41.026329 | 
2026-10-27 17:40:41.026721 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-10-27 17:40:41.285377 | controller | changed: "logs"
2026-10-27 17:40:41.472058 | controller | changed: "artifacts"
2026-10-27 17:40:41.697886 | controller | changed: "docs"
2026-10-27 17:40:41.707576 | 
2026-10-27 17:40:41.707700 | PLAY RECAP
2026-10-27 17:40:41.707765 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-10-27 17:40:41.707800 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 17:40:41.707828 | 
2026-10-27 17:40:41.810382 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-10-27 17:40:41.811847 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-27 17:40:42.437576 | 
2026-10-27 17:40:42.437697 | PLAY [all]
2026-10-27 17:40:42.458797 | 
2026-10-27 17:40:42.459182 | TASK [setup-uv : Extract archive]
2026-10-27 17:40:44.922319 | controller | changed
2026-10-27 17:40:44.938252 | 
2026-10-27 17:40:44.938453 | TASK [setup-uv : Print version]
2026-10-27 17:40:45.342187 | controller | uv 0.8.13
2026-10-27 17:40:45.477650 | controller | ok: Runtime: 0:00:00.015971
2026-10-27 17:40:45.491426 | 
2026-10-27 17:40:45.491562 | TASK [Install Ansible collection siblings]
2026-10-27 17:40:45.895077 | controller | ok:
2026-10-27 17:40:45.895368 | controller | Skipping ansible.posix: no checked-out sibling
2026-10-27 17:40:45.895432 | controller | Skipping community.crypto: no checked-out sibling
2026-10-27 17:40:45.895474 | controller | Skipping community.general: no checked-out sibling
2026-10-27 17:40:45.895512 | controller | Skipping kubernetes.core: no checked-out sibling
2026-10-27 17:40:45.895549 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-10-27 17:40:45.898465 | 
2026-10-27 17:40:45.898558 | PLAY RECAP
2026-10-27 17:40:45.898671 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 17:40:45.898719 | 
2026-10-27 17:40:46.038715 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-10-27 17:40:46.041322 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-10-27 17:40:46.677746 | 
2026-10-27 17:40:46.677936 | PLAY [all]
2026-10-27 17:40:46.689830 | 
2026-10-27 17:40:46.689956 | TASK [Update apt cache]
2026-10-27 17:40:51.942065 | controller | ok
2026-10-27 17:40:51.946062 | 
2026-10-27 17:40:51.946140 | TASK [Disable firewalld]
2026-10-27 17:40:51.973749 | controller | skipping: Conditional result was False
2026-10-27 17:40:51.982053 | 
2026-10-27 17:40:51.982171 | TASK [Install "jq" for log collection]
2026-10-27 17:40:54.328730 | controller | changed
2026-10-27 17:40:54.331257 | 
2026-10-27 17:40:54.331325 | PLAY RECAP
2026-10-27 17:40:54.331395 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-27 17:40:54.331433 | 
2026-10-27 17:40:54.570102 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-10-27 17:40:54.572659 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-10-27 17:40:55.129059 | 
2026-10-27 17:40:55.129163 | PLAY [all]
2026-10-27 17:40:55.137692 | 
2026-10-27 17:40:55.137759 | LOOP [Check inventory directories]
2026-10-27 17:40:55.589589 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-10-27 17:40:55.792274 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/upload-helm-chart/inventory"
2026-10-27 17:40:56.011417 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/inventory"
2026-10-27 17:40:56.027585 | 
2026-10-27 17:40:56.027779 | LOOP [Copy inventory file for Zuul]
2026-10-27 17:40:56.978967 | controller | changed:
2026-10-27 17:40:56.979286 | controller | {
2026-10-27 17:40:56.979340 | controller |   "ansible_loop_var": "item",
2026-10-27 17:40:56.979384 | controller |   "changed": false,
2026-10-27 17:40:56.979422 | controller |   "failed": false,
2026-10-27 17:40:56.979467 | controller |   "invocation": {
2026-10-27 17:40:56.979504 | controller |     "module_args": {
2026-10-27 17:40:56.979539 | controller |       "checksum_algorithm": "sha1",
2026-10-27 17:40:56.979574 | controller |       "follow": true,
2026-10-27 17:40:56.979624 | controller |       "get_attributes": true,
2026-10-27 17:40:56.979662 | controller |       "get_checksum": true,
2026-10-27 17:40:56.979697 | controller |       "get_mime": true,
2026-10-27 17:40:56.979732 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-10-27 17:40:56.979766 | controller |     }
2026-10-27 17:40:56.979800 | controller |   },
2026-10-27 17:40:56.979833 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-10-27 17:40:56.979867 | controller |   "stat": {
2026-10-27 17:40:56.979900 | controller |     "atime": 1793122840.0986924,
2026-10-27 17:40:56.979933 | controller |     "attr_flags": "e",
2026-10-27 17:40:56.979967 | controller |     "attributes": [
2026-10-27 17:40:56.980000 | controller |       "extents"
2026-10-27 17:40:56.980033 | controller |     ],
2026-10-27 17:40:56.980066 | controller |     "block_size": 4096,
2026-10-27 17:40:56.980099 | controller |     "blocks": 8,
2026-10-27 17:40:56.980132 | controller |     "charset": "unknown",
2026-10-27 17:40:56.980168 | controller |     "ctime": 1793122840.2306936,
2026-10-27 17:40:56.980201 | controller |     "dev": 65025,
2026-10-27 17:40:56.980234 | controller |     "device_type": 0,
2026-10-27 17:40:56.980267 | controller |     "executable": true,
2026-10-27 17:40:56.980301 | controller |     "exists": true,
2026-10-27 17:40:56.980333 | controller |     "gid": 1000,
2026-10-27 17:40:56.980365 | controller |     "gr_name": "zuul",
2026-10-27 17:40:56.980397 | controller |     "inode": 521751,
2026-10-27 17:40:56.980430 | controller |     "isblk": false,
2026-10-27 17:40:56.980463 | controller |     "ischr": false,
2026-10-27 17:40:56.980521 | controller |     "isdir": true,
2026-10-27 17:40:56.980559 | controller |     "isfifo": false,
2026-10-27 17:40:56.980592 | controller |     "isgid": false,
2026-10-27 17:40:56.980644 | controller |     "islnk": false,
2026-10-27 17:40:56.980678 | controller |     "isreg": false,
2026-10-27 17:40:56.980710 | controller |     "issock": false,
2026-10-27 17:40:56.980742 | controller |     "isuid": false,
2026-10-27 17:40:56.980774 | controller |     "mimetype": "unknown",
2026-10-27 17:40:56.980806 | controller |     "mode": "0755",
2026-10-27 17:40:56.980838 | controller |     "mtime": 1793122824.059566,
2026-10-27 17:40:56.980871 | controller |     "nlink": 14,
2026-10-27 17:40:56.980903 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-10-27 17:40:56.980936 | controller |     "pw_name": "zuul",
2026-10-27 17:40:56.980975 | controller |     "readable": true,
2026-10-27 17:40:56.981008 | controller |     "rgrp": true,
2026-10-27 17:40:56.981041 | controller |     "roth": true,
2026-10-27 17:40:56.981076 | controller |     "rusr": true,
2026-10-27 17:40:56.981109 | controller |     "size": 4096,
2026-10-27 17:40:56.981143 | controller |     "uid": 1000,
2026-10-27 17:40:56.981176 | controller |     "version": "45448902",
2026-10-27 17:40:56.981209 | controller |     "wgrp": false,
2026-10-27 17:40:56.981246 | controller |     "woth": false,
2026-10-27 17:40:56.981279 | controller |     "writeable": true,
2026-10-27 17:40:56.981313 | controller |     "wusr": true,
2026-10-27 17:40:56.981346 | controller |     "xgrp": true,
2026-10-27 17:40:56.981378 | controller |     "xoth": true,
2026-10-27 17:40:56.981411 | controller |     "xusr": true
2026-10-27 17:40:56.981489 | controller |   }
2026-10-27 17:40:56.981527 | controller | }
2026-10-27 17:40:56.981627 | controller | ok: All items complete
2026-10-27 17:40:56.981671 | 
2026-10-27 17:40:56.984303 | controller | skipping: Conditional result was False
2026-10-27 17:40:56.986574 | controller | skipping: Conditional result was False
2026-10-27 17:40:57.006853 | 
2026-10-27 17:40:57.007063 | LOOP [Switch "ansible_host" to private IP]
2026-10-27 17:40:57.465573 | controller | changed: 1 replacements made
2026-10-27 17:40:57.468220 | controller | skipping: Conditional result was False
2026-10-27 17:40:57.475450 | controller | skipping: Conditional result was False
2026-10-27 17:40:57.494902 | 
2026-10-27 17:40:57.495095 | TASK [Run Molecule scenario]
2026-10-27 17:40:58.006138 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-10-27 17:40:58.006249 | controller | Creating virtual environment at: .venv
2026-10-27 17:40:58.312955 | controller | Downloading ansible-core (2.3MiB)
2026-10-27 17:40:58.319758 | controller | Downloading pygments (1.2MiB)
2026-10-27 17:40:58.320721 | controller | Downloading cryptography (4.3MiB)
2026-10-27 17:40:58.491863 | controller |  Downloading cryptography
2026-10-27 17:40:58.538595 | controller |  Downloading pygments
2026-10-27 17:40:58.682510 | controller |  Downloading ansible-core
2026-10-27 17:40:58.738827 | controller | Installed 36 packages in 55ms
2026-10-27 17:40:59.430807 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-10-27 17:40:59.430868 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-10-27 17:41:00.307744 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-10-27 17:41:00.307796 | controller | INFO     default scenario not found, disabling shared state.
2026-10-27 17:41:00.307893 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-10-27 17:41:00.307984 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-10-27 17:41:17.191102 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-10-27 17:41:17.191518 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-10-27 17:41:17.191944 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-10-27 17:41:17.192165 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-10-27 17:41:17.203116 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-10-27 17:41:17.203789 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-27 17:41:17.214499 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-10-27 17:41:17.214624 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-10-27 17:41:17.214800 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-10-27 17:41:17.224381 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-10-27 17:41:18.083949 | controller |
2026-10-27 17:41:18.084181 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-10-27 17:41:18.140954 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-10-27 17:41:18.152291 | controller | INFO     [upload-helm-chart > create] Executing
2026-10-27 17:41:18.155199 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-27 17:41:18.166160 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-10-27 17:41:18.166741 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-27 17:41:18.177746 | controller | INFO     [upload-helm-chart > converge] Executing
2026-10-27 17:41:19.070002 | controller |
2026-10-27 17:41:19.070200 | controller | PLAY [Converge] ****************************************************************
2026-10-27 17:41:19.070400 | controller |
2026-10-27 17:41:19.070666 | controller | TASK [Gathering Facts] *********************************************************
2026-10-27 17:41:19.070857 | controller | Tuesday 27 October 2026  17:41:19 +0000 (0:00:00.032)       0:00:00.032 *******
2026-10-27 17:41:21.375220 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-27 17:41:21.385229 | controller | ok: [controller]
2026-10-27 17:41:21.385371 | controller |
2026-10-27 17:41:21.385605 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:21.385797 | controller | Tuesday 27 October 2026  17:41:21 +0000 (0:00:02.315)       0:00:02.347 *******
2026-10-27 17:41:21.500786 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-10-27 17:41:21.500885 | controller |
2026-10-27 17:41:21.501072 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-10-27 17:41:21.501232 | controller | Tuesday 27 October 2026  17:41:21 +0000 (0:00:00.116)       0:00:02.463 *******
2026-10-27 17:41:22.243788 | controller | changed: [controller]
2026-10-27 17:41:22.243896 | controller |
2026-10-27 17:41:22.244125 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:22.244330 | controller | Tuesday 27 October 2026  17:41:22 +0000 (0:00:00.742)       0:00:03.206 *******
2026-10-27 17:41:22.294225 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-10-27 17:41:22.294373 | controller |
2026-10-27 17:41:22.294676 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-10-27 17:41:22.294853 | controller | Tuesday 27 October 2026  17:41:22 +0000 (0:00:00.050)       0:00:03.256 *******
2026-10-27 17:41:22.758450 | controller | changed: [controller]
2026-10-27 17:41:22.758575 | controller |
2026-10-27 17:41:22.758805 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-10-27 17:41:22.758987 | controller | Tuesday 27 October 2026  17:41:22 +0000 (0:00:00.463)       0:00:03.720 *******
2026-10-27 17:41:23.959411 | controller | changed: [controller]
2026-10-27 17:41:23.959532 | controller |
2026-10-27 17:41:23.959785 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-10-27 17:41:23.959985 | controller | Tuesday 27 October 2026  17:41:23 +0000 (0:00:01.197)       0:00:04.917 *******
2026-10-27 17:41:24.440506 | controller | ok: [controller]
2026-10-27 17:41:24.440598 | controller |
2026-10-27 17:41:24.440832 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-10-27 17:41:24.440998 | controller | Tuesday 27 October 2026  17:41:24 +0000 (0:00:00.485)       0:00:05.402 *******
2026-10-27 17:41:24.518906 | controller | skipping: [controller]
2026-10-27 17:41:24.519058 | controller |
2026-10-27 17:41:24.519252 | controller | PLAY RECAP *********************************************************************
2026-10-27 17:41:24.519466 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-10-27 17:41:24.519657 | controller |
2026-10-27 17:41:24.519831 | controller |
2026-10-27 17:41:24.520007 | controller | TASKS RECAP ********************************************************************
2026-10-27 17:41:24.520218 | controller | Tuesday 27 October 2026  17:41:24 +0000 (0:00:00.079)       0:00:05.482 *******
2026-10-27 17:41:24.520384 | controller | ===============================================================================
2026-10-27 17:41:24.520585 | controller | Gathering Facts --------------------------------------------------------- 2.32s
2026-10-27 17:41:24.520781 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.20s
2026-10-27 17:41:24.520965 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-10-27 17:41:24.521163 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.49s
2026-10-27 17:41:24.521333 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s
2026-10-27 17:41:24.521548 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.12s
2026-10-27 17:41:24.521875 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.08s
2026-10-27 17:41:24.522155 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-10-27 17:41:24.625708 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-10-27 17:41:24.637876 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-10-27 17:41:25.516527 | controller |
2026-10-27 17:41:25.516630 | controller | PLAY [Converge] ****************************************************************
2026-10-27 17:41:25.516744 | controller |
2026-10-27 17:41:25.516879 | controller | TASK [Gathering Facts] *********************************************************
2026-10-27 17:41:25.517092 | controller | Tuesday 27 October 2026  17:41:25 +0000 (0:00:00.010)       0:00:00.010 *******
2026-10-27 17:41:27.570503 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-27 17:41:27.574472 | controller | ok: [controller]
2026-10-27 17:41:27.574632 | controller |
2026-10-27 17:41:27.574822 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:27.575007 | controller | Tuesday 27 October 2026  17:41:27 +0000 (0:00:02.057)       0:00:02.068 *******
2026-10-27 17:41:27.675665 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-10-27 17:41:27.675763 | controller |
2026-10-27 17:41:27.675949 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-10-27 17:41:27.676120 | controller | Tuesday 27 October 2026  17:41:27 +0000 (0:00:00.101)       0:00:02.169 *******
2026-10-27 17:41:28.417276 | controller | ok: [controller]
2026-10-27 17:41:28.417401 | controller |
2026-10-27 17:41:28.417624 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:28.417800 | controller | Tuesday 27 October 2026  17:41:28 +0000 (0:00:00.741)       0:00:02.910 *******
2026-10-27 17:41:28.474552 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-10-27 17:41:28.474680 | controller |
2026-10-27 17:41:28.474839 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-10-27 17:41:28.475011 | controller | Tuesday 27 October 2026  17:41:28 +0000 (0:00:00.057)       0:00:02.967 *******
2026-10-27 17:41:28.900677 | controller | ok: [controller]
2026-10-27 17:41:28.900791 | controller |
2026-10-27 17:41:28.900989 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-10-27 17:41:28.901169 | controller | Tuesday 27 October 2026  17:41:28 +0000 (0:00:00.426)       0:00:03.393 *******
2026-10-27 17:41:30.062483 | controller | ok: [controller]
2026-10-27 17:41:30.062517 | controller |
2026-10-27 17:41:30.062527 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-10-27 17:41:30.062536 | controller | Tuesday 27 October 2026  17:41:30 +0000 (0:00:01.160)       0:00:04.554 *******
2026-10-27 17:41:30.513856 | controller | ok: [controller]
2026-10-27 17:41:30.514060 | controller |
2026-10-27 17:41:30.514460 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-10-27 17:41:30.514798 | controller | Tuesday 27 October 2026  17:41:30 +0000 (0:00:00.452)       0:00:05.007 *******
2026-10-27 17:41:30.571267 | controller | skipping: [controller]
2026-10-27 17:41:30.571470 | controller |
2026-10-27 17:41:30.571631 | controller | PLAY RECAP *********************************************************************
2026-10-27 17:41:30.571875 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-10-27 17:41:30.571994 | controller |
2026-10-27 17:41:30.572154 | controller |
2026-10-27 17:41:30.572338 | controller | TASKS RECAP ********************************************************************
2026-10-27 17:41:30.572559 | controller | Tuesday 27 October 2026  17:41:30 +0000 (0:00:00.058)       0:00:05.065 *******
2026-10-27 17:41:30.572757 | controller | ===============================================================================
2026-10-27 17:41:30.572949 | controller | Gathering Facts --------------------------------------------------------- 2.06s
2026-10-27 17:41:30.573211 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.16s
2026-10-27 17:41:30.573486 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-10-27 17:41:30.573677 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.45s
2026-10-27 17:41:30.573862 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.43s
2026-10-27 17:41:30.574042 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s
2026-10-27 17:41:30.574236 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-10-27 17:41:30.574494 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s
2026-10-27 17:41:30.681760 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-10-27 17:41:30.694861 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-10-27 17:41:31.527290 | controller |
2026-10-27 17:41:31.527387 | controller | PLAY [Side effect] *************************************************************
2026-10-27 17:41:31.527535 | controller |
2026-10-27 17:41:31.527732 | controller | TASK [Gathering Facts] *********************************************************
2026-10-27 17:41:31.527889 | controller | Tuesday 27 October 2026  17:41:31 +0000 (0:00:00.011)       0:00:00.011 *******
2026-10-27 17:41:32.650184 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-27 17:41:32.662457 | controller | ok: [controller]
2026-10-27 17:41:32.662491 | controller |
2026-10-27 17:41:32.662501 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:32.662509 | controller | Tuesday 27 October 2026  17:41:32 +0000 (0:00:01.130)       0:00:01.142 *******
2026-10-27 17:41:32.771028 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-10-27 17:41:32.771168 | controller |
2026-10-27 17:41:32.771466 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-10-27 17:41:32.771564 | controller | Tuesday 27 October 2026  17:41:32 +0000 (0:00:00.112)       0:00:01.255 *******
2026-10-27 17:41:33.467962 | controller | changed: [controller]
2026-10-27 17:41:33.468036 | controller |
2026-10-27 17:41:33.468261 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-10-27 17:41:33.468466 | controller | Tuesday 27 October 2026  17:41:33 +0000 (0:00:00.696)       0:00:01.951 *******
2026-10-27 17:41:33.528780 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-10-27 17:41:33.528926 | controller |
2026-10-27 17:41:33.529103 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-10-27 17:41:33.529291 | controller | Tuesday 27 October 2026  17:41:33 +0000 (0:00:00.061)       0:00:02.012 *******
2026-10-27 17:41:33.992742 | controller | ok: [controller]
2026-10-27 17:41:33.992780 | controller |
2026-10-27 17:41:33.992788 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-10-27 17:41:33.992820 | controller | Tuesday 27 October 2026  17:41:33 +0000 (0:00:00.461)       0:00:02.474 *******
2026-10-27 17:41:35.167101 | controller | ok: [controller]
2026-10-27 17:41:35.167253 | controller |
2026-10-27 17:41:35.167449 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-10-27 17:41:35.167626 | controller | Tuesday 27 October 2026  17:41:35 +0000 (0:00:01.171)       0:00:03.645 *******
2026-10-27 17:41:35.606830 | controller | ok: [controller]
2026-10-27 17:41:35.606973 | controller |
2026-10-27 17:41:35.607189 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-10-27 17:41:35.607432 | controller | Tuesday 27 October 2026  17:41:35 +0000 (0:00:00.444)       0:00:04.090 *******
2026-10-27 17:41:35.974368 | controller | changed: [controller] => (item=/file)
2026-10-27 17:41:35.977115 | controller |
2026-10-27 17:41:35.977154 | controller | PLAY RECAP *********************************************************************
2026-10-27 17:41:35.977164 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-27 17:41:35.977172 | controller |
2026-10-27 17:41:35.977179 | controller |
2026-10-27 17:41:35.977186 | controller | TASKS RECAP ********************************************************************
2026-10-27 17:41:35.977208 | controller | Tuesday 27 October 2026  17:41:35 +0000 (0:00:00.368)       0:00:04.459 *******
2026-10-27 17:41:35.977237 | controller | ===============================================================================
2026-10-27 17:41:35.977244 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.17s
2026-10-27 17:41:35.977251 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-10-27 17:41:35.977258 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.70s
2026-10-27 17:41:35.977265 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s
2026-10-27 17:41:35.977272 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.44s
2026-10-27 17:41:35.977282 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.37s
2026-10-27 17:41:35.977292 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.11s
2026-10-27 17:41:35.977301 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s
2026-10-27 17:41:36.109425 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-10-27 17:41:36.118582 | controller | INFO     [upload-helm-chart > verify] Executing
2026-10-27 17:41:36.925570 | controller |
2026-10-27 17:41:36.925901 | controller | PLAY [Verify] ******************************************************************
2026-10-27 17:41:36.926133 | controller |
2026-10-27 17:41:36.926396 | controller | TASK [Gathering Facts] *********************************************************
2026-10-27 17:41:36.926790 | controller | Tuesday 27 October 2026  17:41:36 +0000 (0:00:00.009)       0:00:00.009 *******
2026-10-27 17:41:38.046731 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-10-27 17:41:38.053700 | controller | ok: [controller]
2026-10-27 17:41:38.053939 | controller |
2026-10-27 17:41:38.054204 | controller | TASK [Stat file 1] *************************************************************
2026-10-27 17:41:38.054528 | controller | Tuesday 27 October 2026  17:41:38 +0000 (0:00:01.128)       0:00:01.137 *******
2026-10-27 17:41:38.519110 | controller | ok: [controller]
2026-10-27 17:41:38.519382 | controller |
2026-10-27 17:41:38.519614 | controller | TASK [Stat file 2] *************************************************************
2026-10-27 17:41:38.519847 | controller | Tuesday 27 October 2026  17:41:38 +0000 (0:00:00.465)       0:00:01.602 *******
2026-10-27 17:41:38.860575 | controller | ok: [controller]
2026-10-27 17:41:38.860719 | controller |
2026-10-27 17:41:38.860836 | controller | TASK [Stat removed file 1] *****************************************************
2026-10-27 17:41:38.860953 | controller | Tuesday 27 October 2026  17:41:38 +0000 (0:00:00.341)       0:00:01.944 *******
2026-10-27 17:41:39.202387 | controller | ok: [controller]
2026-10-27 17:41:39.202711 | controller |
2026-10-27 17:41:39.202962 | controller | TASK [Stat removed file 2] *****************************************************
2026-10-27 17:41:39.203272 | controller | Tuesday 27 October 2026  17:41:39 +0000 (0:00:00.342)       0:00:02.286 *******
2026-10-27 17:41:39.542898 | controller | ok: [controller]
2026-10-27 17:41:39.543062 | controller |
2026-10-27 17:41:39.543228 | controller | TASK [ansible.builtin.assert] **************************************************
2026-10-27 17:41:39.543373 | controller | Tuesday 27 October 2026  17:41:39 +0000 (0:00:00.338)       0:00:02.624 *******
2026-10-27 17:41:39.586876 | controller | ok: [controller] => {
2026-10-27 17:41:39.587020 | controller |     "changed": false,
2026-10-27 17:41:39.587127 | controller |     "msg": "All assertions passed"
2026-10-27 17:41:39.587250 | controller | }
2026-10-27 17:41:39.587347 | controller |
2026-10-27 17:41:39.587451 | controller | PLAY RECAP *********************************************************************
2026-10-27 17:41:39.587563 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-10-27 17:41:39.587659 | controller |
2026-10-27 17:41:39.587765 | controller |
2026-10-27 17:41:39.587867 | controller | TASKS RECAP ********************************************************************
2026-10-27 17:41:39.587970 | controller | Tuesday 27 October 2026  17:41:39 +0000 (0:00:00.045)       0:00:02.670 *******
2026-10-27 17:41:39.588069 | controller | ===============================================================================
2026-10-27 17:41:39.588189 | controller | Gathering Facts --------------------------------------------------------- 1.13s
2026-10-27 17:41:39.588290 | controller | Stat file 1 ------------------------------------------------------------- 0.46s
2026-10-27 17:41:39.588390 | controller | Stat removed file 1 ----------------------------------------------------- 0.34s
2026-10-27 17:41:39.588565 | controller | Stat file 2 ------------------------------------------------------------- 0.34s
2026-10-27 17:41:39.588668 | controller | Stat removed file 2 ----------------------------------------------------- 0.34s
2026-10-27 17:41:39.588773 | controller | ansible.builtin.assert -------------------------------------------------- 0.05s
2026-10-27 17:41:39.681462 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-10-27 17:41:39.695042 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-10-27 17:41:39.695722 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-10-27 17:41:39.710226 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-10-27 17:41:39.710509 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-10-27 17:41:39.710692 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-10-27 17:41:39.711277 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-10-27 17:41:40.070568 | controller | ok: Runtime: 0:00:41.912777
2026-10-27 17:41:40.078198 | 
2026-10-27 17:41:40.078538 | PLAY RECAP
2026-10-27 17:41:40.078679 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 17:41:40.078755 | 
2026-10-27 17:41:40.301254 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-10-27 17:41:40.303456 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-10-27 17:41:40.886330 | 
2026-10-27 17:41:40.886448 | PLAY [all]
2026-10-27 17:41:40.896374 | 
2026-10-27 17:41:40.896454 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-10-27 17:41:41.301144 | controller | changed
2026-10-27 17:41:41.309129 | 
2026-10-27 17:41:41.309288 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-10-27 17:41:41.717449 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-27 17:41:41.718432 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-27 17:41:41.725643 | controller | environment: line 1: kubectl: command not found
2026-10-27 17:41:41.728212 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-27 17:41:41.729896 | controller | environment: line 1: kubectl: command not found
2026-10-27 17:41:41.732313 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-27 17:41:41.733862 | controller | environment: line 1: kubectl: command not found
2026-10-27 17:41:41.734840 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-27 17:41:41.737902 | controller | environment: line 1: kubectl: command not found
2026-10-27 17:41:41.739440 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-27 17:41:41.742330 | controller | environment: line 1: kubectl: command not found
2026-10-27 17:41:41.743980 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-10-27 17:41:41.848204 | controller | ok: Runtime: 0:00:00.040529
2026-10-27 17:41:41.855747 | 
2026-10-27 17:41:41.855871 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-10-27 17:41:42.115190 | controller | changed
2026-10-27 17:41:42.123339 | 
2026-10-27 17:41:42.123475 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-10-27 17:41:42.412414 | controller | environment: line 5: kubectl: command not found
2026-10-27 17:41:42.413149 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-27 17:41:42.413197 | controller |
2026-10-27 17:41:42.414258 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-10-27 17:41:42.662133 | controller | ok: Runtime: 0:00:00.015036
2026-10-27 17:41:42.671484 | 
2026-10-27 17:41:42.671632 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-10-27 17:41:43.346957 | controller | changed:
2026-10-27 17:41:43.347192 | controller | created directory /var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/logs/controller
2026-10-27 17:41:43.347256 | controller | cd+++++++++ objects/
2026-10-27 17:41:43.347303 | controller | cd+++++++++ objects/cluster/
2026-10-27 17:41:43.347350 | controller | cd+++++++++ objects/namespaced/
2026-10-27 17:41:43.362797 | 
2026-10-27 17:41:43.362939 | TASK [gather-pod-logs : creating directory for pod logs]
2026-10-27 17:41:43.629271 | controller | changed
2026-10-27 17:41:43.637195 | 
2026-10-27 17:41:43.637317 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-10-27 17:41:43.891389 | controller | changed
2026-10-27 17:41:43.899016 | 
2026-10-27 17:41:43.899153 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-10-27 17:41:44.197343 | controller | environment: line 3: kubectl: command not found
2026-10-27 17:41:44.440270 | controller | ok: Runtime: 0:00:00.013365
2026-10-27 17:41:44.448485 | 
2026-10-27 17:41:44.448653 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-10-27 17:41:44.965764 | controller | changed:
2026-10-27 17:41:44.965996 | controller | cd+++++++++ pod-logs/
2026-10-27 17:41:44.966051 | controller | cd+++++++++ pod-logs/failed-pods/
2026-10-27 17:41:44.979921 | 
2026-10-27 17:41:44.980055 | LOOP [helm-release-status : creating directory for helm release status]
2026-10-27 17:41:45.229811 | controller | changed: "values"
2026-10-27 17:41:45.466252 | controller | changed: "releases"
2026-10-27 17:41:45.480572 | 
2026-10-27 17:41:45.480729 | TASK [helm-release-status : Gather get release status for helm charts]
2026-10-27 17:41:45.746557 | controller | /bin/bash: line 7: helm: command not found
2026-10-27 17:41:45.750177 | controller | /bin/bash: line 11: kubectl: command not found
2026-10-27 17:41:46.019890 | controller | ok: Runtime: 0:00:00.012820
2026-10-27 17:41:46.028328 | 
2026-10-27 17:41:46.028477 | TASK [helm-release-status : Downloads logs to executor]
2026-10-27 17:41:46.570750 | controller | changed:
2026-10-27 17:41:46.570985 | controller | cd+++++++++ helm/
2026-10-27 17:41:46.571046 | controller | cd+++++++++ helm/releases/
2026-10-27 17:41:46.571090 | controller | cd+++++++++ helm/values/
2026-10-27 17:41:46.580860 | 
2026-10-27 17:41:46.580986 | PLAY RECAP
2026-10-27 17:41:46.581104 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-10-27 17:41:46.581176 | 
2026-10-27 17:41:46.699684 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-10-27 17:41:46.701333 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-27 17:41:47.290209 | 
2026-10-27 17:41:47.290356 | PLAY [all]
2026-10-27 17:41:47.299992 | 
2026-10-27 17:41:47.300095 | TASK [fetch-output : Set log path for multiple nodes]
2026-10-27 17:41:47.353995 | controller | skipping: Conditional result was False
2026-10-27 17:41:47.359672 | 
2026-10-27 17:41:47.359779 | TASK [fetch-output : Set log path for single node]
2026-10-27 17:41:47.398670 | controller | ok
2026-10-27 17:41:47.403480 | 
2026-10-27 17:41:47.403562 | LOOP [fetch-output : Ensure local output dirs]
2026-10-27 17:41:47.778610 | controller -> localhost | ok: "/var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/logs"
2026-10-27 17:41:47.990604 | controller -> localhost | changed: "/var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/artifacts"
2026-10-27 17:41:48.224264 | controller -> localhost | changed: "/var/lib/zuul/builds/214ae42e7cb6432da9ec733cab58b309/work/docs"
2026-10-27 17:41:48.240007 | 
2026-10-27 17:41:48.240179 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-10-27 17:41:48.878464 | controller | changed: .d..t...... ./
2026-10-27 17:41:48.878775 | controller | changed: All items complete
2026-10-27 17:41:48.878814 | 
2026-10-27 17:41:49.370153 | controller | changed: .d..t...... ./
2026-10-27 17:41:49.862116 | controller | changed: .d..t...... ./
2026-10-27 17:41:49.888668 | 
2026-10-27 17:41:49.915536 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-10-27 17:41:50.368766 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006065
2026-10-27 17:41:50.566137 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008263
2026-10-27 17:41:50.580914 | 
2026-10-27 17:41:50.581316 | PLAY [all]
2026-10-27 17:41:50.587149 | 
2026-10-27 17:41:50.587229 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-10-27 17:41:51.023732 | controller | changed
2026-10-27 17:41:51.032417 | 
2026-10-27 17:41:51.032608 | PLAY RECAP
2026-10-27 17:41:51.032729 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-10-27 17:41:51.032779 | 
2026-10-27 17:41:51.157296 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-10-27 17:41:51.161843 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-10-27 17:41:51.728843 | 
2026-10-27 17:41:51.769032 | PLAY [localhost]
2026-10-27 17:41:51.783936 | 
2026-10-27 17:41:51.784101 | TASK [Generate Zuul manifest]
2026-10-27 17:41:51.801825 | localhost | ok
2026-10-27 17:41:51.816448 | 
2026-10-27 17:41:51.816657 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-10-27 17:41:52.187280 | localhost | changed
2026-10-27 17:41:52.196930 | 
2026-10-27 17:41:52.197019 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-10-27 17:41:52.222622 | localhost | ok
2026-10-27 17:41:52.228333 | 
2026-10-27 17:41:52.228391 | TASK [Upload logs]
2026-10-27 17:41:52.243122 | localhost | ok
2026-10-27 17:41:52.290892 | 
2026-10-27 17:41:52.290978 | TASK [Set zuul-log-path fact]
2026-10-27 17:41:52.306172 | localhost | ok
2026-10-27 17:41:52.315409 | 
2026-10-27 17:41:52.315472 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-10-27 17:41:52.340696 | localhost | ok
2026-10-27 17:41:52.346941 | 
2026-10-27 17:41:52.347011 | TASK [upload-logs : Create log directories]
2026-10-27 17:41:52.760754 | localhost | changed
2026-10-27 17:41:52.769213 | 
2026-10-27 17:41:52.769346 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-10-27 17:41:53.213425 | localhost -> localhost | ok: Runtime: 0:00:00.005708
2026-10-27 17:41:53.223613 | 
2026-10-27 17:41:53.223771 | TASK [upload-logs : Upload logs to log server]
2026-10-27 17:41:53.809692 | localhost | Output suppressed because no_log was given
2026-10-27 17:41:53.819284 | 
2026-10-27 17:41:53.819432 | LOOP [upload-logs : Compress console log and json output]
2026-10-27 17:41:53.858999 | localhost | skipping: Conditional result was False
2026-10-27 17:41:53.899326 | localhost | skipping: Conditional result was False
2026-10-27 17:41:53.919046 | 
2026-10-27 17:41:53.919338 | LOOP [upload-logs : Upload compressed console log and json output]
2026-10-27 17:41:53.952057 | localhost | skipping: Conditional result was False
2026-10-27 17:41:53.952413 | 
2026-10-27 17:41:53.956157 | localhost | skipping: Conditional result was False
2026-10-27 17:41:53.970523 | 
2026-10-27 17:41:53.970701 | LOOP [upload-logs : Upload console log and json output]