2026-05-13 00:59:32.970694 | Job console starting
2026-05-13 00:59:32.981418 | Updating git repos
2026-05-13 00:59:33.015687 | Cloning repos into workspace
2026-05-13 00:59:33.051819 | Restoring repo states
2026-05-13 00:59:33.065171 | Merging changes
2026-05-13 00:59:33.652727 | Checking out repos
2026-05-13 00:59:33.923236 | Preparing playbooks
2026-05-13 00:59:37.103114 | Running Ansible setup
2026-05-13 00:59:41.827487 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-13 00:59:42.471275 | 
2026-05-13 00:59:42.471438 | PLAY [localhost]
2026-05-13 00:59:42.479688 | 
2026-05-13 00:59:42.479771 | TASK [Gathering Facts]
2026-05-13 00:59:43.376900 | localhost | ok
2026-05-13 00:59:43.386657 | 
2026-05-13 00:59:43.386732 | TASK [Setup log path fact]
2026-05-13 00:59:43.418334 | localhost | ok
2026-05-13 00:59:43.430605 | 
2026-05-13 00:59:43.430669 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-13 00:59:43.457993 | localhost | ok
2026-05-13 00:59:43.465976 | 
2026-05-13 00:59:43.466066 | TASK [emit-job-header : Print job information]
2026-05-13 00:59:43.506675 | # Job Information
2026-05-13 00:59:43.506829 | Ansible Version: 2.16.18
2026-05-13 00:59:43.506876 | Job: ansible-collection-kubernetes-molecule-helm
2026-05-13 00:59:43.506908 | Pipeline: check
2026-05-13 00:59:43.506939 | Executor: 2d72f0692154
2026-05-13 00:59:43.506969 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/273
2026-05-13 00:59:43.507002 | Event ID: e09751c0-4e66-11f1-86a7-4ae871bac6c7
2026-05-13 00:59:43.510896 | 
2026-05-13 00:59:43.510979 | LOOP [emit-job-header : Print node information]
2026-05-13 00:59:43.597909 | localhost | ok:
2026-05-13 00:59:43.598234 | localhost | # Node Information
2026-05-13 00:59:43.598290 | localhost | Inventory Hostname: controller
2026-05-13 00:59:43.598330 | localhost | Hostname: np0000173855
2026-05-13 00:59:43.598365 | localhost | Username: zuul
2026-05-13 00:59:43.598406 | localhost | Distro: Debian 13.4
2026-05-13 00:59:43.598440 | localhost | Provider: yul1
2026-05-13 00:59:43.598474 | localhost | Region: ca-ymq-1
2026-05-13 00:59:43.598507 | localhost | Label: debian-trixie
2026-05-13 00:59:43.598540 | localhost | Product Name: OpenStack Nova
2026-05-13 00:59:43.598572 | localhost | Interface IP: 199.204.45.113
2026-05-13 00:59:43.609333 | 
2026-05-13 00:59:43.609519 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-13 00:59:44.036849 | localhost -> localhost | changed
2026-05-13 00:59:44.042249 | 
2026-05-13 00:59:44.042362 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-13 00:59:44.943443 | localhost -> localhost | changed
2026-05-13 00:59:44.950012 | 
2026-05-13 00:59:44.950083 | PLAY [all]
2026-05-13 00:59:44.956807 | 
2026-05-13 00:59:44.956872 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-13 00:59:45.204556 | controller -> localhost | ok
2026-05-13 00:59:45.212901 | 
2026-05-13 00:59:45.213076 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-13 00:59:45.243179 | controller | ok
2026-05-13 00:59:45.271086 | controller | included: /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-13 00:59:45.277088 | 
2026-05-13 00:59:45.277203 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-13 00:59:46.364478 | controller -> localhost | Generating public/private rsa key pair.
2026-05-13 00:59:46.364661 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/5aa0166c5d4b46fe8f383a1b753dd09e_id_rsa
2026-05-13 00:59:46.364702 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/5aa0166c5d4b46fe8f383a1b753dd09e_id_rsa.pub
2026-05-13 00:59:46.364735 | controller -> localhost | The key fingerprint is:
2026-05-13 00:59:46.364765 | controller -> localhost | SHA256:VLa0i8dAL9oQc8wWQWu0g9/SfCbVUSRwZM0tl9DyP5k zuul-build-sshkey
2026-05-13 00:59:46.364805 | controller -> localhost | The key's randomart image is:
2026-05-13 00:59:46.364835 | controller -> localhost | +---[RSA 3072]----+
2026-05-13 00:59:46.364874 | controller -> localhost | |      o+Bo+ .+O==|
2026-05-13 00:59:46.364904 | controller -> localhost | |       B+B o =.==|
2026-05-13 00:59:46.364933 | controller -> localhost | |      o.O + . +o |
2026-05-13 00:59:46.364984 | controller -> localhost | |       B X o   . |
2026-05-13 00:59:46.365015 | controller -> localhost | |      . S O o   +|
2026-05-13 00:59:46.365042 | controller -> localhost | |         o +   E.|
2026-05-13 00:59:46.365069 | controller -> localhost | |                .|
2026-05-13 00:59:46.365095 | controller -> localhost | |                 |
2026-05-13 00:59:46.365126 | controller -> localhost | |                 |
2026-05-13 00:59:46.365154 | controller -> localhost | +----[SHA256]-----+
2026-05-13 00:59:46.365217 | controller -> localhost | ok: Runtime: 0:00:00.569578
2026-05-13 00:59:46.370799 | 
2026-05-13 00:59:46.370880 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-13 00:59:46.402790 | controller | ok
2026-05-13 00:59:46.412639 | controller | included: /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-13 00:59:46.419311 | 
2026-05-13 00:59:46.419372 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-13 00:59:46.444734 | controller | skipping: Conditional result was False
2026-05-13 00:59:46.452089 | 
2026-05-13 00:59:46.452172 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-13 00:59:46.939313 | controller | changed
2026-05-13 00:59:46.944431 | 
2026-05-13 00:59:46.944496 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-13 00:59:47.156942 | controller | ok
2026-05-13 00:59:47.161123 | 
2026-05-13 00:59:47.161187 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-13 00:59:47.705045 | controller | changed
2026-05-13 00:59:47.747184 | 
2026-05-13 00:59:47.747353 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-13 00:59:48.281930 | controller | changed
2026-05-13 00:59:48.287245 | 
2026-05-13 00:59:48.287314 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-13 00:59:48.312710 | controller | skipping: Conditional result was False
2026-05-13 00:59:48.323564 | 
2026-05-13 00:59:48.323658 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-13 00:59:48.740540 | controller -> localhost | changed
2026-05-13 00:59:48.756403 | 
2026-05-13 00:59:48.756493 | TASK [add-build-sshkey : Add back temp key]
2026-05-13 00:59:49.029006 | controller -> localhost | Identity added: /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/5aa0166c5d4b46fe8f383a1b753dd09e_id_rsa (zuul-build-sshkey)
2026-05-13 00:59:49.029192 | controller -> localhost | ok: Runtime: 0:00:00.013881
2026-05-13 00:59:49.033131 | 
2026-05-13 00:59:49.033190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-13 00:59:49.378803 | controller | ok
2026-05-13 00:59:49.384189 | 
2026-05-13 00:59:49.384278 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-13 00:59:49.410801 | controller | skipping: Conditional result was False
2026-05-13 00:59:49.422649 | 
2026-05-13 00:59:49.422782 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-13 00:59:49.770777 | controller | ok
2026-05-13 00:59:49.777502 | 
2026-05-13 00:59:49.777603 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-13 00:59:50.786179 | controller | Output suppressed because no_log was given
2026-05-13 00:59:50.795548 | 
2026-05-13 00:59:50.795633 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-13 00:59:51.018162 | controller | ok: "logs"
2026-05-13 00:59:51.018561 | controller | ok: All items complete
2026-05-13 00:59:51.018610 | 
2026-05-13 00:59:51.202737 | controller | ok: "artifacts"
2026-05-13 00:59:51.395758 | controller | ok: "docs"
2026-05-13 00:59:51.408666 | 
2026-05-13 00:59:51.408934 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-13 00:59:51.616127 | controller | changed: "logs"
2026-05-13 00:59:51.799379 | controller | changed: "artifacts"
2026-05-13 00:59:51.974514 | controller | changed: "docs"
2026-05-13 00:59:51.994443 | 
2026-05-13 00:59:51.994570 | PLAY RECAP
2026-05-13 00:59:51.994625 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-13 00:59:51.994654 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-13 00:59:51.994677 | 
2026-05-13 00:59:52.153243 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-13 00:59:52.155814 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-13 00:59:52.768652 | 
2026-05-13 00:59:52.769068 | PLAY [all]
2026-05-13 00:59:52.780008 | 
2026-05-13 00:59:52.780092 | TASK [setup-uv : Extract archive]
2026-05-13 00:59:55.196945 | controller | changed
2026-05-13 00:59:55.202848 | 
2026-05-13 00:59:55.203067 | TASK [setup-uv : Print version]
2026-05-13 00:59:55.597558 | controller | uv 0.8.13
2026-05-13 00:59:55.741390 | controller | ok: Runtime: 0:00:00.009767
2026-05-13 00:59:55.748338 | 
2026-05-13 00:59:55.748388 | PLAY RECAP
2026-05-13 00:59:55.748435 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-13 00:59:55.748459 | 
2026-05-13 00:59:55.885735 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-13 00:59:55.888452 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-13 00:59:56.487162 | 
2026-05-13 00:59:56.487596 | PLAY [all]
2026-05-13 00:59:56.501459 | 
2026-05-13 00:59:56.501563 | TASK [Update apt cache]
2026-05-13 01:00:01.412745 | controller | ok
2026-05-13 01:00:01.417710 | 
2026-05-13 01:00:01.417794 | TASK [Disable firewalld]
2026-05-13 01:00:01.443735 | controller | skipping: Conditional result was False
2026-05-13 01:00:01.451476 | 
2026-05-13 01:00:01.451567 | TASK [Install "jq" for log collection]
2026-05-13 01:00:03.792503 | controller | changed
2026-05-13 01:00:03.794255 | 
2026-05-13 01:00:03.794304 | PLAY RECAP
2026-05-13 01:00:03.794347 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-13 01:00:03.794369 | 
2026-05-13 01:00:03.944807 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-13 01:00:03.947785 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-13 01:00:04.612315 | 
2026-05-13 01:00:04.612480 | PLAY [all]
2026-05-13 01:00:04.626352 | 
2026-05-13 01:00:04.626487 | TASK [Copy inventory file for Zuul]
2026-05-13 01:00:05.633091 | controller | changed
2026-05-13 01:00:05.640897 | 
2026-05-13 01:00:05.641034 | TASK [Switch "ansible_host" to private IP]
2026-05-13 01:00:05.973856 | controller | changed: 1 replacements made
2026-05-13 01:00:05.978720 | 
2026-05-13 01:00:05.978796 | TASK [Run Molecule scenario]
2026-05-13 01:00:06.412965 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-05-13 01:00:06.413125 | controller | Creating virtual environment at: .venv
2026-05-13 01:00:07.753956 | controller | Downloading pygments (1.2MiB)
2026-05-13 01:00:07.756564 | controller | Downloading cryptography (4.3MiB)
2026-05-13 01:00:07.757673 | controller | Downloading ansible-core (2.3MiB)
2026-05-13 01:00:08.240832 | controller |  Downloading pygments
2026-05-13 01:00:08.412080 | controller |  Downloading cryptography
2026-05-13 01:00:08.443219 | controller |  Downloading ansible-core
2026-05-13 01:00:08.497283 | controller | Installed 36 packages in 53ms
2026-05-13 01:00:09.159632 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-05-13 01:00:09.159747 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-13 01:00:09.976859 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-05-13 01:00:09.976938 | controller | INFO     default scenario not found, disabling shared state.
2026-05-13 01:00:09.976962 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-13 01:00:09.977080 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-05-13 01:01:26.574572 | controller | INFO     [helm > dependency] Executing
2026-05-13 01:01:26.574678 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-05-13 01:01:26.574689 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-05-13 01:01:26.574718 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-05-13 01:01:26.579976 | controller | INFO     [helm > cleanup] Executing
2026-05-13 01:01:26.580251 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-13 01:01:26.585528 | controller | INFO     [helm > destroy] Executing
2026-05-13 01:01:26.585553 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-05-13 01:01:26.585568 | controller | INFO     [helm > destroy] Executed: Successful
2026-05-13 01:01:26.590856 | controller | INFO     [helm > syntax] Executing
2026-05-13 01:01:27.472024 | controller |
2026-05-13 01:01:27.472229 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-05-13 01:01:27.529665 | controller | INFO     [helm > syntax] Executed: Successful
2026-05-13 01:01:27.540422 | controller | INFO     [helm > create] Executing
2026-05-13 01:01:27.541870 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-13 01:01:27.547142 | controller | INFO     [helm > prepare] Executing
2026-05-13 01:01:28.368985 | controller |
2026-05-13 01:01:28.369054 | controller | PLAY [Prepare] *****************************************************************
2026-05-13 01:01:28.369188 | controller |
2026-05-13 01:01:28.369309 | controller | TASK [Gathering Facts] *********************************************************
2026-05-13 01:01:28.369435 | controller | Wednesday 13 May 2026  01:01:28 +0000 (0:00:00.028)       0:00:00.028 *********
2026-05-13 01:01:30.618343 | 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-05-13 01:01:30.626728 | controller | ok: [controller]
2026-05-13 01:01:30.626981 | controller |
2026-05-13 01:01:30.627252 | controller | TASK [Install Debian packages] *************************************************
2026-05-13 01:01:30.627505 | controller | Wednesday 13 May 2026  01:01:30 +0000 (0:00:02.258)       0:00:02.286 *********
2026-05-13 01:01:32.075871 | controller | ok: [controller]
2026-05-13 01:01:32.076022 | controller |
2026-05-13 01:01:32.076259 | controller | PLAY RECAP *********************************************************************
2026-05-13 01:01:32.076498 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-13 01:01:32.076658 | controller |
2026-05-13 01:01:32.076883 | controller |
2026-05-13 01:01:32.077123 | controller | TASKS RECAP ********************************************************************
2026-05-13 01:01:32.077397 | controller | Wednesday 13 May 2026  01:01:32 +0000 (0:00:01.449)       0:00:03.735 *********
2026-05-13 01:01:32.077528 | controller | ===============================================================================
2026-05-13 01:01:32.077735 | controller | Gathering Facts --------------------------------------------------------- 2.26s
2026-05-13 01:01:32.077940 | controller | Install Debian packages ------------------------------------------------- 1.45s
2026-05-13 01:01:32.174344 | controller | INFO     [helm > prepare] Executed: Successful
2026-05-13 01:01:32.183877 | controller | INFO     [helm > converge] Executing
2026-05-13 01:01:33.039905 | controller |
2026-05-13 01:01:33.039941 | controller | PLAY [Converge] ****************************************************************
2026-05-13 01:01:33.039946 | controller |
2026-05-13 01:01:33.039950 | controller | TASK [Gathering Facts] *********************************************************
2026-05-13 01:01:33.039954 | controller | Wednesday 13 May 2026  01:01:33 +0000 (0:00:00.013)       0:00:00.013 *********
2026-05-13 01:01:34.097342 | 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-05-13 01:01:34.104101 | controller | ok: [controller]
2026-05-13 01:01:34.104290 | controller |
2026-05-13 01:01:34.104503 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-13 01:01:34.104706 | controller | Wednesday 13 May 2026  01:01:34 +0000 (0:00:01.066)       0:00:01.080 *********
2026-05-13 01:01:34.596452 | controller | ok: [controller]
2026-05-13 01:01:34.596522 | controller |
2026-05-13 01:01:34.596704 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-13 01:01:34.596951 | controller | Wednesday 13 May 2026  01:01:34 +0000 (0:00:00.492)       0:00:01.572 *********
2026-05-13 01:01:35.659562 | controller | ok: [controller]
2026-05-13 01:01:35.659650 | controller |
2026-05-13 01:01:35.659854 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-13 01:01:35.660051 | controller | Wednesday 13 May 2026  01:01:35 +0000 (0:00:01.062)       0:00:02.635 *********
2026-05-13 01:01:36.088714 | controller | changed: [controller]
2026-05-13 01:01:36.088827 | controller |
2026-05-13 01:01:36.088838 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-13 01:01:36.088910 | controller | Wednesday 13 May 2026  01:01:36 +0000 (0:00:00.429)       0:00:03.065 *********
2026-05-13 01:01:36.136805 | controller | ok: [controller] => {
2026-05-13 01:01:36.136911 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-05-13 01:01:36.137095 | controller | }
2026-05-13 01:01:36.137265 | controller |
2026-05-13 01:01:36.137491 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-13 01:01:36.137694 | controller | Wednesday 13 May 2026  01:01:36 +0000 (0:00:00.047)       0:00:03.112 *********
2026-05-13 01:01:36.915111 | 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-05-13 01:01:36.923907 | controller | changed: [controller]
2026-05-13 01:01:36.924085 | controller |
2026-05-13 01:01:36.924286 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-13 01:01:36.924479 | controller | Wednesday 13 May 2026  01:01:36 +0000 (0:00:00.787)       0:00:03.900 *********
2026-05-13 01:01:39.001324 | controller | changed: [controller]
2026-05-13 01:01:39.001375 | controller |
2026-05-13 01:01:39.002961 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-05-13 01:01:39.002974 | controller | Wednesday 13 May 2026  01:01:38 +0000 (0:00:02.074)       0:00:05.974 *********
2026-05-13 01:01:39.511710 | controller | ok: [controller]
2026-05-13 01:01:39.511833 | controller |
2026-05-13 01:01:39.512033 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-05-13 01:01:39.512221 | controller | Wednesday 13 May 2026  01:01:39 +0000 (0:00:00.513)       0:00:06.488 *********
2026-05-13 01:01:39.904802 | controller | changed: [controller]
2026-05-13 01:01:39.904943 | controller |
2026-05-13 01:01:39.905193 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-05-13 01:01:39.905343 | controller | Wednesday 13 May 2026  01:01:39 +0000 (0:00:00.392)       0:00:06.880 *********
2026-05-13 01:01:40.354064 | controller | ok: [controller]
2026-05-13 01:01:40.354128 | controller |
2026-05-13 01:01:40.354189 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-05-13 01:01:40.354276 | controller | Wednesday 13 May 2026  01:01:40 +0000 (0:00:00.449)       0:00:07.330 *********
2026-05-13 01:01:40.640543 | controller | changed: [controller]
2026-05-13 01:01:40.640629 | controller |
2026-05-13 01:01:40.640866 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-05-13 01:01:40.640997 | controller | Wednesday 13 May 2026  01:01:40 +0000 (0:00:00.286)       0:00:07.616 *********
2026-05-13 01:01:40.946007 | controller | ok: [controller]
2026-05-13 01:01:40.946136 | controller |
2026-05-13 01:01:40.946338 | controller | TASK [Install plugin] **********************************************************
2026-05-13 01:01:40.946539 | controller | Wednesday 13 May 2026  01:01:40 +0000 (0:00:00.305)       0:00:07.922 *********
2026-05-13 01:01:40.999548 | controller | included: vexxhost.containers.download_artifact for controller
2026-05-13 01:01:40.999713 | controller |
2026-05-13 01:01:40.999916 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-13 01:01:41.000127 | controller | Wednesday 13 May 2026  01:01:40 +0000 (0:00:00.053)       0:00:07.976 *********
2026-05-13 01:01:41.052068 | controller | ok: [controller] => {
2026-05-13 01:01:41.052334 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-05-13 01:01:41.052525 | controller | }
2026-05-13 01:01:41.052708 | controller |
2026-05-13 01:01:41.052946 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-13 01:01:41.053145 | controller | Wednesday 13 May 2026  01:01:41 +0000 (0:00:00.051)       0:00:08.028 *********
2026-05-13 01:01:41.891723 | controller | changed: [controller]
2026-05-13 01:01:41.891766 | controller |
2026-05-13 01:01:41.891775 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-13 01:01:41.891784 | controller | Wednesday 13 May 2026  01:01:41 +0000 (0:00:00.839)       0:00:08.867 *********
2026-05-13 01:01:43.904471 | controller | changed: [controller]
2026-05-13 01:01:43.904502 | controller |
2026-05-13 01:01:43.904508 | controller | PLAY RECAP *********************************************************************
2026-05-13 01:01:43.904515 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-13 01:01:43.904520 | controller |
2026-05-13 01:01:43.904525 | controller |
2026-05-13 01:01:43.904529 | controller | TASKS RECAP ********************************************************************
2026-05-13 01:01:43.904534 | controller | Wednesday 13 May 2026  01:01:43 +0000 (0:00:02.010)       0:00:10.877 *********
2026-05-13 01:01:43.904538 | controller | ===============================================================================
2026-05-13 01:01:43.904543 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.07s
2026-05-13 01:01:43.904547 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.01s
2026-05-13 01:01:43.904552 | controller | Gathering Facts --------------------------------------------------------- 1.07s
2026-05-13 01:01:43.904556 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.06s
2026-05-13 01:01:43.904561 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.84s
2026-05-13 01:01:43.904565 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.79s
2026-05-13 01:01:43.904569 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s
2026-05-13 01:01:43.904574 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-05-13 01:01:43.904578 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s
2026-05-13 01:01:43.904583 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s
2026-05-13 01:01:43.904598 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.39s
2026-05-13 01:01:43.904603 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s
2026-05-13 01:01:43.904607 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s
2026-05-13 01:01:43.904612 | controller | Install plugin ---------------------------------------------------------- 0.05s
2026-05-13 01:01:43.904616 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-05-13 01:01:43.904621 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-05-13 01:01:44.012935 | controller | INFO     [helm > converge] Executed: Successful
2026-05-13 01:01:44.023246 | controller | INFO     [helm > idempotence] Executing
2026-05-13 01:01:44.847788 | controller |
2026-05-13 01:01:44.848104 | controller | PLAY [Converge] ****************************************************************
2026-05-13 01:01:44.848392 | controller |
2026-05-13 01:01:44.848658 | controller | TASK [Gathering Facts] *********************************************************
2026-05-13 01:01:44.848973 | controller | Wednesday 13 May 2026  01:01:44 +0000 (0:00:00.012)       0:00:00.012 *********
2026-05-13 01:01:45.895097 | 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-05-13 01:01:45.898996 | controller | ok: [controller]
2026-05-13 01:01:45.899260 | controller |
2026-05-13 01:01:45.899521 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-13 01:01:45.899770 | controller | Wednesday 13 May 2026  01:01:45 +0000 (0:00:01.051)       0:00:01.064 *********
2026-05-13 01:01:46.318015 | controller | ok: [controller]
2026-05-13 01:01:46.318306 | controller |
2026-05-13 01:01:46.318578 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-13 01:01:46.318834 | controller | Wednesday 13 May 2026  01:01:46 +0000 (0:00:00.418)       0:00:01.482 *********
2026-05-13 01:01:47.431867 | controller | ok: [controller]
2026-05-13 01:01:47.432155 | controller |
2026-05-13 01:01:47.432420 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-13 01:01:47.432672 | controller | Wednesday 13 May 2026  01:01:47 +0000 (0:00:01.113)       0:00:02.596 *********
2026-05-13 01:01:47.850386 | controller | ok: [controller]
2026-05-13 01:01:47.850660 | controller |
2026-05-13 01:01:47.850921 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-13 01:01:47.851169 | controller | Wednesday 13 May 2026  01:01:47 +0000 (0:00:00.418)       0:00:03.015 *********
2026-05-13 01:01:47.893117 | controller | ok: [controller] => {
2026-05-13 01:01:47.893406 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-05-13 01:01:47.893660 | controller | }
2026-05-13 01:01:47.893903 | controller |
2026-05-13 01:01:47.894177 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-13 01:01:47.894429 | controller | Wednesday 13 May 2026  01:01:47 +0000 (0:00:00.042)       0:00:03.057 *********
2026-05-13 01:01:48.425413 | controller | ok: [controller]
2026-05-13 01:01:48.425705 | controller |
2026-05-13 01:01:48.425987 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-13 01:01:48.426255 | controller | Wednesday 13 May 2026  01:01:48 +0000 (0:00:00.532)       0:00:03.589 *********
2026-05-13 01:01:50.077190 | controller | ok: [controller]
2026-05-13 01:01:50.077366 | controller |
2026-05-13 01:01:50.077531 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-05-13 01:01:50.077690 | controller | Wednesday 13 May 2026  01:01:50 +0000 (0:00:01.650)       0:00:05.240 *********
2026-05-13 01:01:50.565005 | controller | ok: [controller]
2026-05-13 01:01:50.565047 | controller |
2026-05-13 01:01:50.565173 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-05-13 01:01:50.565294 | controller | Wednesday 13 May 2026  01:01:50 +0000 (0:00:00.488)       0:00:05.729 *********
2026-05-13 01:01:50.956320 | controller | ok: [controller]
2026-05-13 01:01:50.956398 | controller |
2026-05-13 01:01:50.956529 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-05-13 01:01:50.956650 | controller | Wednesday 13 May 2026  01:01:50 +0000 (0:00:00.391)       0:00:06.121 *********
2026-05-13 01:01:51.401440 | controller | ok: [controller]
2026-05-13 01:01:51.401464 | controller |
2026-05-13 01:01:51.401468 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-05-13 01:01:51.401472 | controller | Wednesday 13 May 2026  01:01:51 +0000 (0:00:00.441)       0:00:06.563 *********
2026-05-13 01:01:51.680096 | controller | ok: [controller]
2026-05-13 01:01:51.680172 | controller |
2026-05-13 01:01:51.680316 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-05-13 01:01:51.680438 | controller | Wednesday 13 May 2026  01:01:51 +0000 (0:00:00.281)       0:00:06.844 *********
2026-05-13 01:01:51.977512 | controller | ok: [controller]
2026-05-13 01:01:51.977565 | controller |
2026-05-13 01:01:51.978543 | controller | TASK [Install plugin] **********************************************************
2026-05-13 01:01:51.978806 | controller | Wednesday 13 May 2026  01:01:51 +0000 (0:00:00.295)       0:00:07.140 *********
2026-05-13 01:01:52.035912 | controller | included: vexxhost.containers.download_artifact for controller
2026-05-13 01:01:52.035969 | controller |
2026-05-13 01:01:52.036077 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-13 01:01:52.036161 | controller | Wednesday 13 May 2026  01:01:52 +0000 (0:00:00.060)       0:00:07.201 *********
2026-05-13 01:01:52.089794 | controller | ok: [controller] => {
2026-05-13 01:01:52.089836 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-05-13 01:01:52.089842 | controller | }
2026-05-13 01:01:52.089848 | controller |
2026-05-13 01:01:52.089853 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-13 01:01:52.089858 | controller | Wednesday 13 May 2026  01:01:52 +0000 (0:00:00.049)       0:00:07.250 *********
2026-05-13 01:01:52.531863 | controller | ok: [controller]
2026-05-13 01:01:52.531944 | controller |
2026-05-13 01:01:52.532053 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-13 01:01:52.532163 | controller | Wednesday 13 May 2026  01:01:52 +0000 (0:00:00.443)       0:00:07.693 *********
2026-05-13 01:01:54.178899 | controller | ok: [controller]
2026-05-13 01:01:54.178958 | controller |
2026-05-13 01:01:54.178968 | controller | PLAY RECAP *********************************************************************
2026-05-13 01:01:54.178977 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-13 01:01:54.178985 | controller |
2026-05-13 01:01:54.178992 | controller |
2026-05-13 01:01:54.178999 | controller | TASKS RECAP ********************************************************************
2026-05-13 01:01:54.179006 | controller | Wednesday 13 May 2026  01:01:54 +0000 (0:00:01.649)       0:00:09.342 *********
2026-05-13 01:01:54.179013 | controller | ===============================================================================
2026-05-13 01:01:54.179021 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.65s
2026-05-13 01:01:54.179028 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.65s
2026-05-13 01:01:54.179035 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.11s
2026-05-13 01:01:54.179042 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-05-13 01:01:54.179049 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s
2026-05-13 01:01:54.179056 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s
2026-05-13 01:01:54.179063 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s
2026-05-13 01:01:54.179070 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s
2026-05-13 01:01:54.179082 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s
2026-05-13 01:01:54.179154 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s
2026-05-13 01:01:54.179236 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.39s
2026-05-13 01:01:54.179320 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s
2026-05-13 01:01:54.179411 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.28s
2026-05-13 01:01:54.179497 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-05-13 01:01:54.179581 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-05-13 01:01:54.179664 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-05-13 01:01:54.272834 | controller | INFO     [helm > idempotence] Executed: Successful
2026-05-13 01:01:54.280636 | controller | INFO     [helm > side_effect] Executing
2026-05-13 01:01:54.280981 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-13 01:01:54.286323 | controller | INFO     [helm > verify] Executing
2026-05-13 01:01:55.089891 | controller |
2026-05-13 01:01:55.090084 | controller | PLAY [Verify] ******************************************************************
2026-05-13 01:01:55.090257 | controller |
2026-05-13 01:01:55.090443 | controller | TASK [Gathering Facts] *********************************************************
2026-05-13 01:01:55.090624 | controller | Wednesday 13 May 2026  01:01:55 +0000 (0:00:00.009)       0:00:00.009 *********
2026-05-13 01:01:56.133549 | 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-05-13 01:01:56.140039 | controller | ok: [controller]
2026-05-13 01:01:56.140237 | controller |
2026-05-13 01:01:56.140448 | controller | TASK [Get the current Helm version] ********************************************
2026-05-13 01:01:56.140646 | controller | Wednesday 13 May 2026  01:01:56 +0000 (0:00:01.049)       0:00:01.059 *********
2026-05-13 01:01:56.569848 | controller | changed: [controller]
2026-05-13 01:01:56.570007 | controller |
2026-05-13 01:01:56.570211 | controller | TASK [Assert Helm version] *****************************************************
2026-05-13 01:01:56.570414 | controller | Wednesday 13 May 2026  01:01:56 +0000 (0:00:00.429)       0:00:01.488 *********
2026-05-13 01:01:56.597956 | controller | ok: [controller] => {
2026-05-13 01:01:56.598137 | controller |     "changed": false,
2026-05-13 01:01:56.598321 | controller |     "msg": "All assertions passed"
2026-05-13 01:01:56.598499 | controller | }
2026-05-13 01:01:56.598666 | controller |
2026-05-13 01:01:56.598860 | controller | PLAY RECAP *********************************************************************
2026-05-13 01:01:56.599082 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-13 01:01:56.599258 | controller |
2026-05-13 01:01:56.599421 | controller |
2026-05-13 01:01:56.599603 | controller | TASKS RECAP ********************************************************************
2026-05-13 01:01:56.599788 | controller | Wednesday 13 May 2026  01:01:56 +0000 (0:00:00.028)       0:00:01.517 *********
2026-05-13 01:01:56.599960 | controller | ===============================================================================
2026-05-13 01:01:56.600160 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-05-13 01:01:56.600350 | controller | Get the current Helm version -------------------------------------------- 0.43s
2026-05-13 01:01:56.600531 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-05-13 01:01:56.690915 | controller | INFO     [helm > verify] Executed: Successful
2026-05-13 01:01:56.701389 | controller | INFO     [helm > cleanup] Executing
2026-05-13 01:01:56.701768 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-13 01:01:56.709139 | controller | INFO     [helm > destroy] Executing
2026-05-13 01:01:56.709241 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-05-13 01:01:56.709319 | controller | INFO     [helm > destroy] Executed: Successful
2026-05-13 01:01:56.709546 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-05-13 01:01:57.097646 | controller | ok: Runtime: 0:01:50.462717
2026-05-13 01:01:57.104876 | 
2026-05-13 01:01:57.105025 | PLAY RECAP
2026-05-13 01:01:57.105134 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-13 01:01:57.105184 | 
2026-05-13 01:01:57.222956 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-13 01:01:57.226270 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-13 01:01:57.820025 | 
2026-05-13 01:01:57.820150 | PLAY [all]
2026-05-13 01:01:57.830816 | 
2026-05-13 01:01:57.830890 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-05-13 01:01:58.208154 | controller | changed
2026-05-13 01:01:58.213685 | 
2026-05-13 01:01:58.213774 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-05-13 01:01:58.606111 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-13 01:01:58.606207 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-13 01:01:58.611764 | controller | environment: line 1: kubectl: command not found
2026-05-13 01:01:58.612955 | controller | environment: line 1: kubectl: command not found
2026-05-13 01:01:58.613722 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-13 01:01:58.614722 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-13 01:01:58.617761 | controller | environment: line 1: kubectl: command not found
2026-05-13 01:01:58.620290 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-13 01:01:58.620389 | controller | environment: line 1: kubectl: command not found
2026-05-13 01:01:58.621347 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-13 01:01:58.623525 | controller | environment: line 1: kubectl: command not found
2026-05-13 01:01:58.624833 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-13 01:01:58.745239 | controller | ok: Runtime: 0:00:00.032219
2026-05-13 01:01:58.750937 | 
2026-05-13 01:01:58.751031 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-05-13 01:01:58.986644 | controller | changed
2026-05-13 01:01:58.991451 | 
2026-05-13 01:01:58.991525 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-05-13 01:01:59.224659 | controller | environment: line 5: kubectl: command not found
2026-05-13 01:01:59.226300 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-13 01:01:59.226811 | 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-05-13 01:01:59.226842 | controller |
2026-05-13 01:01:59.521673 | controller | ok: Runtime: 0:00:00.012880
2026-05-13 01:01:59.528003 | 
2026-05-13 01:01:59.531706 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-05-13 01:02:00.222090 | controller | changed:
2026-05-13 01:02:00.222290 | controller | created directory /var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/logs/controller
2026-05-13 01:02:00.222336 | controller | cd+++++++++ objects/
2026-05-13 01:02:00.222368 | controller | cd+++++++++ objects/cluster/
2026-05-13 01:02:00.222401 | controller | cd+++++++++ objects/namespaced/
2026-05-13 01:02:00.231408 | 
2026-05-13 01:02:00.231479 | TASK [gather-pod-logs : creating directory for pod logs]
2026-05-13 01:02:00.458464 | controller | changed
2026-05-13 01:02:00.464851 | 
2026-05-13 01:02:00.464949 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-05-13 01:02:00.703363 | controller | changed
2026-05-13 01:02:00.709851 | 
2026-05-13 01:02:00.709960 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-05-13 01:02:00.949616 | controller | environment: line 3: kubectl: command not found
2026-05-13 01:02:01.242964 | controller | ok: Runtime: 0:00:00.014215
2026-05-13 01:02:01.247958 | 
2026-05-13 01:02:01.248027 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-05-13 01:02:01.777444 | controller | changed:
2026-05-13 01:02:01.777736 | controller | cd+++++++++ pod-logs/
2026-05-13 01:02:01.777801 | controller | cd+++++++++ pod-logs/failed-pods/
2026-05-13 01:02:01.788429 | 
2026-05-13 01:02:01.788491 | LOOP [helm-release-status : creating directory for helm release status]
2026-05-13 01:02:02.020676 | controller | changed: "values"
2026-05-13 01:02:02.220326 | controller | changed: "releases"
2026-05-13 01:02:02.237071 | 
2026-05-13 01:02:02.237260 | TASK [helm-release-status : Gather get release status for helm charts]
2026-05-13 01:02:02.476197 | controller | /bin/bash: line 3: kubectl: command not found
2026-05-13 01:02:02.767813 | controller | ok: Runtime: 0:00:00.008901
2026-05-13 01:02:02.774277 | 
2026-05-13 01:02:02.774342 | TASK [helm-release-status : Downloads logs to executor]
2026-05-13 01:02:03.288682 | controller | changed:
2026-05-13 01:02:03.288900 | controller | cd+++++++++ helm/
2026-05-13 01:02:03.288940 | controller | cd+++++++++ helm/releases/
2026-05-13 01:02:03.289106 | controller | cd+++++++++ helm/values/
2026-05-13 01:02:03.295416 | 
2026-05-13 01:02:03.295484 | PLAY RECAP
2026-05-13 01:02:03.295545 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-13 01:02:03.295579 | 
2026-05-13 01:02:03.440454 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-13 01:02:03.443523 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-13 01:02:04.091626 | 
2026-05-13 01:02:04.091772 | PLAY [all]
2026-05-13 01:02:04.102318 | 
2026-05-13 01:02:04.102398 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-13 01:02:04.146936 | controller | skipping: Conditional result was False
2026-05-13 01:02:04.162920 | 
2026-05-13 01:02:04.163088 | TASK [fetch-output : Set log path for single node]
2026-05-13 01:02:04.204375 | controller | ok
2026-05-13 01:02:04.211830 | 
2026-05-13 01:02:04.211898 | LOOP [fetch-output : Ensure local output dirs]
2026-05-13 01:02:04.618410 | controller -> localhost | ok: "/var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/logs"
2026-05-13 01:02:04.818054 | controller -> localhost | changed: "/var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/artifacts"
2026-05-13 01:02:05.013897 | controller -> localhost | changed: "/var/lib/zuul/builds/5aa0166c5d4b46fe8f383a1b753dd09e/work/docs"
2026-05-13 01:02:05.030347 | 
2026-05-13 01:02:05.030490 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-13 01:02:05.669053 | controller | changed: .d..t...... ./
2026-05-13 01:02:05.669284 | controller | changed: All items complete
2026-05-13 01:02:05.669325 | 
2026-05-13 01:02:06.172287 | controller | changed: .d..t...... ./
2026-05-13 01:02:06.669379 | controller | changed: .d..t...... ./
2026-05-13 01:02:06.691872 | 
2026-05-13 01:02:06.692043 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-13 01:02:07.111513 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006857
2026-05-13 01:02:07.333048 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008245
2026-05-13 01:02:07.347637 | 
2026-05-13 01:02:07.347772 | PLAY [all]
2026-05-13 01:02:07.352930 | 
2026-05-13 01:02:07.353019 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-13 01:02:07.837229 | controller | changed
2026-05-13 01:02:07.842045 | 
2026-05-13 01:02:07.842099 | PLAY RECAP
2026-05-13 01:02:07.842146 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-13 01:02:07.842169 | 
2026-05-13 01:02:07.980883 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-13 01:02:07.983833 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-13 01:02:08.609812 | 
2026-05-13 01:02:08.609952 | PLAY [localhost]
2026-05-13 01:02:08.620176 | 
2026-05-13 01:02:08.620261 | TASK [Generate Zuul manifest]
2026-05-13 01:02:08.644815 | localhost | ok
2026-05-13 01:02:08.661933 | 
2026-05-13 01:02:08.662021 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-13 01:02:09.177637 | localhost | changed
2026-05-13 01:02:09.191123 | 
2026-05-13 01:02:09.191255 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-13 01:02:09.224328 | localhost | ok
2026-05-13 01:02:09.233084 | 
2026-05-13 01:02:09.233155 | TASK [Upload logs]
2026-05-13 01:02:09.255483 | localhost | ok
2026-05-13 01:02:09.320092 | 
2026-05-13 01:02:09.320251 | TASK [Set zuul-log-path fact]
2026-05-13 01:02:09.344364 | localhost | ok
2026-05-13 01:02:09.356149 | 
2026-05-13 01:02:09.356216 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-13 01:02:09.390644 | localhost | ok
2026-05-13 01:02:09.399503 | 
2026-05-13 01:02:09.399570 | TASK [upload-logs : Create log directories]
2026-05-13 01:02:09.820314 | localhost | changed
2026-05-13 01:02:09.826940 | 
2026-05-13 01:02:09.827040 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-13 01:02:10.230233 | localhost -> localhost | ok: Runtime: 0:00:00.006844
2026-05-13 01:02:10.235610 | 
2026-05-13 01:02:10.235680 | TASK [upload-logs : Upload logs to log server]
2026-05-13 01:02:10.696046 | localhost | Output suppressed because no_log was given
2026-05-13 01:02:10.701267 | 
2026-05-13 01:02:10.701359 | LOOP [upload-logs : Compress console log and json output]
2026-05-13 01:02:10.748775 | localhost | skipping: Conditional result was False
2026-05-13 01:02:10.807163 | localhost | skipping: Conditional result was False
2026-05-13 01:02:10.820384 | 
2026-05-13 01:02:10.820561 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-13 01:02:10.865723 | localhost | skipping: Conditional result was False
2026-05-13 01:02:10.866285 | 
2026-05-13 01:02:10.869586 | localhost | skipping: Conditional result was False
2026-05-13 01:02:10.881392 | 
2026-05-13 01:02:10.881530 | LOOP [upload-logs : Upload console log and json output]