2026-04-22 12:50:44.071921 | Job console starting
2026-04-22 12:50:44.084367 | Updating git repos
2026-04-22 12:50:44.132210 | Cloning repos into workspace
2026-04-22 12:50:54.461428 | Restoring repo states
2026-04-22 12:50:54.476457 | Merging changes
2026-04-22 12:50:55.082472 | Checking out repos
2026-04-22 12:50:56.490992 | Preparing playbooks
2026-04-22 12:51:27.196237 | Running Ansible setup
2026-04-22 12:51:38.113865 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-22 12:51:38.808407 | 
2026-04-22 12:51:39.587341 | PLAY [localhost]
2026-04-22 12:51:39.600881 | 
2026-04-22 12:51:39.601034 | TASK [Gathering Facts]
2026-04-22 12:51:40.762945 | localhost | ok
2026-04-22 12:51:40.784500 | 
2026-04-22 12:51:40.789396 | TASK [Setup log path fact]
2026-04-22 12:51:40.812308 | localhost | ok
2026-04-22 12:51:41.107395 | 
2026-04-22 12:51:41.107764 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-22 12:51:41.139003 | localhost | ok
2026-04-22 12:51:41.149490 | 
2026-04-22 12:51:41.149644 | TASK [emit-job-header : Print job information]
2026-04-22 12:51:41.191878 | # Job Information
2026-04-22 12:51:41.192157 | Ansible Version: 2.16.16
2026-04-22 12:51:41.192230 | Job: ansible-collection-kubernetes-molecule-helm
2026-04-22 12:51:41.192279 | Pipeline: check
2026-04-22 12:51:41.192323 | Executor: 0a8996d2b663
2026-04-22 12:51:41.192366 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/269
2026-04-22 12:51:41.192414 | Event ID: 5229c580-3e49-11f1-911c-59510bc58952
2026-04-22 12:51:41.197542 | 
2026-04-22 12:51:41.197649 | LOOP [emit-job-header : Print node information]
2026-04-22 12:51:41.330368 | localhost | ok:
2026-04-22 12:51:41.330575 | localhost | # Node Information
2026-04-22 12:51:41.330617 | localhost | Inventory Hostname: controller
2026-04-22 12:51:41.330648 | localhost | Hostname: np0000169367
2026-04-22 12:51:41.330677 | localhost | Username: zuul
2026-04-22 12:51:41.330711 | localhost | Distro: Debian 13.4
2026-04-22 12:51:41.330740 | localhost | Provider: yul1
2026-04-22 12:51:41.330770 | localhost | Region: ca-ymq-1
2026-04-22 12:51:41.330797 | localhost | Label: debian-trixie
2026-04-22 12:51:41.330825 | localhost | Product Name: OpenStack Nova
2026-04-22 12:51:41.330852 | localhost | Interface IP: 199.19.213.128
2026-04-22 12:51:41.347715 | 
2026-04-22 12:51:41.347857 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-22 12:51:41.909661 | localhost -> localhost | changed
2026-04-22 12:51:41.915031 | 
2026-04-22 12:51:41.915114 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-22 12:51:42.994331 | localhost -> localhost | changed
2026-04-22 12:51:43.008068 | 
2026-04-22 12:51:43.008175 | PLAY [all]
2026-04-22 12:51:43.018790 | 
2026-04-22 12:51:43.018895 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-22 12:51:44.077865 | controller -> localhost | ok
2026-04-22 12:51:44.395378 | 
2026-04-22 12:51:44.395513 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-22 12:51:44.427477 | controller | ok
2026-04-22 12:51:44.442371 | controller | included: /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-22 12:51:44.447411 | 
2026-04-22 12:51:44.447480 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-22 12:51:47.110310 | controller -> localhost | Generating public/private rsa key pair.
2026-04-22 12:51:47.110542 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/827cab5bc76749b68c1186c1a28f0a04_id_rsa
2026-04-22 12:51:47.110576 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/827cab5bc76749b68c1186c1a28f0a04_id_rsa.pub
2026-04-22 12:51:47.110600 | controller -> localhost | The key fingerprint is:
2026-04-22 12:51:47.110622 | controller -> localhost | SHA256:N8YFX8NqumKFqXI5eBn0FplWLNFDnliFzmZVPMhCL4o zuul-build-sshkey
2026-04-22 12:51:47.110656 | controller -> localhost | The key's randomart image is:
2026-04-22 12:51:47.110679 | controller -> localhost | +---[RSA 3072]----+
2026-04-22 12:51:47.110703 | controller -> localhost | |        .*=+.=+  |
2026-04-22 12:51:47.110726 | controller -> localhost | |        .+B=+.+. |
2026-04-22 12:51:47.110748 | controller -> localhost | |        .B+++. . |
2026-04-22 12:51:47.110770 | controller -> localhost | |      ..=o=oo    |
2026-04-22 12:51:47.110791 | controller -> localhost | |     .EoS*=o     |
2026-04-22 12:51:47.110811 | controller -> localhost | |      . =oo.     |
2026-04-22 12:51:47.110832 | controller -> localhost | |     . * . .     |
2026-04-22 12:51:47.110853 | controller -> localhost | |    o B o .      |
2026-04-22 12:51:47.110876 | controller -> localhost | |     + o .       |
2026-04-22 12:51:47.110897 | controller -> localhost | +----[SHA256]-----+
2026-04-22 12:51:47.110942 | controller -> localhost | ok: Runtime: 0:00:02.040619
2026-04-22 12:51:47.118385 | 
2026-04-22 12:51:47.307075 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-22 12:51:47.330308 | controller | ok
2026-04-22 12:51:47.342219 | controller | included: /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-22 12:51:47.355328 | 
2026-04-22 12:51:47.355489 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-22 12:51:47.381555 | controller | skipping: Conditional result was False
2026-04-22 12:51:47.388781 | 
2026-04-22 12:51:47.388902 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-22 12:51:48.054865 | controller | changed
2026-04-22 12:51:48.059196 | 
2026-04-22 12:51:48.059261 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-22 12:51:48.275345 | controller | ok
2026-04-22 12:51:48.280075 | 
2026-04-22 12:51:48.280197 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-22 12:51:48.809213 | controller | changed
2026-04-22 12:51:48.815185 | 
2026-04-22 12:51:48.815265 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-22 12:51:49.364019 | controller | changed
2026-04-22 12:51:49.370066 | 
2026-04-22 12:51:49.370186 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-22 12:51:49.395649 | controller | skipping: Conditional result was False
2026-04-22 12:51:49.406499 | 
2026-04-22 12:51:49.406643 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-22 12:51:49.819699 | controller -> localhost | changed
2026-04-22 12:51:49.832538 | 
2026-04-22 12:51:49.832696 | TASK [add-build-sshkey : Add back temp key]
2026-04-22 12:51:50.201859 | controller -> localhost | Identity added: /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/827cab5bc76749b68c1186c1a28f0a04_id_rsa (zuul-build-sshkey)
2026-04-22 12:51:50.202121 | controller -> localhost | ok: Runtime: 0:00:00.016412
2026-04-22 12:51:50.207790 | 
2026-04-22 12:51:50.207903 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-22 12:51:50.568035 | controller | ok
2026-04-22 12:51:50.572806 | 
2026-04-22 12:51:50.572890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-22 12:51:50.598531 | controller | skipping: Conditional result was False
2026-04-22 12:51:50.616681 | 
2026-04-22 12:51:50.616862 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-22 12:51:50.994151 | controller | ok
2026-04-22 12:51:51.002716 | 
2026-04-22 12:51:51.002874 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-22 12:51:52.200139 | controller | Output suppressed because no_log was given
2026-04-22 12:51:53.806117 | 
2026-04-22 12:51:53.806513 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-22 12:51:54.029734 | controller | ok: "logs"
2026-04-22 12:51:54.030010 | controller | ok: All items complete
2026-04-22 12:51:54.030050 | 
2026-04-22 12:51:54.226765 | controller | ok: "artifacts"
2026-04-22 12:51:54.423002 | controller | ok: "docs"
2026-04-22 12:51:54.435355 | 
2026-04-22 12:51:54.435557 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-22 12:51:54.662845 | controller | changed: "logs"
2026-04-22 12:51:54.990792 | controller | changed: "artifacts"
2026-04-22 12:51:55.041091 | controller | changed: "docs"
2026-04-22 12:51:55.054277 | 
2026-04-22 12:51:55.054398 | PLAY RECAP
2026-04-22 12:51:55.054463 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-22 12:51:55.054517 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-22 12:51:55.054553 | 
2026-04-22 12:51:55.297995 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-22 12:51:55.307813 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-22 12:51:55.985449 | 
2026-04-22 12:51:55.985604 | PLAY [all]
2026-04-22 12:51:55.999967 | 
2026-04-22 12:51:56.000155 | TASK [setup-uv : Extract archive]
2026-04-22 12:51:58.653778 | controller | changed
2026-04-22 12:51:58.662445 | 
2026-04-22 12:51:58.662605 | TASK [setup-uv : Print version]
2026-04-22 12:51:59.110889 | controller | uv 0.8.13
2026-04-22 12:51:59.194912 | controller | ok: Runtime: 0:00:00.015052
2026-04-22 12:51:59.202469 | 
2026-04-22 12:51:59.202551 | PLAY RECAP
2026-04-22 12:51:59.202613 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-22 12:51:59.202648 | 
2026-04-22 12:51:59.377603 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-22 12:51:59.379043 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-22 12:51:59.964637 | 
2026-04-22 12:51:59.965440 | PLAY [all]
2026-04-22 12:51:59.976071 | 
2026-04-22 12:51:59.976156 | TASK [Update apt cache]
2026-04-22 12:52:05.410086 | controller | ok
2026-04-22 12:52:05.420484 | 
2026-04-22 12:52:05.420720 | TASK [Disable firewalld]
2026-04-22 12:52:05.446937 | controller | skipping: Conditional result was False
2026-04-22 12:52:05.462260 | 
2026-04-22 12:52:05.532617 | TASK [Install "jq" for log collection]
2026-04-22 12:52:08.046989 | controller | changed
2026-04-22 12:52:08.049017 | 
2026-04-22 12:52:08.049075 | PLAY RECAP
2026-04-22 12:52:08.049125 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-22 12:52:08.049147 | 
2026-04-22 12:52:08.158141 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-22 12:52:08.159932 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-22 12:52:08.884085 | 
2026-04-22 12:52:08.884225 | PLAY [all]
2026-04-22 12:52:08.894403 | 
2026-04-22 12:52:08.894479 | TASK [Copy inventory file for Zuul]
2026-04-22 12:52:09.890410 | controller | changed
2026-04-22 12:52:10.102361 | 
2026-04-22 12:52:10.109758 | TASK [Switch "ansible_host" to private IP]
2026-04-22 12:52:10.421693 | controller | changed: 1 replacements made
2026-04-22 12:52:10.475375 | 
2026-04-22 12:52:10.475507 | TASK [Run Molecule scenario]
2026-04-22 12:52:10.958514 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-04-22 12:52:10.958606 | controller | Creating virtual environment at: .venv
2026-04-22 12:52:11.594313 | controller | Downloading cryptography (4.3MiB)
2026-04-22 12:52:11.594676 | controller | Downloading ansible-core (2.3MiB)
2026-04-22 12:52:11.597328 | controller | Downloading pygments (1.2MiB)
2026-04-22 12:52:13.275437 | controller |  Downloading pygments
2026-04-22 12:52:13.461019 | controller |  Downloading ansible-core
2026-04-22 12:52:13.585107 | controller |  Downloading cryptography
2026-04-22 12:52:13.633519 | controller | Installed 36 packages in 47ms
2026-04-22 12:52:14.317524 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-04-22 12:52:14.317620 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-04-22 12:52:15.220483 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-04-22 12:52:15.220557 | controller | INFO     default scenario not found, disabling shared state.
2026-04-22 12:52:15.220647 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-04-22 12:52:15.220723 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-04-22 12:52:34.717986 | controller | INFO     [helm > dependency] Executing
2026-04-22 12:52:34.718200 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-04-22 12:52:34.718477 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-04-22 12:52:34.718643 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-04-22 12:52:34.725168 | controller | INFO     [helm > cleanup] Executing
2026-04-22 12:52:34.725490 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-22 12:52:34.730940 | controller | INFO     [helm > destroy] Executing
2026-04-22 12:52:34.730998 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-04-22 12:52:34.731066 | controller | INFO     [helm > destroy] Executed: Successful
2026-04-22 12:52:34.736518 | controller | INFO     [helm > syntax] Executing
2026-04-22 12:52:35.633769 | controller |
2026-04-22 12:52:35.633813 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-04-22 12:52:35.706644 | controller | INFO     [helm > syntax] Executed: Successful
2026-04-22 12:52:35.715994 | controller | INFO     [helm > create] Executing
2026-04-22 12:52:35.718302 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-22 12:52:35.724172 | controller | INFO     [helm > prepare] Executing
2026-04-22 12:52:36.613088 | controller |
2026-04-22 12:52:36.613109 | controller | PLAY [Prepare] *****************************************************************
2026-04-22 12:52:36.613113 | controller |
2026-04-22 12:52:36.613117 | controller | TASK [Gathering Facts] *********************************************************
2026-04-22 12:52:36.613121 | controller | Wednesday 22 April 2026  12:52:36 +0000 (0:00:00.028)       0:00:00.028 *******
2026-04-22 12:52:37.880594 | 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-04-22 12:52:37.887124 | controller | ok: [controller]
2026-04-22 12:52:37.887306 | controller |
2026-04-22 12:52:37.887525 | controller | TASK [Install Debian packages] *************************************************
2026-04-22 12:52:37.887753 | controller | Wednesday 22 April 2026  12:52:37 +0000 (0:00:01.276)       0:00:01.305 *******
2026-04-22 12:52:39.400821 | controller | ok: [controller]
2026-04-22 12:52:39.401807 | controller |
2026-04-22 12:52:39.401855 | controller | PLAY RECAP *********************************************************************
2026-04-22 12:52:39.401864 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-22 12:52:39.401876 | controller |
2026-04-22 12:52:39.402032 | controller |
2026-04-22 12:52:39.402247 | controller | TASKS RECAP ********************************************************************
2026-04-22 12:52:39.402480 | controller | Wednesday 22 April 2026  12:52:39 +0000 (0:00:01.513)       0:00:02.818 *******
2026-04-22 12:52:39.402804 | controller | ===============================================================================
2026-04-22 12:52:39.403403 | controller | Install Debian packages ------------------------------------------------- 1.51s
2026-04-22 12:52:39.403507 | controller | Gathering Facts --------------------------------------------------------- 1.28s
2026-04-22 12:52:39.506317 | controller | INFO     [helm > prepare] Executed: Successful
2026-04-22 12:52:39.516803 | controller | INFO     [helm > converge] Executing
2026-04-22 12:52:40.431608 | controller |
2026-04-22 12:52:40.431714 | controller | PLAY [Converge] ****************************************************************
2026-04-22 12:52:40.431870 | controller |
2026-04-22 12:52:40.432144 | controller | TASK [Gathering Facts] *********************************************************
2026-04-22 12:52:40.432334 | controller | Wednesday 22 April 2026  12:52:40 +0000 (0:00:00.014)       0:00:00.014 *******
2026-04-22 12:52:42.514908 | 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-04-22 12:52:42.521342 | controller | ok: [controller]
2026-04-22 12:52:42.521378 | controller |
2026-04-22 12:52:42.521387 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-22 12:52:42.521396 | controller | Wednesday 22 April 2026  12:52:42 +0000 (0:00:02.089)       0:00:02.103 *******
2026-04-22 12:52:43.012653 | controller | ok: [controller]
2026-04-22 12:52:43.012976 | controller |
2026-04-22 12:52:43.013301 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-22 12:52:43.013597 | controller | Wednesday 22 April 2026  12:52:43 +0000 (0:00:00.491)       0:00:02.594 *******
2026-04-22 12:52:44.277257 | controller | ok: [controller]
2026-04-22 12:52:44.277456 | controller |
2026-04-22 12:52:44.277873 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-04-22 12:52:44.278061 | controller | Wednesday 22 April 2026  12:52:44 +0000 (0:00:01.255)       0:00:03.850 *******
2026-04-22 12:52:44.701816 | controller | changed: [controller]
2026-04-22 12:52:44.702127 | controller |
2026-04-22 12:52:44.702427 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-22 12:52:44.702712 | controller | Wednesday 22 April 2026  12:52:44 +0000 (0:00:00.434)       0:00:04.284 *******
2026-04-22 12:52:44.753339 | controller | ok: [controller] => {
2026-04-22 12:52:44.753552 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-04-22 12:52:44.753743 | controller | }
2026-04-22 12:52:44.753928 | controller |
2026-04-22 12:52:44.754125 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-22 12:52:44.754307 | controller | Wednesday 22 April 2026  12:52:44 +0000 (0:00:00.051)       0:00:04.336 *******
2026-04-22 12:52:45.794117 | 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-04-22 12:52:45.804440 | controller | changed: [controller]
2026-04-22 12:52:45.804467 | controller |
2026-04-22 12:52:45.804475 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-22 12:52:45.804482 | controller | Wednesday 22 April 2026  12:52:45 +0000 (0:00:01.047)       0:00:05.383 *******
2026-04-22 12:52:47.868799 | controller | changed: [controller]
2026-04-22 12:52:47.869133 | controller |
2026-04-22 12:52:47.869411 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-04-22 12:52:47.869668 | controller | Wednesday 22 April 2026  12:52:47 +0000 (0:00:02.067)       0:00:07.451 *******
2026-04-22 12:52:48.372938 | controller | ok: [controller]
2026-04-22 12:52:48.373297 | controller |
2026-04-22 12:52:48.373583 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-04-22 12:52:48.373895 | controller | Wednesday 22 April 2026  12:52:48 +0000 (0:00:00.504)       0:00:07.955 *******
2026-04-22 12:52:48.785849 | controller | changed: [controller]
2026-04-22 12:52:48.786085 | controller |
2026-04-22 12:52:48.786303 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-04-22 12:52:48.786505 | controller | Wednesday 22 April 2026  12:52:48 +0000 (0:00:00.412)       0:00:08.368 *******
2026-04-22 12:52:49.236577 | controller | ok: [controller]
2026-04-22 12:52:49.236905 | controller |
2026-04-22 12:52:49.237236 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-04-22 12:52:49.237547 | controller | Wednesday 22 April 2026  12:52:49 +0000 (0:00:00.450)       0:00:08.818 *******
2026-04-22 12:52:49.529428 | controller | changed: [controller]
2026-04-22 12:52:49.529534 | controller |
2026-04-22 12:52:49.529678 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-04-22 12:52:49.529892 | controller | Wednesday 22 April 2026  12:52:49 +0000 (0:00:00.293)       0:00:09.112 *******
2026-04-22 12:52:49.826250 | controller | ok: [controller]
2026-04-22 12:52:49.826306 | controller |
2026-04-22 12:52:49.826449 | controller | TASK [Install plugin] **********************************************************
2026-04-22 12:52:49.826626 | controller | Wednesday 22 April 2026  12:52:49 +0000 (0:00:00.294)       0:00:09.406 *******
2026-04-22 12:52:49.880460 | controller | included: vexxhost.containers.download_artifact for controller
2026-04-22 12:52:49.880516 | controller |
2026-04-22 12:52:49.880559 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-22 12:52:49.880684 | controller | Wednesday 22 April 2026  12:52:49 +0000 (0:00:00.056)       0:00:09.463 *******
2026-04-22 12:52:49.927403 | controller | ok: [controller] => {
2026-04-22 12:52:49.927474 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-04-22 12:52:49.927610 | controller | }
2026-04-22 12:52:49.927789 | controller |
2026-04-22 12:52:49.927926 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-22 12:52:49.928070 | controller | Wednesday 22 April 2026  12:52:49 +0000 (0:00:00.046)       0:00:09.510 *******
2026-04-22 12:52:50.653392 | controller | changed: [controller]
2026-04-22 12:52:50.653447 | controller |
2026-04-22 12:52:50.653595 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-22 12:52:50.653765 | controller | Wednesday 22 April 2026  12:52:50 +0000 (0:00:00.725)       0:00:10.236 *******
2026-04-22 12:52:52.737835 | controller | changed: [controller]
2026-04-22 12:52:52.737872 | controller |
2026-04-22 12:52:52.737876 | controller | PLAY RECAP *********************************************************************
2026-04-22 12:52:52.737882 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-22 12:52:52.737885 | controller |
2026-04-22 12:52:52.737889 | controller |
2026-04-22 12:52:52.737892 | controller | TASKS RECAP ********************************************************************
2026-04-22 12:52:52.737895 | controller | Wednesday 22 April 2026  12:52:52 +0000 (0:00:02.082)       0:00:12.319 *******
2026-04-22 12:52:52.737898 | controller | ===============================================================================
2026-04-22 12:52:52.737902 | controller | Gathering Facts --------------------------------------------------------- 2.09s
2026-04-22 12:52:52.737905 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s
2026-04-22 12:52:52.737914 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.07s
2026-04-22 12:52:52.738012 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.26s
2026-04-22 12:52:52.738205 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.05s
2026-04-22 12:52:52.738411 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.73s
2026-04-22 12:52:52.738618 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s
2026-04-22 12:52:52.738815 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-04-22 12:52:52.739006 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s
2026-04-22 12:52:52.739266 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s
2026-04-22 12:52:52.739464 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s
2026-04-22 12:52:52.739674 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s
2026-04-22 12:52:52.739874 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-04-22 12:52:52.740065 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-04-22 12:52:52.740261 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-04-22 12:52:52.740449 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-04-22 12:52:52.852234 | controller | INFO     [helm > converge] Executed: Successful
2026-04-22 12:52:52.862677 | controller | INFO     [helm > idempotence] Executing
2026-04-22 12:52:53.727784 | controller |
2026-04-22 12:52:53.728025 | controller | PLAY [Converge] ****************************************************************
2026-04-22 12:52:53.728186 | controller |
2026-04-22 12:52:53.728427 | controller | TASK [Gathering Facts] *********************************************************
2026-04-22 12:52:53.728620 | controller | Wednesday 22 April 2026  12:52:53 +0000 (0:00:00.012)       0:00:00.012 *******
2026-04-22 12:52:54.769084 | 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-04-22 12:52:54.774209 | controller | ok: [controller]
2026-04-22 12:52:54.774445 | controller |
2026-04-22 12:52:54.774653 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-22 12:52:54.774868 | controller | Wednesday 22 April 2026  12:52:54 +0000 (0:00:01.046)       0:00:01.058 *******
2026-04-22 12:52:55.197307 | controller | ok: [controller]
2026-04-22 12:52:55.197505 | controller |
2026-04-22 12:52:55.197773 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-22 12:52:55.197992 | controller | Wednesday 22 April 2026  12:52:55 +0000 (0:00:00.423)       0:00:01.481 *******
2026-04-22 12:52:56.227700 | controller | ok: [controller]
2026-04-22 12:52:56.227888 | controller |
2026-04-22 12:52:56.228122 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-04-22 12:52:56.228341 | controller | Wednesday 22 April 2026  12:52:56 +0000 (0:00:01.030)       0:00:02.511 *******
2026-04-22 12:52:56.644489 | controller | ok: [controller]
2026-04-22 12:52:56.644548 | controller |
2026-04-22 12:52:56.644713 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-22 12:52:56.644886 | controller | Wednesday 22 April 2026  12:52:56 +0000 (0:00:00.416)       0:00:02.928 *******
2026-04-22 12:52:56.684590 | controller | ok: [controller] => {
2026-04-22 12:52:56.684682 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-04-22 12:52:56.684829 | controller | }
2026-04-22 12:52:56.684925 | controller |
2026-04-22 12:52:56.685060 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-22 12:52:56.685228 | controller | Wednesday 22 April 2026  12:52:56 +0000 (0:00:00.040)       0:00:02.968 *******
2026-04-22 12:52:57.208339 | controller | ok: [controller]
2026-04-22 12:52:57.208648 | controller |
2026-04-22 12:52:57.208930 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-22 12:52:57.209249 | controller | Wednesday 22 April 2026  12:52:57 +0000 (0:00:00.523)       0:00:03.492 *******
2026-04-22 12:52:58.892688 | controller | ok: [controller]
2026-04-22 12:52:58.892712 | controller |
2026-04-22 12:52:58.892718 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-04-22 12:52:58.892722 | controller | Wednesday 22 April 2026  12:52:58 +0000 (0:00:01.682)       0:00:05.175 *******
2026-04-22 12:52:59.381609 | controller | ok: [controller]
2026-04-22 12:52:59.381733 | controller |
2026-04-22 12:52:59.381928 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-04-22 12:52:59.382070 | controller | Wednesday 22 April 2026  12:52:59 +0000 (0:00:00.484)       0:00:05.659 *******
2026-04-22 12:52:59.791570 | controller | ok: [controller]
2026-04-22 12:52:59.791735 | controller |
2026-04-22 12:52:59.791991 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-04-22 12:52:59.792232 | controller | Wednesday 22 April 2026  12:52:59 +0000 (0:00:00.415)       0:00:06.075 *******
2026-04-22 12:53:00.225306 | controller | ok: [controller]
2026-04-22 12:53:00.225344 | controller |
2026-04-22 12:53:00.225353 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-04-22 12:53:00.225362 | controller | Wednesday 22 April 2026  12:53:00 +0000 (0:00:00.433)       0:00:06.508 *******
2026-04-22 12:53:00.518107 | controller | ok: [controller]
2026-04-22 12:53:00.518157 | controller |
2026-04-22 12:53:00.518257 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-04-22 12:53:00.518350 | controller | Wednesday 22 April 2026  12:53:00 +0000 (0:00:00.291)       0:00:06.800 *******
2026-04-22 12:53:00.834082 | controller | ok: [controller]
2026-04-22 12:53:00.834132 | controller |
2026-04-22 12:53:00.834261 | controller | TASK [Install plugin] **********************************************************
2026-04-22 12:53:00.834397 | controller | Wednesday 22 April 2026  12:53:00 +0000 (0:00:00.318)       0:00:07.118 *******
2026-04-22 12:53:00.885404 | controller | included: vexxhost.containers.download_artifact for controller
2026-04-22 12:53:00.885470 | controller |
2026-04-22 12:53:00.885575 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-22 12:53:00.885668 | controller | Wednesday 22 April 2026  12:53:00 +0000 (0:00:00.051)       0:00:07.170 *******
2026-04-22 12:53:00.933238 | controller | ok: [controller] => {
2026-04-22 12:53:00.933391 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-04-22 12:53:00.933406 | controller | }
2026-04-22 12:53:00.933419 | controller |
2026-04-22 12:53:00.933506 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-22 12:53:00.933586 | controller | Wednesday 22 April 2026  12:53:00 +0000 (0:00:00.047)       0:00:07.217 *******
2026-04-22 12:53:01.333784 | controller | ok: [controller]
2026-04-22 12:53:01.333818 | controller |
2026-04-22 12:53:01.334050 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-22 12:53:01.334076 | controller | Wednesday 22 April 2026  12:53:01 +0000 (0:00:00.397)       0:00:07.615 *******
2026-04-22 12:53:02.948431 | controller | ok: [controller]
2026-04-22 12:53:02.948832 | controller |
2026-04-22 12:53:02.949162 | controller | PLAY RECAP *********************************************************************
2026-04-22 12:53:02.949490 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-22 12:53:02.949847 | controller |
2026-04-22 12:53:02.950137 | controller |
2026-04-22 12:53:02.950466 | controller | TASKS RECAP ********************************************************************
2026-04-22 12:53:02.950796 | controller | Wednesday 22 April 2026  12:53:02 +0000 (0:00:01.617)       0:00:09.233 *******
2026-04-22 12:53:02.951072 | controller | ===============================================================================
2026-04-22 12:53:02.951334 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s
2026-04-22 12:53:02.951721 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.62s
2026-04-22 12:53:02.952063 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-04-22 12:53:02.952399 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.03s
2026-04-22 12:53:02.952778 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.52s
2026-04-22 12:53:02.953116 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s
2026-04-22 12:53:02.953492 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.43s
2026-04-22 12:53:02.953900 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s
2026-04-22 12:53:02.954243 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s
2026-04-22 12:53:02.954581 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s
2026-04-22 12:53:02.954909 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.40s
2026-04-22 12:53:02.955237 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s
2026-04-22 12:53:02.955517 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-04-22 12:53:02.955775 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-04-22 12:53:02.956036 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-04-22 12:53:02.956293 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-04-22 12:53:03.057939 | controller | INFO     [helm > idempotence] Executed: Successful
2026-04-22 12:53:03.068120 | controller | INFO     [helm > side_effect] Executing
2026-04-22 12:53:03.068265 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-22 12:53:03.073828 | controller | INFO     [helm > verify] Executing
2026-04-22 12:53:03.979202 | controller |
2026-04-22 12:53:03.981065 | controller | PLAY [Verify] ******************************************************************
2026-04-22 12:53:03.981321 | controller |
2026-04-22 12:53:03.981584 | controller | TASK [Gathering Facts] *********************************************************
2026-04-22 12:53:03.981901 | controller | Wednesday 22 April 2026  12:53:03 +0000 (0:00:00.010)       0:00:00.010 *******
2026-04-22 12:53:05.034162 | 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-04-22 12:53:05.042564 | controller | ok: [controller]
2026-04-22 12:53:05.042837 | controller |
2026-04-22 12:53:05.043110 | controller | TASK [Get the current Helm version] ********************************************
2026-04-22 12:53:05.043389 | controller | Wednesday 22 April 2026  12:53:05 +0000 (0:00:01.063)       0:00:01.073 *******
2026-04-22 12:53:05.495933 | controller | changed: [controller]
2026-04-22 12:53:05.496618 | controller |
2026-04-22 12:53:05.496930 | controller | TASK [Assert Helm version] *****************************************************
2026-04-22 12:53:05.497198 | controller | Wednesday 22 April 2026  12:53:05 +0000 (0:00:00.452)       0:00:01.525 *******
2026-04-22 12:53:05.523677 | controller | ok: [controller] => {
2026-04-22 12:53:05.523961 | controller |     "changed": false,
2026-04-22 12:53:05.524232 | controller |     "msg": "All assertions passed"
2026-04-22 12:53:05.524488 | controller | }
2026-04-22 12:53:05.524733 | controller |
2026-04-22 12:53:05.524993 | controller | PLAY RECAP *********************************************************************
2026-04-22 12:53:05.525279 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-22 12:53:05.525522 | controller |
2026-04-22 12:53:05.525871 | controller |
2026-04-22 12:53:05.526139 | controller | TASKS RECAP ********************************************************************
2026-04-22 12:53:05.526406 | controller | Wednesday 22 April 2026  12:53:05 +0000 (0:00:00.029)       0:00:01.555 *******
2026-04-22 12:53:05.526654 | controller | ===============================================================================
2026-04-22 12:53:05.526908 | controller | Gathering Facts --------------------------------------------------------- 1.06s
2026-04-22 12:53:05.527149 | controller | Get the current Helm version -------------------------------------------- 0.45s
2026-04-22 12:53:05.527390 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-04-22 12:53:05.622262 | controller | INFO     [helm > verify] Executed: Successful
2026-04-22 12:53:05.632450 | controller | INFO     [helm > cleanup] Executing
2026-04-22 12:53:05.632904 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-22 12:53:05.654196 | controller | INFO     [helm > destroy] Executing
2026-04-22 12:53:05.654453 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-04-22 12:53:05.654663 | controller | INFO     [helm > destroy] Executed: Successful
2026-04-22 12:53:05.655254 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-04-22 12:53:06.169561 | controller | ok: Runtime: 0:00:54.881411
2026-04-22 12:53:06.175038 | 
2026-04-22 12:53:06.175092 | PLAY RECAP
2026-04-22 12:53:06.175138 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-22 12:53:06.175160 | 
2026-04-22 12:53:06.302223 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-22 12:53:06.305119 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-22 12:53:06.964506 | 
2026-04-22 12:53:06.964668 | PLAY [all]
2026-04-22 12:53:06.976725 | 
2026-04-22 12:53:06.976826 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-22 12:53:07.383912 | controller | changed
2026-04-22 12:53:07.394781 | 
2026-04-22 12:53:07.394962 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-22 12:53:07.826264 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-22 12:53:07.826610 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-22 12:53:07.831839 | controller | environment: line 1: kubectl: command not found
2026-04-22 12:53:07.833867 | controller | environment: line 1: kubectl: command not found
2026-04-22 12:53:07.833885 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-22 12:53:07.836180 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-22 12:53:07.837637 | controller | environment: line 1: kubectl: command not found
2026-04-22 12:53:07.840476 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-22 12:53:07.840739 | controller | environment: line 1: kubectl: command not found
2026-04-22 12:53:07.841796 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-22 12:53:07.842514 | controller | environment: line 1: kubectl: command not found
2026-04-22 12:53:07.843701 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-22 12:53:07.930069 | controller | ok: Runtime: 0:00:00.031398
2026-04-22 12:53:07.937053 | 
2026-04-22 12:53:07.937157 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-22 12:53:08.172881 | controller | changed
2026-04-22 12:53:08.178434 | 
2026-04-22 12:53:08.178508 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-22 12:53:08.410320 | controller | environment: line 5: kubectl: command not found
2026-04-22 12:53:08.412375 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-22 12:53:08.412640 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-22 12:53:08.412900 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-22 12:53:08.708430 | controller | ok: Runtime: 0:00:00.012518
2026-04-22 12:53:08.716174 | 
2026-04-22 12:53:08.716318 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-22 12:53:09.369390 | controller | changed:
2026-04-22 12:53:09.369636 | controller | created directory /var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/logs/controller
2026-04-22 12:53:09.369690 | controller | cd+++++++++ objects/
2026-04-22 12:53:09.369731 | controller | cd+++++++++ objects/cluster/
2026-04-22 12:53:09.369769 | controller | cd+++++++++ objects/namespaced/
2026-04-22 12:53:09.378810 | 
2026-04-22 12:53:09.378911 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-22 12:53:09.612053 | controller | changed
2026-04-22 12:53:09.617800 | 
2026-04-22 12:53:09.617865 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-22 12:53:09.854652 | controller | changed
2026-04-22 12:53:09.860493 | 
2026-04-22 12:53:09.860592 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-22 12:53:10.098547 | controller | environment: line 3: kubectl: command not found
2026-04-22 12:53:10.390323 | controller | ok: Runtime: 0:00:00.008797
2026-04-22 12:53:10.397460 | 
2026-04-22 12:53:10.397528 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-22 12:53:10.952628 | controller | changed:
2026-04-22 12:53:10.952809 | controller | cd+++++++++ pod-logs/
2026-04-22 12:53:10.952841 | controller | cd+++++++++ pod-logs/failed-pods/
2026-04-22 12:53:10.960092 | 
2026-04-22 12:53:10.960158 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-22 12:53:11.199772 | controller | changed: "values"
2026-04-22 12:53:11.438159 | controller | changed: "releases"
2026-04-22 12:53:11.457420 | 
2026-04-22 12:53:11.457587 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-22 12:53:11.697297 | controller | /bin/bash: line 3: kubectl: command not found
2026-04-22 12:53:11.986608 | controller | ok: Runtime: 0:00:00.009993
2026-04-22 12:53:11.993187 | 
2026-04-22 12:53:11.993276 | TASK [helm-release-status : Downloads logs to executor]
2026-04-22 12:53:12.582394 | controller | changed:
2026-04-22 12:53:12.582624 | controller | cd+++++++++ helm/
2026-04-22 12:53:12.582664 | controller | cd+++++++++ helm/releases/
2026-04-22 12:53:12.582697 | controller | cd+++++++++ helm/values/
2026-04-22 12:53:12.589614 | 
2026-04-22 12:53:12.589717 | PLAY RECAP
2026-04-22 12:53:12.589782 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-22 12:53:12.589814 | 
2026-04-22 12:53:12.726396 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-22 12:53:12.728453 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-22 12:53:13.345960 | 
2026-04-22 12:53:13.346110 | PLAY [all]
2026-04-22 12:53:13.357054 | 
2026-04-22 12:53:13.357141 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-22 12:53:13.402782 | controller | skipping: Conditional result was False
2026-04-22 12:53:13.412646 | 
2026-04-22 12:53:13.412763 | TASK [fetch-output : Set log path for single node]
2026-04-22 12:53:13.456548 | controller | ok
2026-04-22 12:53:13.462002 | 
2026-04-22 12:53:13.462105 | LOOP [fetch-output : Ensure local output dirs]
2026-04-22 12:53:13.872309 | controller -> localhost | ok: "/var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/logs"
2026-04-22 12:53:14.103923 | controller -> localhost | changed: "/var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/artifacts"
2026-04-22 12:53:14.471184 | controller -> localhost | changed: "/var/lib/zuul/builds/827cab5bc76749b68c1186c1a28f0a04/work/docs"
2026-04-22 12:53:14.494471 | 
2026-04-22 12:53:14.494618 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-22 12:53:15.179269 | controller | changed: .d..t...... ./
2026-04-22 12:53:15.179558 | controller | changed: All items complete
2026-04-22 12:53:15.179599 | 
2026-04-22 12:53:15.682742 | controller | changed: .d..t...... ./
2026-04-22 12:53:16.179549 | controller | changed: .d..t...... ./
2026-04-22 12:53:16.204766 | 
2026-04-22 12:53:16.204972 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-22 12:53:16.675601 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009226
2026-04-22 12:53:16.913010 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009641
2026-04-22 12:53:16.932264 | 
2026-04-22 12:53:16.932484 | PLAY [all]
2026-04-22 12:53:16.942380 | 
2026-04-22 12:53:16.942450 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-22 12:53:17.452697 | controller | changed
2026-04-22 12:53:17.460886 | 
2026-04-22 12:53:17.461075 | PLAY RECAP
2026-04-22 12:53:17.461148 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-22 12:53:17.461179 | 
2026-04-22 12:53:17.638016 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-22 12:53:17.640644 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-22 12:53:18.252431 | 
2026-04-22 12:53:18.252804 | PLAY [localhost]
2026-04-22 12:53:18.262767 | 
2026-04-22 12:53:18.262837 | TASK [Generate Zuul manifest]
2026-04-22 12:53:18.284447 | localhost | ok
2026-04-22 12:53:18.300173 | 
2026-04-22 12:53:18.300250 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-22 12:53:18.633275 | localhost | changed
2026-04-22 12:53:18.646591 | 
2026-04-22 12:53:18.646756 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-22 12:53:18.679211 | localhost | ok
2026-04-22 12:53:18.688087 | 
2026-04-22 12:53:18.688189 | TASK [Upload logs]
2026-04-22 12:53:18.710781 | localhost | ok
2026-04-22 12:53:18.779906 | 
2026-04-22 12:53:18.780074 | TASK [Set zuul-log-path fact]
2026-04-22 12:53:18.801567 | localhost | ok
2026-04-22 12:53:18.815755 | 
2026-04-22 12:53:18.815877 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-22 12:53:18.845206 | localhost | ok
2026-04-22 12:53:18.851961 | 
2026-04-22 12:53:18.852031 | TASK [upload-logs : Create log directories]
2026-04-22 12:53:19.248034 | localhost | changed
2026-04-22 12:53:19.253442 | 
2026-04-22 12:53:19.253512 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-22 12:53:20.251848 | localhost -> localhost | ok: Runtime: 0:00:00.006907
2026-04-22 12:53:20.258521 | 
2026-04-22 12:53:20.258617 | TASK [upload-logs : Upload logs to log server]
2026-04-22 12:53:20.729782 | localhost | Output suppressed because no_log was given
2026-04-22 12:53:20.735470 | 
2026-04-22 12:53:20.735571 | LOOP [upload-logs : Compress console log and json output]
2026-04-22 12:53:20.782314 | localhost | skipping: Conditional result was False
2026-04-22 12:53:20.789623 | localhost | skipping: Conditional result was False
2026-04-22 12:53:20.803411 | 
2026-04-22 12:53:20.803609 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-22 12:53:20.847450 | localhost | skipping: Conditional result was False
2026-04-22 12:53:20.847861 | 
2026-04-22 12:53:20.852681 | localhost | skipping: Conditional result was False
2026-04-22 12:53:20.870328 | 
2026-04-22 12:53:20.870538 | LOOP [upload-logs : Upload console log and json output]