2026-03-26 14:45:02.161469 | Job console starting 2026-03-26 14:45:02.171105 | Updating git repos 2026-03-26 14:45:02.274218 | Cloning repos into workspace 2026-03-26 14:45:02.323853 | Restoring repo states 2026-03-26 14:45:02.358220 | Merging changes 2026-03-26 14:45:03.133666 | Checking out repos 2026-03-26 14:45:03.190360 | Preparing playbooks 2026-03-26 14:45:06.522687 | Running Ansible setup 2026-03-26 14:45:10.508586 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 14:45:11.103211 | 2026-03-26 14:45:11.103367 | PLAY [localhost] 2026-03-26 14:45:11.111568 | 2026-03-26 14:45:11.111650 | TASK [Gathering Facts] 2026-03-26 14:45:12.004256 | localhost | ok 2026-03-26 14:45:12.015094 | 2026-03-26 14:45:12.015200 | TASK [Setup log path fact] 2026-03-26 14:45:12.038817 | localhost | ok 2026-03-26 14:45:12.049193 | 2026-03-26 14:45:12.049276 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 14:45:12.077716 | localhost | ok 2026-03-26 14:45:12.084938 | 2026-03-26 14:45:12.085027 | TASK [emit-job-header : Print job information] 2026-03-26 14:45:12.123694 | # Job Information 2026-03-26 14:45:12.123885 | Ansible Version: 2.16.16 2026-03-26 14:45:12.123920 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-26 14:45:12.123942 | Pipeline: check 2026-03-26 14:45:12.123962 | Executor: 0a8996d2b663 2026-03-26 14:45:12.123982 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/247 2026-03-26 14:45:12.124005 | Event ID: 36e96b90-2922-11f1-82f5-672ae468ec59 2026-03-26 14:45:12.127100 | 2026-03-26 14:45:12.127183 | LOOP [emit-job-header : Print node information] 2026-03-26 14:45:12.240218 | localhost | ok: 2026-03-26 14:45:12.240477 | localhost | # Node Information 2026-03-26 14:45:12.240519 | localhost | Inventory Hostname: controller 2026-03-26 14:45:12.240551 | localhost | Hostname: np0000161079 2026-03-26 14:45:12.240580 | localhost | Username: zuul 2026-03-26 14:45:12.240612 | localhost | Distro: Debian 13.4 2026-03-26 14:45:12.240641 | localhost | Provider: yul1 2026-03-26 14:45:12.240668 | localhost | Region: ca-ymq-1 2026-03-26 14:45:12.240696 | localhost | Label: debian-trixie 2026-03-26 14:45:12.240724 | localhost | Product Name: OpenStack Nova 2026-03-26 14:45:12.240751 | localhost | Interface IP: 199.204.45.3 2026-03-26 14:45:12.259936 | 2026-03-26 14:45:12.260097 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-26 14:45:12.675034 | localhost -> localhost | changed 2026-03-26 14:45:12.684245 | 2026-03-26 14:45:12.684349 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-26 14:45:13.632679 | localhost -> localhost | changed 2026-03-26 14:45:13.642263 | 2026-03-26 14:45:13.642391 | PLAY [all] 2026-03-26 14:45:13.649723 | 2026-03-26 14:45:13.649829 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-26 14:45:13.872319 | controller -> localhost | ok 2026-03-26 14:45:13.892217 | 2026-03-26 14:45:13.892434 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-26 14:45:13.928244 | controller | ok 2026-03-26 14:45:13.946503 | controller | included: /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-26 14:45:13.952645 | 2026-03-26 14:45:13.952738 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-26 14:45:14.863344 | controller -> localhost | Generating public/private rsa key pair. 2026-03-26 14:45:14.863519 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/8d8ce801d9d444b68e370161bc004560_id_rsa 2026-03-26 14:45:14.863551 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/8d8ce801d9d444b68e370161bc004560_id_rsa.pub 2026-03-26 14:45:14.863609 | controller -> localhost | The key fingerprint is: 2026-03-26 14:45:14.863676 | controller -> localhost | SHA256:Kq6LUuhszAZVqZzCcJ/cLSYWds3uXqBmMvGA3sOXRtM zuul-build-sshkey 2026-03-26 14:45:14.863741 | controller -> localhost | The key's randomart image is: 2026-03-26 14:45:14.863800 | controller -> localhost | +---[RSA 3072]----+ 2026-03-26 14:45:14.863877 | controller -> localhost | | . o | 2026-03-26 14:45:14.863946 | controller -> localhost | |. . = . o | 2026-03-26 14:45:14.864004 | controller -> localhost | |oo O = + | 2026-03-26 14:45:14.864059 | controller -> localhost | |..* O * E | 2026-03-26 14:45:14.864113 | controller -> localhost | | = + B *S. | 2026-03-26 14:45:14.864168 | controller -> localhost | |o o * O.. . | 2026-03-26 14:45:14.864237 | controller -> localhost | |*. .O.. . | 2026-03-26 14:45:14.864298 | controller -> localhost | |.O . . . | 2026-03-26 14:45:14.864355 | controller -> localhost | |= oo. | 2026-03-26 14:45:14.864402 | controller -> localhost | +----[SHA256]-----+ 2026-03-26 14:45:14.864494 | controller -> localhost | ok: Runtime: 0:00:00.338246 2026-03-26 14:45:14.870956 | 2026-03-26 14:45:14.871017 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-26 14:45:14.902311 | controller | ok 2026-03-26 14:45:14.912936 | controller | included: /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-26 14:45:14.921385 | 2026-03-26 14:45:14.921445 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-26 14:45:14.946812 | controller | skipping: Conditional result was False 2026-03-26 14:45:14.955107 | 2026-03-26 14:45:14.955213 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-26 14:45:15.545375 | controller | changed 2026-03-26 14:45:15.550822 | 2026-03-26 14:45:15.550929 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-26 14:45:15.772861 | controller | ok 2026-03-26 14:45:15.778304 | 2026-03-26 14:45:15.778390 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-26 14:45:16.339479 | controller | changed 2026-03-26 14:45:16.348505 | 2026-03-26 14:45:16.348571 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-26 14:45:16.912007 | controller | changed 2026-03-26 14:45:16.919960 | 2026-03-26 14:45:16.920055 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-26 14:45:16.944606 | controller | skipping: Conditional result was False 2026-03-26 14:45:16.952374 | 2026-03-26 14:45:16.952484 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-26 14:45:17.368486 | controller -> localhost | changed 2026-03-26 14:45:17.379520 | 2026-03-26 14:45:17.379629 | TASK [add-build-sshkey : Add back temp key] 2026-03-26 14:45:17.668802 | controller -> localhost | Identity added: /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/8d8ce801d9d444b68e370161bc004560_id_rsa (zuul-build-sshkey) 2026-03-26 14:45:17.669048 | controller -> localhost | ok: Runtime: 0:00:00.018706 2026-03-26 14:45:17.674793 | 2026-03-26 14:45:17.674856 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-26 14:45:18.032228 | controller | ok 2026-03-26 14:45:18.036665 | 2026-03-26 14:45:18.036731 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-26 14:45:18.063805 | controller | skipping: Conditional result was False 2026-03-26 14:45:18.076357 | 2026-03-26 14:45:18.076483 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-26 14:45:18.470529 | controller | ok 2026-03-26 14:45:18.481717 | 2026-03-26 14:45:18.481819 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-26 14:45:19.568173 | controller | Output suppressed because no_log was given 2026-03-26 14:45:19.576898 | 2026-03-26 14:45:19.576981 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-26 14:45:19.812751 | controller | ok: "logs" 2026-03-26 14:45:20.091069 | controller | ok: All items complete 2026-03-26 14:45:20.091244 | 2026-03-26 14:45:20.100413 | controller | ok: "artifacts" 2026-03-26 14:45:20.213761 | controller | ok: "docs" 2026-03-26 14:45:20.228391 | 2026-03-26 14:45:20.228526 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-26 14:45:20.455807 | controller | changed: "logs" 2026-03-26 14:45:20.657909 | controller | changed: "artifacts" 2026-03-26 14:45:20.832529 | controller | changed: "docs" 2026-03-26 14:45:20.852742 | 2026-03-26 14:45:20.853309 | PLAY RECAP 2026-03-26 14:45:20.853393 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-26 14:45:20.853438 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 14:45:20.853471 | 2026-03-26 14:45:20.985025 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 14:45:20.986323 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 14:45:21.548056 | 2026-03-26 14:45:21.548181 | PLAY [all] 2026-03-26 14:45:21.558773 | 2026-03-26 14:45:21.558857 | TASK [setup-uv : Extract archive] 2026-03-26 14:45:24.914743 | controller | changed 2026-03-26 14:45:24.922099 | 2026-03-26 14:45:24.922187 | TASK [setup-uv : Print version] 2026-03-26 14:45:25.179946 | controller | uv 0.8.13 2026-03-26 14:45:25.443888 | controller | ok: Runtime: 0:00:00.014199 2026-03-26 14:45:25.451670 | 2026-03-26 14:45:25.451807 | PLAY RECAP 2026-03-26 14:45:25.451879 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 14:45:25.451916 | 2026-03-26 14:45:25.628479 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 14:45:25.630753 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-26 14:45:26.202666 | 2026-03-26 14:45:26.528003 | PLAY [all] 2026-03-26 14:45:26.547768 | 2026-03-26 14:45:26.547928 | TASK [Update apt cache] 2026-03-26 14:45:31.796770 | controller | ok 2026-03-26 14:45:31.802900 | 2026-03-26 14:45:31.803000 | TASK [Disable firewalld] 2026-03-26 14:45:31.827811 | controller | skipping: Conditional result was False 2026-03-26 14:45:31.836612 | 2026-03-26 14:45:31.836718 | TASK [Install "jq" for log collection] 2026-03-26 14:45:34.498346 | controller | changed 2026-03-26 14:45:34.913205 | 2026-03-26 14:45:34.913961 | PLAY RECAP 2026-03-26 14:45:34.914116 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-26 14:45:34.914202 | 2026-03-26 14:45:35.043034 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-26 14:45:35.045652 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 14:45:38.765294 | 2026-03-26 14:45:38.894096 | PLAY [all] 2026-03-26 14:45:38.909686 | 2026-03-26 14:45:38.909768 | TASK [Copy inventory file for Zuul] 2026-03-26 14:45:40.997221 | controller | changed 2026-03-26 14:45:41.003781 | 2026-03-26 14:45:41.003852 | TASK [Switch "ansible_host" to private IP] 2026-03-26 14:45:41.329186 | controller | changed: 1 replacements made 2026-03-26 14:45:41.334986 | 2026-03-26 14:45:41.335069 | TASK [Run Molecule scenario] 2026-03-26 14:45:41.738421 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-26 14:45:41.738556 | controller | Creating virtual environment at: .venv 2026-03-26 14:45:42.000870 | controller | Downloading pygments (1.2MiB) 2026-03-26 14:45:42.006622 | controller | Downloading ansible-core (2.3MiB) 2026-03-26 14:45:42.007777 | controller | Downloading cryptography (4.3MiB) 2026-03-26 14:45:42.188432 | controller | Downloading cryptography 2026-03-26 14:45:42.240943 | controller | Downloading pygments 2026-03-26 14:45:42.445218 | controller | Downloading ansible-core 2026-03-26 14:45:42.492755 | controller | Installed 36 packages in 46ms 2026-03-26 14:45:43.218071 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-26 14:45:43.218139 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-26 14:45:44.146983 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-26 14:45:44.147042 | controller | INFO default scenario not found, disabling shared state. 2026-03-26 14:45:44.147135 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-26 14:45:44.147210 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-26 14:46:04.705194 | controller | INFO [helm > dependency] Executing 2026-03-26 14:46:04.705464 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-26 14:46:04.705803 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-26 14:46:04.705997 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-26 14:46:04.734123 | controller | INFO [helm > cleanup] Executing 2026-03-26 14:46:04.734960 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 14:46:04.745675 | controller | INFO [helm > destroy] Executing 2026-03-26 14:46:04.745773 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-26 14:46:04.745936 | controller | INFO [helm > destroy] Executed: Successful 2026-03-26 14:46:04.753473 | controller | INFO [helm > syntax] Executing 2026-03-26 14:46:05.702797 | controller | 2026-03-26 14:46:05.702881 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-26 14:46:05.767970 | controller | INFO [helm > syntax] Executed: Successful 2026-03-26 14:46:05.775710 | controller | INFO [helm > create] Executing 2026-03-26 14:46:05.777967 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 14:46:05.784126 | controller | INFO [helm > prepare] Executing 2026-03-26 14:46:06.770045 | controller | 2026-03-26 14:46:06.770213 | controller | PLAY [Prepare] ***************************************************************** 2026-03-26 14:46:06.770427 | controller | 2026-03-26 14:46:06.770651 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-26 14:46:06.770870 | controller | Thursday 26 March 2026 14:46:06 +0000 (0:00:00.030) 0:00:00.030 ******** 2026-03-26 14:46:09.057501 | 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-03-26 14:46:09.063867 | controller | ok: [controller] 2026-03-26 14:46:09.064101 | controller | 2026-03-26 14:46:09.064345 | controller | TASK [Install Debian packages] ************************************************* 2026-03-26 14:46:09.064596 | controller | Thursday 26 March 2026 14:46:09 +0000 (0:00:02.294) 0:00:02.324 ******** 2026-03-26 14:46:10.637641 | controller | ok: [controller] 2026-03-26 14:46:10.637820 | controller | 2026-03-26 14:46:10.638029 | controller | PLAY RECAP ********************************************************************* 2026-03-26 14:46:10.638254 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-26 14:46:10.638417 | controller | 2026-03-26 14:46:10.638586 | controller | 2026-03-26 14:46:10.638775 | controller | TASKS RECAP ******************************************************************** 2026-03-26 14:46:10.638966 | controller | Thursday 26 March 2026 14:46:10 +0000 (0:00:01.574) 0:00:03.899 ******** 2026-03-26 14:46:10.639141 | controller | =============================================================================== 2026-03-26 14:46:10.639325 | controller | Gathering Facts --------------------------------------------------------- 2.29s 2026-03-26 14:46:10.639506 | controller | Install Debian packages ------------------------------------------------- 1.57s 2026-03-26 14:46:10.748175 | controller | INFO [helm > prepare] Executed: Successful 2026-03-26 14:46:10.757836 | controller | INFO [helm > converge] Executing 2026-03-26 14:46:11.682228 | controller | 2026-03-26 14:46:11.682301 | controller | PLAY [Converge] **************************************************************** 2026-03-26 14:46:11.682461 | controller | 2026-03-26 14:46:11.682714 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-26 14:46:11.682859 | controller | Thursday 26 March 2026 14:46:11 +0000 (0:00:00.014) 0:00:00.014 ******** 2026-03-26 14:46:12.865608 | 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-03-26 14:46:12.871391 | controller | ok: [controller] 2026-03-26 14:46:12.871481 | controller | 2026-03-26 14:46:12.871596 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-26 14:46:12.871704 | controller | Thursday 26 March 2026 14:46:12 +0000 (0:00:01.189) 0:00:01.203 ******** 2026-03-26 14:46:13.403974 | controller | ok: [controller] 2026-03-26 14:46:13.404040 | controller | 2026-03-26 14:46:13.404260 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-26 14:46:13.404460 | controller | Thursday 26 March 2026 14:46:13 +0000 (0:00:00.531) 0:00:01.735 ******** 2026-03-26 14:46:14.644032 | controller | ok: [controller] 2026-03-26 14:46:14.644098 | controller | 2026-03-26 14:46:14.644335 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-26 14:46:14.644556 | controller | Thursday 26 March 2026 14:46:14 +0000 (0:00:01.239) 0:00:02.975 ******** 2026-03-26 14:46:15.092268 | controller | changed: [controller] 2026-03-26 14:46:15.092406 | controller | 2026-03-26 14:46:15.092714 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-26 14:46:15.092919 | controller | Thursday 26 March 2026 14:46:15 +0000 (0:00:00.448) 0:00:03.423 ******** 2026-03-26 14:46:15.148261 | controller | ok: [controller] => { 2026-03-26 14:46:15.148419 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-26 14:46:15.148659 | controller | } 2026-03-26 14:46:15.148844 | controller | 2026-03-26 14:46:15.149049 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-26 14:46:15.149401 | controller | Thursday 26 March 2026 14:46:15 +0000 (0:00:00.055) 0:00:03.479 ******** 2026-03-26 14:46:15.959964 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-26 14:46:15.967461 | controller | changed: [controller] 2026-03-26 14:46:15.967678 | controller | 2026-03-26 14:46:15.967908 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-26 14:46:15.968107 | controller | Thursday 26 March 2026 14:46:15 +0000 (0:00:00.819) 0:00:04.299 ******** 2026-03-26 14:46:18.095951 | controller | changed: [controller] 2026-03-26 14:46:18.095997 | controller | 2026-03-26 14:46:18.096118 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-26 14:46:18.096242 | controller | Thursday 26 March 2026 14:46:18 +0000 (0:00:02.128) 0:00:06.427 ******** 2026-03-26 14:46:18.714594 | controller | ok: [controller] 2026-03-26 14:46:18.714705 | controller | 2026-03-26 14:46:18.714926 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-26 14:46:18.715157 | controller | Thursday 26 March 2026 14:46:18 +0000 (0:00:00.618) 0:00:07.046 ******** 2026-03-26 14:46:19.121382 | controller | changed: [controller] 2026-03-26 14:46:19.121503 | controller | 2026-03-26 14:46:19.121724 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-26 14:46:19.121917 | controller | Thursday 26 March 2026 14:46:19 +0000 (0:00:00.406) 0:00:07.453 ******** 2026-03-26 14:46:19.562466 | controller | ok: [controller] 2026-03-26 14:46:19.562532 | controller | 2026-03-26 14:46:19.562591 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-26 14:46:19.562678 | controller | Thursday 26 March 2026 14:46:19 +0000 (0:00:00.441) 0:00:07.894 ******** 2026-03-26 14:46:19.889357 | controller | changed: [controller] 2026-03-26 14:46:19.889466 | controller | 2026-03-26 14:46:19.889689 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-26 14:46:19.889884 | controller | Thursday 26 March 2026 14:46:19 +0000 (0:00:00.326) 0:00:08.220 ******** 2026-03-26 14:46:20.198149 | controller | ok: [controller] 2026-03-26 14:46:20.198194 | controller | 2026-03-26 14:46:20.198204 | controller | TASK [Install plugin] ********************************************************** 2026-03-26 14:46:20.198212 | controller | Thursday 26 March 2026 14:46:20 +0000 (0:00:00.308) 0:00:08.528 ******** 2026-03-26 14:46:20.261138 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-26 14:46:20.261216 | controller | 2026-03-26 14:46:20.261227 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-26 14:46:20.261356 | controller | Thursday 26 March 2026 14:46:20 +0000 (0:00:00.062) 0:00:08.591 ******** 2026-03-26 14:46:20.317241 | controller | ok: [controller] => { 2026-03-26 14:46:20.317348 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-26 14:46:20.317502 | controller | } 2026-03-26 14:46:20.317615 | controller | 2026-03-26 14:46:20.317759 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-26 14:46:20.317920 | controller | Thursday 26 March 2026 14:46:20 +0000 (0:00:00.054) 0:00:08.645 ******** 2026-03-26 14:46:21.329732 | controller | changed: [controller] 2026-03-26 14:46:21.329776 | controller | 2026-03-26 14:46:21.329860 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-26 14:46:21.329946 | controller | Thursday 26 March 2026 14:46:21 +0000 (0:00:01.015) 0:00:09.661 ******** 2026-03-26 14:46:23.471913 | controller | changed: [controller] 2026-03-26 14:46:23.471963 | controller | 2026-03-26 14:46:23.472043 | controller | PLAY RECAP ********************************************************************* 2026-03-26 14:46:23.472136 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-26 14:46:23.472225 | controller | 2026-03-26 14:46:23.472282 | controller | 2026-03-26 14:46:23.472687 | controller | TASKS RECAP ******************************************************************** 2026-03-26 14:46:23.472747 | controller | Thursday 26 March 2026 14:46:23 +0000 (0:00:02.143) 0:00:11.804 ******** 2026-03-26 14:46:23.472756 | controller | =============================================================================== 2026-03-26 14:46:23.472764 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.14s 2026-03-26 14:46:23.472781 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.13s 2026-03-26 14:46:23.472824 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.24s 2026-03-26 14:46:23.473918 | controller | Gathering Facts --------------------------------------------------------- 1.19s 2026-03-26 14:46:23.473934 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.02s 2026-03-26 14:46:23.473939 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-03-26 14:46:23.473942 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.62s 2026-03-26 14:46:23.473945 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.53s 2026-03-26 14:46:23.473949 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-26 14:46:23.473952 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-03-26 14:46:23.473963 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-26 14:46:23.473966 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-03-26 14:46:23.473969 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-03-26 14:46:23.473972 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-26 14:46:23.473976 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-26 14:46:23.473979 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-26 14:46:23.587870 | controller | INFO [helm > converge] Executed: Successful 2026-03-26 14:46:23.598854 | controller | INFO [helm > idempotence] Executing 2026-03-26 14:46:24.449181 | controller | 2026-03-26 14:46:24.449503 | controller | PLAY [Converge] **************************************************************** 2026-03-26 14:46:24.449665 | controller | 2026-03-26 14:46:24.449836 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-26 14:46:24.450005 | controller | Thursday 26 March 2026 14:46:24 +0000 (0:00:00.014) 0:00:00.014 ******** 2026-03-26 14:46:25.524652 | 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-03-26 14:46:25.531108 | controller | ok: [controller] 2026-03-26 14:46:25.531269 | controller | 2026-03-26 14:46:25.531437 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-26 14:46:25.531597 | controller | Thursday 26 March 2026 14:46:25 +0000 (0:00:01.082) 0:00:01.096 ******** 2026-03-26 14:46:26.016127 | controller | ok: [controller] 2026-03-26 14:46:26.016454 | controller | 2026-03-26 14:46:26.016875 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-26 14:46:26.017149 | controller | Thursday 26 March 2026 14:46:26 +0000 (0:00:00.484) 0:00:01.581 ******** 2026-03-26 14:46:27.337110 | controller | ok: [controller] 2026-03-26 14:46:27.337299 | controller | 2026-03-26 14:46:27.337451 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-26 14:46:27.337589 | controller | Thursday 26 March 2026 14:46:27 +0000 (0:00:01.320) 0:00:02.902 ******** 2026-03-26 14:46:27.814857 | controller | ok: [controller] 2026-03-26 14:46:27.815514 | controller | 2026-03-26 14:46:27.815838 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-26 14:46:27.816543 | controller | Thursday 26 March 2026 14:46:27 +0000 (0:00:00.477) 0:00:03.379 ******** 2026-03-26 14:46:27.866794 | controller | ok: [controller] => { 2026-03-26 14:46:27.866837 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-26 14:46:27.866843 | controller | } 2026-03-26 14:46:27.866849 | controller | 2026-03-26 14:46:27.866854 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-26 14:46:27.866859 | controller | Thursday 26 March 2026 14:46:27 +0000 (0:00:00.051) 0:00:03.430 ******** 2026-03-26 14:46:28.443850 | controller | ok: [controller] 2026-03-26 14:46:28.444068 | controller | 2026-03-26 14:46:28.444239 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-26 14:46:28.444405 | controller | Thursday 26 March 2026 14:46:28 +0000 (0:00:00.577) 0:00:04.008 ******** 2026-03-26 14:46:30.244292 | controller | ok: [controller] 2026-03-26 14:46:30.244349 | controller | 2026-03-26 14:46:30.244361 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-26 14:46:30.244468 | controller | Thursday 26 March 2026 14:46:30 +0000 (0:00:01.797) 0:00:05.805 ******** 2026-03-26 14:46:30.821243 | controller | ok: [controller] 2026-03-26 14:46:30.821348 | controller | 2026-03-26 14:46:30.821512 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-26 14:46:30.821646 | controller | Thursday 26 March 2026 14:46:30 +0000 (0:00:00.578) 0:00:06.384 ******** 2026-03-26 14:46:31.226747 | controller | ok: [controller] 2026-03-26 14:46:31.226797 | controller | 2026-03-26 14:46:31.226870 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-26 14:46:31.226959 | controller | Thursday 26 March 2026 14:46:31 +0000 (0:00:00.407) 0:00:06.792 ******** 2026-03-26 14:46:31.683159 | controller | ok: [controller] 2026-03-26 14:46:31.683184 | controller | 2026-03-26 14:46:31.683188 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-26 14:46:31.683192 | controller | Thursday 26 March 2026 14:46:31 +0000 (0:00:00.450) 0:00:07.243 ******** 2026-03-26 14:46:31.983843 | controller | ok: [controller] 2026-03-26 14:46:31.983875 | controller | 2026-03-26 14:46:31.983882 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-26 14:46:31.983888 | controller | Thursday 26 March 2026 14:46:31 +0000 (0:00:00.305) 0:00:07.548 ******** 2026-03-26 14:46:32.301822 | controller | ok: [controller] 2026-03-26 14:46:32.301964 | controller | 2026-03-26 14:46:32.302087 | controller | TASK [Install plugin] ********************************************************** 2026-03-26 14:46:32.302204 | controller | Thursday 26 March 2026 14:46:32 +0000 (0:00:00.318) 0:00:07.866 ******** 2026-03-26 14:46:32.356663 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-26 14:46:32.356691 | controller | 2026-03-26 14:46:32.356695 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-26 14:46:32.356699 | controller | Thursday 26 March 2026 14:46:32 +0000 (0:00:00.055) 0:00:07.921 ******** 2026-03-26 14:46:32.406864 | controller | ok: [controller] => { 2026-03-26 14:46:32.406950 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-26 14:46:32.407067 | controller | } 2026-03-26 14:46:32.407206 | controller | 2026-03-26 14:46:32.407279 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-26 14:46:32.407405 | controller | Thursday 26 March 2026 14:46:32 +0000 (0:00:00.050) 0:00:07.971 ******** 2026-03-26 14:46:32.840151 | controller | ok: [controller] 2026-03-26 14:46:32.840238 | controller | 2026-03-26 14:46:32.840503 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-26 14:46:32.840517 | controller | Thursday 26 March 2026 14:46:32 +0000 (0:00:00.433) 0:00:08.405 ******** 2026-03-26 14:46:34.581134 | controller | ok: [controller] 2026-03-26 14:46:34.581224 | controller | 2026-03-26 14:46:34.581234 | controller | PLAY RECAP ********************************************************************* 2026-03-26 14:46:34.581283 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-26 14:46:34.581379 | controller | 2026-03-26 14:46:34.581464 | controller | 2026-03-26 14:46:34.581546 | controller | TASKS RECAP ******************************************************************** 2026-03-26 14:46:34.581648 | controller | Thursday 26 March 2026 14:46:34 +0000 (0:00:01.738) 0:00:10.143 ******** 2026-03-26 14:46:34.581724 | controller | =============================================================================== 2026-03-26 14:46:34.581812 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.80s 2026-03-26 14:46:34.581901 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.74s 2026-03-26 14:46:34.581989 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.32s 2026-03-26 14:46:34.582076 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-03-26 14:46:34.582165 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.58s 2026-03-26 14:46:34.582258 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.58s 2026-03-26 14:46:34.582352 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.48s 2026-03-26 14:46:34.582443 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.48s 2026-03-26 14:46:34.582535 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-26 14:46:34.582620 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-03-26 14:46:34.582710 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-26 14:46:34.582806 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-26 14:46:34.582900 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-26 14:46:34.582987 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-26 14:46:34.583075 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-26 14:46:34.583170 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-26 14:46:34.700796 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-26 14:46:34.708617 | controller | INFO [helm > side_effect] Executing 2026-03-26 14:46:34.708637 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 14:46:34.711647 | controller | INFO [helm > verify] Executing 2026-03-26 14:46:35.606411 | controller | 2026-03-26 14:46:35.606759 | controller | PLAY [Verify] ****************************************************************** 2026-03-26 14:46:35.607051 | controller | 2026-03-26 14:46:35.607328 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-26 14:46:35.607601 | controller | Thursday 26 March 2026 14:46:35 +0000 (0:00:00.013) 0:00:00.013 ******** 2026-03-26 14:46:37.790716 | 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-03-26 14:46:37.796837 | controller | ok: [controller] 2026-03-26 14:46:37.797028 | controller | 2026-03-26 14:46:37.797218 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-26 14:46:37.797404 | controller | Thursday 26 March 2026 14:46:37 +0000 (0:00:02.190) 0:00:02.203 ******** 2026-03-26 14:46:38.264659 | controller | changed: [controller] 2026-03-26 14:46:38.264959 | controller | 2026-03-26 14:46:38.265228 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-26 14:46:38.265499 | controller | Thursday 26 March 2026 14:46:38 +0000 (0:00:00.467) 0:00:02.671 ******** 2026-03-26 14:46:38.299177 | controller | ok: [controller] => { 2026-03-26 14:46:38.299518 | controller | "changed": false, 2026-03-26 14:46:38.299787 | controller | "msg": "All assertions passed" 2026-03-26 14:46:38.300032 | controller | } 2026-03-26 14:46:38.300262 | controller | 2026-03-26 14:46:38.300509 | controller | PLAY RECAP ********************************************************************* 2026-03-26 14:46:38.300823 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-26 14:46:38.301054 | controller | 2026-03-26 14:46:38.301274 | controller | 2026-03-26 14:46:38.301530 | controller | TASKS RECAP ******************************************************************** 2026-03-26 14:46:38.301794 | controller | Thursday 26 March 2026 14:46:38 +0000 (0:00:00.035) 0:00:02.706 ******** 2026-03-26 14:46:38.302027 | controller | =============================================================================== 2026-03-26 14:46:38.302269 | controller | Gathering Facts --------------------------------------------------------- 2.19s 2026-03-26 14:46:38.302510 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-03-26 14:46:38.302749 | controller | Assert Helm version ----------------------------------------------------- 0.04s 2026-03-26 14:46:38.437280 | controller | INFO [helm > verify] Executed: Successful 2026-03-26 14:46:38.446411 | controller | INFO [helm > cleanup] Executing 2026-03-26 14:46:38.446878 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 14:46:38.453791 | controller | INFO [helm > destroy] Executing 2026-03-26 14:46:38.453891 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-26 14:46:38.453976 | controller | INFO [helm > destroy] Executed: Successful 2026-03-26 14:46:38.454287 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-26 14:46:38.881849 | controller | ok: Runtime: 0:00:56.869225 2026-03-26 14:46:38.888894 | 2026-03-26 14:46:38.889022 | PLAY RECAP 2026-03-26 14:46:38.889098 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 14:46:38.889132 | 2026-03-26 14:46:39.039820 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 14:46:39.041366 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-26 14:46:39.602471 | 2026-03-26 14:46:39.602611 | PLAY [all] 2026-03-26 14:46:39.613549 | 2026-03-26 14:46:39.613630 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-26 14:46:40.012690 | controller | changed 2026-03-26 14:46:40.018773 | 2026-03-26 14:46:40.018894 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-26 14:46:40.423178 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 14:46:40.423968 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 14:46:40.431760 | controller | environment: line 1: kubectl: command not found 2026-03-26 14:46:40.432950 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 14:46:40.436677 | controller | environment: line 1: kubectl: command not found 2026-03-26 14:46:40.438504 | controller | environment: line 1: kubectl: command not found 2026-03-26 14:46:40.438863 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 14:46:40.439908 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 14:46:40.442851 | controller | environment: line 1: kubectl: command not found 2026-03-26 14:46:40.443829 | controller | environment: line 1: kubectl: command not found 2026-03-26 14:46:40.444105 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 14:46:40.445530 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 14:46:40.549046 | controller | ok: Runtime: 0:00:00.035612 2026-03-26 14:46:40.556166 | 2026-03-26 14:46:40.556316 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-26 14:46:40.821162 | controller | changed 2026-03-26 14:46:40.826872 | 2026-03-26 14:46:40.826945 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-26 14:46:41.084817 | controller | environment: line 5: kubectl: command not found 2026-03-26 14:46:41.086228 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 14:46:41.087178 | 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-03-26 14:46:41.087193 | controller | 2026-03-26 14:46:41.354706 | controller | ok: Runtime: 0:00:00.012170 2026-03-26 14:46:41.361612 | 2026-03-26 14:46:41.361680 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-26 14:46:42.016012 | controller | changed: 2026-03-26 14:46:42.016361 | controller | created directory /var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/logs/controller 2026-03-26 14:46:42.016521 | controller | cd+++++++++ objects/ 2026-03-26 14:46:42.016578 | controller | cd+++++++++ objects/cluster/ 2026-03-26 14:46:42.016629 | controller | cd+++++++++ objects/namespaced/ 2026-03-26 14:46:42.024489 | 2026-03-26 14:46:42.024556 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-26 14:46:42.281174 | controller | changed 2026-03-26 14:46:42.286226 | 2026-03-26 14:46:42.286290 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-26 14:46:42.529670 | controller | changed 2026-03-26 14:46:42.533665 | 2026-03-26 14:46:42.533762 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-26 14:46:42.781149 | controller | environment: line 3: kubectl: command not found 2026-03-26 14:46:43.064453 | controller | ok: Runtime: 0:00:00.012527 2026-03-26 14:46:43.070489 | 2026-03-26 14:46:43.070592 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-26 14:46:43.618854 | controller | changed: 2026-03-26 14:46:43.619009 | controller | cd+++++++++ pod-logs/ 2026-03-26 14:46:43.619038 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-26 14:46:43.628478 | 2026-03-26 14:46:43.628545 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-26 14:46:43.867377 | controller | changed: "values" 2026-03-26 14:46:44.064289 | controller | changed: "releases" 2026-03-26 14:46:44.078645 | 2026-03-26 14:46:44.078804 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-26 14:46:44.308959 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-26 14:46:44.611078 | controller | ok: Runtime: 0:00:00.009198 2026-03-26 14:46:44.615048 | 2026-03-26 14:46:44.615109 | TASK [helm-release-status : Downloads logs to executor] 2026-03-26 14:46:45.134811 | controller | changed: 2026-03-26 14:46:45.134999 | controller | cd+++++++++ helm/ 2026-03-26 14:46:45.135037 | controller | cd+++++++++ helm/releases/ 2026-03-26 14:46:45.135068 | controller | cd+++++++++ helm/values/ 2026-03-26 14:46:45.141005 | 2026-03-26 14:46:45.141122 | PLAY RECAP 2026-03-26 14:46:45.141189 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 14:46:45.141219 | 2026-03-26 14:46:45.242468 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-26 14:46:45.245242 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 14:46:45.837015 | 2026-03-26 14:46:45.837186 | PLAY [all] 2026-03-26 14:46:45.847602 | 2026-03-26 14:46:45.847683 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-26 14:46:45.893064 | controller | skipping: Conditional result was False 2026-03-26 14:46:45.901700 | 2026-03-26 14:46:45.901817 | TASK [fetch-output : Set log path for single node] 2026-03-26 14:46:45.943997 | controller | ok 2026-03-26 14:46:45.949316 | 2026-03-26 14:46:45.949440 | LOOP [fetch-output : Ensure local output dirs] 2026-03-26 14:46:46.330627 | controller -> localhost | ok: "/var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/logs" 2026-03-26 14:46:46.553803 | controller -> localhost | changed: "/var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/artifacts" 2026-03-26 14:46:46.800313 | controller -> localhost | changed: "/var/lib/zuul/builds/8d8ce801d9d444b68e370161bc004560/work/docs" 2026-03-26 14:46:46.815301 | 2026-03-26 14:46:46.815478 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-26 14:46:47.483221 | controller | changed: .d..t...... ./ 2026-03-26 14:46:47.483620 | controller | changed: All items complete 2026-03-26 14:46:47.483683 | 2026-03-26 14:46:47.994982 | controller | changed: .d..t...... ./ 2026-03-26 14:46:48.494033 | controller | changed: .d..t...... ./ 2026-03-26 14:46:48.514388 | 2026-03-26 14:46:48.514556 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-26 14:46:48.965755 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008850 2026-03-26 14:46:49.193197 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007289 2026-03-26 14:46:49.213062 | 2026-03-26 14:46:49.213219 | PLAY [all] 2026-03-26 14:46:49.219114 | 2026-03-26 14:46:49.219183 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-26 14:46:49.657048 | controller | changed 2026-03-26 14:46:49.663427 | 2026-03-26 14:46:49.663505 | PLAY RECAP 2026-03-26 14:46:49.663567 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-26 14:46:49.663599 | 2026-03-26 14:46:49.783463 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 14:46:49.784817 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-26 14:46:50.328918 | 2026-03-26 14:46:50.329067 | PLAY [localhost] 2026-03-26 14:46:50.338878 | 2026-03-26 14:46:50.338978 | TASK [Generate Zuul manifest] 2026-03-26 14:46:50.360101 | localhost | ok 2026-03-26 14:46:50.377170 | 2026-03-26 14:46:50.377253 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-26 14:46:50.704200 | localhost | changed 2026-03-26 14:46:50.714086 | 2026-03-26 14:46:50.714183 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-26 14:46:50.746167 | localhost | ok 2026-03-26 14:46:50.754432 | 2026-03-26 14:46:50.754498 | TASK [Upload logs] 2026-03-26 14:46:50.774138 | localhost | ok 2026-03-26 14:46:50.836392 | 2026-03-26 14:46:50.836536 | TASK [Set zuul-log-path fact] 2026-03-26 14:46:50.858332 | localhost | ok 2026-03-26 14:46:50.871292 | 2026-03-26 14:46:50.871364 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 14:46:50.903442 | localhost | ok 2026-03-26 14:46:50.911981 | 2026-03-26 14:46:50.912052 | TASK [upload-logs : Create log directories] 2026-03-26 14:46:51.330737 | localhost | changed 2026-03-26 14:46:51.337086 | 2026-03-26 14:46:51.337225 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-26 14:46:51.763680 | localhost -> localhost | ok: Runtime: 0:00:00.006302 2026-03-26 14:46:51.770827 | 2026-03-26 14:46:51.770940 | TASK [upload-logs : Upload logs to log server] 2026-03-26 14:46:52.218810 | localhost | Output suppressed because no_log was given 2026-03-26 14:46:52.225662 | 2026-03-26 14:46:52.225792 | LOOP [upload-logs : Compress console log and json output] 2026-03-26 14:46:52.276745 | localhost | skipping: Conditional result was False 2026-03-26 14:46:52.283573 | localhost | skipping: Conditional result was False 2026-03-26 14:46:52.302618 | 2026-03-26 14:46:52.302808 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-26 14:46:52.345940 | localhost | skipping: Conditional result was False 2026-03-26 14:46:52.346421 | 2026-03-26 14:46:52.349682 | localhost | skipping: Conditional result was False 2026-03-26 14:46:52.366610 | 2026-03-26 14:46:52.366788 | LOOP [upload-logs : Upload console log and json output]