2026-05-20 20:53:05.809176 | Job console starting
2026-05-20 20:53:05.833292 | Updating git repos
2026-05-20 20:53:05.905376 | Cloning repos into workspace
2026-05-20 20:53:05.985455 | Restoring repo states
2026-05-20 20:53:05.996334 | Merging changes
2026-05-20 20:53:06.900041 | Checking out repos
2026-05-20 20:53:07.280128 | Preparing playbooks
2026-05-20 20:53:10.371335 | Running Ansible setup
2026-05-20 20:53:14.201105 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-20 20:53:14.858479 | 
2026-05-20 20:53:14.909397 | PLAY [localhost]
2026-05-20 20:53:14.922463 | 
2026-05-20 20:53:14.922550 | TASK [Gathering Facts]
2026-05-20 20:53:15.909854 | localhost | ok
2026-05-20 20:53:15.919953 | 
2026-05-20 20:53:15.920076 | TASK [Setup log path fact]
2026-05-20 20:53:15.941228 | localhost | ok
2026-05-20 20:53:15.954520 | 
2026-05-20 20:53:15.954620 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-20 20:53:15.985949 | localhost | ok
2026-05-20 20:53:15.994906 | 
2026-05-20 20:53:15.994974 | TASK [emit-job-header : Print job information]
2026-05-20 20:53:16.036494 | # Job Information
2026-05-20 20:53:16.036705 | Ansible Version: 2.16.18
2026-05-20 20:53:16.036775 | Job: ansible-collection-kubernetes-molecule-helm
2026-05-20 20:53:16.036825 | Pipeline: check
2026-05-20 20:53:16.036870 | Executor: 2d72f0692154
2026-05-20 20:53:16.036914 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/276
2026-05-20 20:53:16.037019 | Event ID: bfa157e0-548d-11f1-894a-3280c2d33a65
2026-05-20 20:53:16.041497 | 
2026-05-20 20:53:16.041567 | LOOP [emit-job-header : Print node information]
2026-05-20 20:53:16.128940 | localhost | ok:
2026-05-20 20:53:16.129277 | localhost | # Node Information
2026-05-20 20:53:16.129334 | localhost | Inventory Hostname: controller
2026-05-20 20:53:16.129376 | localhost | Hostname: np0000175472
2026-05-20 20:53:16.129412 | localhost | Username: zuul
2026-05-20 20:53:16.129453 | localhost | Distro: Debian 13.4
2026-05-20 20:53:16.129490 | localhost | Provider: yul1
2026-05-20 20:53:16.129524 | localhost | Region: ca-ymq-1
2026-05-20 20:53:16.129558 | localhost | Label: debian-trixie
2026-05-20 20:53:16.129591 | localhost | Product Name: OpenStack Nova
2026-05-20 20:53:16.129623 | localhost | Interface IP: 199.204.45.19
2026-05-20 20:53:16.141143 | 
2026-05-20 20:53:16.141259 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-20 20:53:16.541285 | localhost -> localhost | changed
2026-05-20 20:53:16.550835 | 
2026-05-20 20:53:16.550954 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-20 20:53:17.392651 | localhost -> localhost | changed
2026-05-20 20:53:17.400060 | 
2026-05-20 20:53:17.400117 | PLAY [all]
2026-05-20 20:53:17.406884 | 
2026-05-20 20:53:17.406965 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-20 20:53:17.646318 | controller -> localhost | ok
2026-05-20 20:53:17.653047 | 
2026-05-20 20:53:17.653137 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-20 20:53:17.686274 | controller | ok
2026-05-20 20:53:17.702100 | controller | included: /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-20 20:53:17.706729 | 
2026-05-20 20:53:17.706789 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-20 20:53:18.339549 | controller -> localhost | Generating public/private rsa key pair.
2026-05-20 20:53:18.339747 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/89d07301e8184daba8bb4f0a440925e8_id_rsa
2026-05-20 20:53:18.339789 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/89d07301e8184daba8bb4f0a440925e8_id_rsa.pub
2026-05-20 20:53:18.339822 | controller -> localhost | The key fingerprint is:
2026-05-20 20:53:18.339852 | controller -> localhost | SHA256:J2FMnVlO4tzfyFF3q4Bv62bszQPFNfr6TMvU9frOLfc zuul-build-sshkey
2026-05-20 20:53:18.339899 | controller -> localhost | The key's randomart image is:
2026-05-20 20:53:18.339930 | controller -> localhost | +---[RSA 3072]----+
2026-05-20 20:53:18.339968 | controller -> localhost | |        ...+o   +|
2026-05-20 20:53:18.340000 | controller -> localhost | |       o o==   ++|
2026-05-20 20:53:18.340029 | controller -> localhost | |        +.o.+ +..|
2026-05-20 20:53:18.340058 | controller -> localhost | |       . .. .*.+ |
2026-05-20 20:53:18.340087 | controller -> localhost | |        S .o..= o|
2026-05-20 20:53:18.340116 | controller -> localhost | |         o...  .+|
2026-05-20 20:53:18.340144 | controller -> localhost | |          ... .oo|
2026-05-20 20:53:18.340172 | controller -> localhost | |          .+oo*o+|
2026-05-20 20:53:18.340204 | controller -> localhost | |          +o o+XE|
2026-05-20 20:53:18.340234 | controller -> localhost | +----[SHA256]-----+
2026-05-20 20:53:18.340299 | controller -> localhost | ok: Runtime: 0:00:00.213993
2026-05-20 20:53:18.346021 | 
2026-05-20 20:53:18.346084 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-20 20:53:18.376780 | controller | ok
2026-05-20 20:53:18.385914 | controller | included: /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-20 20:53:18.392271 | 
2026-05-20 20:53:18.392337 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-20 20:53:18.417335 | controller | skipping: Conditional result was False
2026-05-20 20:53:18.424778 | 
2026-05-20 20:53:18.424870 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-20 20:53:19.058886 | controller | changed
2026-05-20 20:53:19.063060 | 
2026-05-20 20:53:19.063124 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-20 20:53:19.280776 | controller | ok
2026-05-20 20:53:19.285987 | 
2026-05-20 20:53:19.286054 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-20 20:53:19.854440 | controller | changed
2026-05-20 20:53:19.860006 | 
2026-05-20 20:53:19.860095 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-20 20:53:20.401316 | controller | changed
2026-05-20 20:53:20.405641 | 
2026-05-20 20:53:20.405842 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-20 20:53:20.437009 | controller | skipping: Conditional result was False
2026-05-20 20:53:20.443788 | 
2026-05-20 20:53:20.443882 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-20 20:53:20.845709 | controller -> localhost | changed
2026-05-20 20:53:20.865477 | 
2026-05-20 20:53:20.865682 | TASK [add-build-sshkey : Add back temp key]
2026-05-20 20:53:21.140005 | controller -> localhost | Identity added: /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/89d07301e8184daba8bb4f0a440925e8_id_rsa (zuul-build-sshkey)
2026-05-20 20:53:21.140246 | controller -> localhost | ok: Runtime: 0:00:00.014210
2026-05-20 20:53:21.145712 | 
2026-05-20 20:53:21.145779 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-20 20:53:21.483547 | controller | ok
2026-05-20 20:53:21.488173 | 
2026-05-20 20:53:21.488243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-20 20:53:21.513589 | controller | skipping: Conditional result was False
2026-05-20 20:53:21.525643 | 
2026-05-20 20:53:21.525769 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-20 20:53:21.913954 | controller | ok
2026-05-20 20:53:21.918961 | 
2026-05-20 20:53:21.919029 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-20 20:53:22.927359 | controller | Output suppressed because no_log was given
2026-05-20 20:53:22.934337 | 
2026-05-20 20:53:22.934402 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-20 20:53:23.161727 | controller | ok: "logs"
2026-05-20 20:53:23.162384 | controller | ok: All items complete
2026-05-20 20:53:23.162443 | 
2026-05-20 20:53:23.364267 | controller | ok: "artifacts"
2026-05-20 20:53:23.557902 | controller | ok: "docs"
2026-05-20 20:53:23.569378 | 
2026-05-20 20:53:23.569576 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-20 20:53:23.783896 | controller | changed: "logs"
2026-05-20 20:53:23.986533 | controller | changed: "artifacts"
2026-05-20 20:53:24.173129 | controller | changed: "docs"
2026-05-20 20:53:24.192795 | 
2026-05-20 20:53:24.192981 | PLAY RECAP
2026-05-20 20:53:24.193053 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-20 20:53:24.193101 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 20:53:24.193134 | 
2026-05-20 20:53:24.340006 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-20 20:53:24.341896 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-20 20:53:24.940249 | 
2026-05-20 20:53:24.940385 | PLAY [all]
2026-05-20 20:53:24.950000 | 
2026-05-20 20:53:24.950077 | TASK [setup-uv : Extract archive]
2026-05-20 20:53:28.319131 | controller | changed
2026-05-20 20:53:28.325519 | 
2026-05-20 20:53:28.325598 | TASK [setup-uv : Print version]
2026-05-20 20:53:28.289342 | controller | uv 0.8.13
2026-05-20 20:53:28.861110 | controller | ok: Runtime: 0:00:00.017883
2026-05-20 20:53:28.870143 | 
2026-05-20 20:53:28.870209 | TASK [Install Ansible collection siblings]
2026-05-20 20:53:29.268341 | controller | ok:
2026-05-20 20:53:29.268527 | controller | Skipping ansible.posix: no checked-out sibling
2026-05-20 20:53:29.268569 | controller | Skipping community.crypto: no checked-out sibling
2026-05-20 20:53:29.268601 | controller | Skipping community.general: no checked-out sibling
2026-05-20 20:53:29.268632 | controller | Skipping kubernetes.core: no checked-out sibling
2026-05-20 20:53:29.268662 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-05-20 20:53:29.270730 | 
2026-05-20 20:53:29.270794 | PLAY RECAP
2026-05-20 20:53:29.270856 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 20:53:29.270889 | 
2026-05-20 20:53:29.399167 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-20 20:53:29.402039 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-20 20:53:29.982516 | 
2026-05-20 20:53:29.982660 | PLAY [all]
2026-05-20 20:53:29.993951 | 
2026-05-20 20:53:29.994027 | TASK [Update apt cache]
2026-05-20 20:53:37.486605 | controller | ok
2026-05-20 20:53:37.490829 | 
2026-05-20 20:53:37.490906 | TASK [Disable firewalld]
2026-05-20 20:53:37.516239 | controller | skipping: Conditional result was False
2026-05-20 20:53:37.525309 | 
2026-05-20 20:53:37.525492 | TASK [Install "jq" for log collection]
2026-05-20 20:53:41.064096 | controller | changed
2026-05-20 20:53:41.066269 | 
2026-05-20 20:53:41.066329 | PLAY RECAP
2026-05-20 20:53:41.066385 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-20 20:53:41.066414 | 
2026-05-20 20:53:41.184931 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-20 20:53:41.187885 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-20 20:53:41.819886 | 
2026-05-20 20:53:41.820038 | PLAY [all]
2026-05-20 20:53:41.829727 | 
2026-05-20 20:53:41.829798 | TASK [Copy inventory file for Zuul]
2026-05-20 20:53:42.816280 | controller | changed
2026-05-20 20:53:42.822751 | 
2026-05-20 20:53:42.822839 | TASK [Switch "ansible_host" to private IP]
2026-05-20 20:53:43.183154 | controller | changed: 1 replacements made
2026-05-20 20:53:43.188098 | 
2026-05-20 20:53:43.188169 | TASK [Run Molecule scenario]
2026-05-20 20:53:43.210915 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-05-20 20:53:43.211020 | controller | Creating virtual environment at: .venv
2026-05-20 20:53:44.414190 | controller | Downloading cryptography (4.3MiB)
2026-05-20 20:53:44.415107 | controller | Downloading ansible-core (2.3MiB)
2026-05-20 20:53:44.415302 | controller | Downloading pygments (1.2MiB)
2026-05-20 20:53:44.573877 | controller |  Downloading cryptography
2026-05-20 20:53:44.624996 | controller |  Downloading pygments
2026-05-20 20:53:44.799339 | controller |  Downloading ansible-core
2026-05-20 20:53:44.845740 | controller | Installed 36 packages in 45ms
2026-05-20 20:53:45.601921 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-05-20 20:53:45.602032 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-20 20:53:46.557598 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-05-20 20:53:46.557660 | controller | INFO     default scenario not found, disabling shared state.
2026-05-20 20:53:46.557738 | controller | INFO     [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-20 20:53:46.557831 | controller | INFO     [helm > prerun] Performing prerun with role_name_check=0...
2026-05-20 20:56:07.287189 | controller | INFO     [helm > dependency] Executing
2026-05-20 20:56:07.287269 | controller | WARNING  [helm > dependency] Missing roles requirements file: requirements.yml
2026-05-20 20:56:07.287452 | controller | WARNING  [helm > dependency] Missing collections requirements file: collections.yml
2026-05-20 20:56:07.287552 | controller | WARNING  [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-05-20 20:56:07.293089 | controller | INFO     [helm > cleanup] Executing
2026-05-20 20:56:07.293397 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 20:56:07.298862 | controller | INFO     [helm > destroy] Executing
2026-05-20 20:56:07.298891 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-05-20 20:56:07.298936 | controller | INFO     [helm > destroy] Executed: Successful
2026-05-20 20:56:07.304441 | controller | INFO     [helm > syntax] Executing
2026-05-20 20:56:08.196492 | controller |
2026-05-20 20:56:08.196733 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml
2026-05-20 20:56:08.259573 | controller | INFO     [helm > syntax] Executed: Successful
2026-05-20 20:56:08.270986 | controller | INFO     [helm > create] Executing
2026-05-20 20:56:08.272814 | controller | WARNING  [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 20:56:08.278392 | controller | INFO     [helm > prepare] Executing
2026-05-20 20:56:09.256281 | controller |
2026-05-20 20:56:09.256450 | controller | PLAY [Prepare] *****************************************************************
2026-05-20 20:56:09.256717 | controller |
2026-05-20 20:56:09.256977 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 20:56:09.257268 | controller | Wednesday 20 May 2026  20:56:09 +0000 (0:00:00.031)       0:00:00.031 *********
2026-05-20 20:56:10.550158 | 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-20 20:56:10.558446 | controller | ok: [controller]
2026-05-20 20:56:10.558557 | controller |
2026-05-20 20:56:10.558709 | controller | TASK [Install Debian packages] *************************************************
2026-05-20 20:56:10.558888 | controller | Wednesday 20 May 2026  20:56:10 +0000 (0:00:01.302)       0:00:01.334 *********
2026-05-20 20:56:12.040623 | controller | ok: [controller]
2026-05-20 20:56:12.040685 | controller |
2026-05-20 20:56:12.040844 | controller | PLAY RECAP *********************************************************************
2026-05-20 20:56:12.040992 | controller | controller                 : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-20 20:56:12.041107 | controller |
2026-05-20 20:56:12.041221 | controller |
2026-05-20 20:56:12.041353 | controller | TASKS RECAP ********************************************************************
2026-05-20 20:56:12.041479 | controller | Wednesday 20 May 2026  20:56:12 +0000 (0:00:01.482)       0:00:02.817 *********
2026-05-20 20:56:12.041602 | controller | ===============================================================================
2026-05-20 20:56:12.041746 | controller | Install Debian packages ------------------------------------------------- 1.48s
2026-05-20 20:56:12.041878 | controller | Gathering Facts --------------------------------------------------------- 1.30s
2026-05-20 20:56:12.161128 | controller | INFO     [helm > prepare] Executed: Successful
2026-05-20 20:56:12.171337 | controller | INFO     [helm > converge] Executing
2026-05-20 20:56:13.078471 | controller |
2026-05-20 20:56:13.078531 | controller | PLAY [Converge] ****************************************************************
2026-05-20 20:56:13.078538 | controller |
2026-05-20 20:56:13.078726 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 20:56:13.078832 | controller | Wednesday 20 May 2026  20:56:13 +0000 (0:00:00.014)       0:00:00.014 *********
2026-05-20 20:56:15.200773 | 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-20 20:56:15.201370 | controller | ok: [controller]
2026-05-20 20:56:15.201582 | controller |
2026-05-20 20:56:15.201811 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 20:56:15.202017 | controller | Wednesday 20 May 2026  20:56:15 +0000 (0:00:02.122)       0:00:02.137 *********
2026-05-20 20:56:15.723424 | controller | ok: [controller]
2026-05-20 20:56:15.723574 | controller |
2026-05-20 20:56:15.723778 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-20 20:56:15.724045 | controller | Wednesday 20 May 2026  20:56:15 +0000 (0:00:00.521)       0:00:02.659 *********
2026-05-20 20:56:16.761689 | controller | ok: [controller]
2026-05-20 20:56:16.761807 | controller |
2026-05-20 20:56:16.762017 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-20 20:56:16.762235 | controller | Wednesday 20 May 2026  20:56:16 +0000 (0:00:01.038)       0:00:03.697 *********
2026-05-20 20:56:17.220774 | controller | changed: [controller]
2026-05-20 20:56:17.220955 | controller |
2026-05-20 20:56:17.221184 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 20:56:17.221406 | controller | Wednesday 20 May 2026  20:56:17 +0000 (0:00:00.459)       0:00:04.156 *********
2026-05-20 20:56:17.264210 | controller | ok: [controller] => {
2026-05-20 20:56:17.264308 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-05-20 20:56:17.264427 | controller | }
2026-05-20 20:56:17.264534 | controller |
2026-05-20 20:56:17.264674 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 20:56:17.264813 | controller | Wednesday 20 May 2026  20:56:17 +0000 (0:00:00.043)       0:00:04.199 *********
2026-05-20 20:56:18.196764 | 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-20 20:56:18.205975 | controller | changed: [controller]
2026-05-20 20:56:18.206176 | controller |
2026-05-20 20:56:18.206454 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 20:56:18.206666 | controller | Wednesday 20 May 2026  20:56:18 +0000 (0:00:00.942)       0:00:05.141 *********
2026-05-20 20:56:20.369406 | controller | changed: [controller]
2026-05-20 20:56:20.369576 | controller |
2026-05-20 20:56:20.369797 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-05-20 20:56:20.370008 | controller | Wednesday 20 May 2026  20:56:20 +0000 (0:00:02.163)       0:00:07.304 *********
2026-05-20 20:56:20.906999 | controller | ok: [controller]
2026-05-20 20:56:20.907111 | controller |
2026-05-20 20:56:20.907216 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-05-20 20:56:20.907337 | controller | Wednesday 20 May 2026  20:56:20 +0000 (0:00:00.537)       0:00:07.842 *********
2026-05-20 20:56:21.316367 | controller | changed: [controller]
2026-05-20 20:56:21.316440 | controller |
2026-05-20 20:56:21.316594 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-05-20 20:56:21.316732 | controller | Wednesday 20 May 2026  20:56:21 +0000 (0:00:00.408)       0:00:08.251 *********
2026-05-20 20:56:21.803475 | controller | ok: [controller]
2026-05-20 20:56:21.803556 | controller |
2026-05-20 20:56:21.803567 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-05-20 20:56:21.803622 | controller | Wednesday 20 May 2026  20:56:21 +0000 (0:00:00.484)       0:00:08.735 *********
2026-05-20 20:56:22.124137 | controller | changed: [controller]
2026-05-20 20:56:22.124207 | controller |
2026-05-20 20:56:22.124257 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-05-20 20:56:22.124372 | controller | Wednesday 20 May 2026  20:56:22 +0000 (0:00:00.321)       0:00:09.057 *********
2026-05-20 20:56:22.446143 | controller | ok: [controller]
2026-05-20 20:56:22.446269 | controller |
2026-05-20 20:56:22.446526 | controller | TASK [Install plugin] **********************************************************
2026-05-20 20:56:22.446721 | controller | Wednesday 20 May 2026  20:56:22 +0000 (0:00:00.324)       0:00:09.381 *********
2026-05-20 20:56:22.502884 | controller | included: vexxhost.containers.download_artifact for controller
2026-05-20 20:56:22.502957 | controller |
2026-05-20 20:56:22.503059 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 20:56:22.503219 | controller | Wednesday 20 May 2026  20:56:22 +0000 (0:00:00.057)       0:00:09.438 *********
2026-05-20 20:56:22.549465 | controller | ok: [controller] => {
2026-05-20 20:56:22.549545 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-05-20 20:56:22.549649 | controller | }
2026-05-20 20:56:22.549775 | controller |
2026-05-20 20:56:22.549989 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 20:56:22.550128 | controller | Wednesday 20 May 2026  20:56:22 +0000 (0:00:00.046)       0:00:09.484 *********
2026-05-20 20:56:23.395530 | controller | changed: [controller]
2026-05-20 20:56:23.395570 | controller |
2026-05-20 20:56:23.395691 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 20:56:23.395798 | controller | Wednesday 20 May 2026  20:56:23 +0000 (0:00:00.844)       0:00:10.329 *********
2026-05-20 20:56:25.539214 | controller | changed: [controller]
2026-05-20 20:56:25.539266 | controller |
2026-05-20 20:56:25.539276 | controller | PLAY RECAP *********************************************************************
2026-05-20 20:56:25.539286 | controller | controller                 : ok=16   changed=7    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-20 20:56:25.539294 | controller |
2026-05-20 20:56:25.539301 | controller |
2026-05-20 20:56:25.539309 | controller | TASKS RECAP ********************************************************************
2026-05-20 20:56:25.539316 | controller | Wednesday 20 May 2026  20:56:25 +0000 (0:00:02.144)       0:00:12.473 *********
2026-05-20 20:56:25.539323 | controller | ===============================================================================
2026-05-20 20:56:25.539336 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.16s
2026-05-20 20:56:25.539410 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.14s
2026-05-20 20:56:25.539646 | controller | Gathering Facts --------------------------------------------------------- 2.12s
2026-05-20 20:56:25.539875 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.04s
2026-05-20 20:56:25.540103 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.94s
2026-05-20 20:56:25.540300 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.84s
2026-05-20 20:56:25.540492 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s
2026-05-20 20:56:25.540682 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.52s
2026-05-20 20:56:25.540867 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s
2026-05-20 20:56:25.541055 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s
2026-05-20 20:56:25.541245 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s
2026-05-20 20:56:25.541445 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s
2026-05-20 20:56:25.541642 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s
2026-05-20 20:56:25.541825 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-05-20 20:56:25.542014 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s
2026-05-20 20:56:25.542201 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-05-20 20:56:25.631809 | controller | INFO     [helm > converge] Executed: Successful
2026-05-20 20:56:25.641472 | controller | INFO     [helm > idempotence] Executing
2026-05-20 20:56:26.519790 | controller |
2026-05-20 20:56:26.519885 | controller | PLAY [Converge] ****************************************************************
2026-05-20 20:56:26.520004 | controller |
2026-05-20 20:56:26.520196 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 20:56:26.520384 | controller | Wednesday 20 May 2026  20:56:26 +0000 (0:00:00.013)       0:00:00.013 *********
2026-05-20 20:56:28.625782 | 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-20 20:56:28.630767 | controller | ok: [controller]
2026-05-20 20:56:28.630963 | controller |
2026-05-20 20:56:28.631370 | controller | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-20 20:56:28.631603 | controller | Wednesday 20 May 2026  20:56:28 +0000 (0:00:02.110)       0:00:02.124 *********
2026-05-20 20:56:29.116640 | controller | ok: [controller]
2026-05-20 20:56:29.116856 | controller |
2026-05-20 20:56:29.117199 | controller | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-20 20:56:29.117517 | controller | Wednesday 20 May 2026  20:56:29 +0000 (0:00:00.485)       0:00:02.609 *********
2026-05-20 20:56:30.320423 | controller | ok: [controller]
2026-05-20 20:56:30.320585 | controller |
2026-05-20 20:56:30.320799 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-20 20:56:30.321011 | controller | Wednesday 20 May 2026  20:56:30 +0000 (0:00:01.203)       0:00:03.813 *********
2026-05-20 20:56:30.757272 | controller | ok: [controller]
2026-05-20 20:56:30.757419 | controller |
2026-05-20 20:56:30.757695 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 20:56:30.757873 | controller | Wednesday 20 May 2026  20:56:30 +0000 (0:00:00.437)       0:00:04.250 *********
2026-05-20 20:56:30.802173 | controller | ok: [controller] => {
2026-05-20 20:56:30.802345 | controller |     "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz"
2026-05-20 20:56:30.802531 | controller | }
2026-05-20 20:56:30.802738 | controller |
2026-05-20 20:56:30.802935 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 20:56:30.803166 | controller | Wednesday 20 May 2026  20:56:30 +0000 (0:00:00.044)       0:00:04.295 *********
2026-05-20 20:56:31.351316 | controller | ok: [controller]
2026-05-20 20:56:31.351473 | controller |
2026-05-20 20:56:31.351749 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 20:56:31.352034 | controller | Wednesday 20 May 2026  20:56:31 +0000 (0:00:00.546)       0:00:04.842 *********
2026-05-20 20:56:33.147422 | controller | ok: [controller]
2026-05-20 20:56:33.147470 | controller |
2026-05-20 20:56:33.147481 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] ***********************
2026-05-20 20:56:33.147489 | controller | Wednesday 20 May 2026  20:56:33 +0000 (0:00:01.797)       0:00:06.639 *********
2026-05-20 20:56:33.755902 | controller | ok: [controller]
2026-05-20 20:56:33.755978 | controller |
2026-05-20 20:56:33.756083 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] ***************
2026-05-20 20:56:33.756212 | controller | Wednesday 20 May 2026  20:56:33 +0000 (0:00:00.606)       0:00:07.246 *********
2026-05-20 20:56:34.184254 | controller | ok: [controller]
2026-05-20 20:56:34.184311 | controller |
2026-05-20 20:56:34.184468 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] *************************
2026-05-20 20:56:34.184600 | controller | Wednesday 20 May 2026  20:56:34 +0000 (0:00:00.430)       0:00:07.676 *********
2026-05-20 20:56:34.689375 | controller | ok: [controller]
2026-05-20 20:56:34.689432 | controller |
2026-05-20 20:56:34.689597 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] ***
2026-05-20 20:56:34.689737 | controller | Wednesday 20 May 2026  20:56:34 +0000 (0:00:00.505)       0:00:08.182 *********
2026-05-20 20:56:35.003729 | controller | ok: [controller]
2026-05-20 20:56:35.003811 | controller |
2026-05-20 20:56:35.003928 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] ***
2026-05-20 20:56:35.004059 | controller | Wednesday 20 May 2026  20:56:35 +0000 (0:00:00.312)       0:00:08.495 *********
2026-05-20 20:56:35.345561 | controller | ok: [controller]
2026-05-20 20:56:35.345636 | controller |
2026-05-20 20:56:35.345739 | controller | TASK [Install plugin] **********************************************************
2026-05-20 20:56:35.345906 | controller | Wednesday 20 May 2026  20:56:35 +0000 (0:00:00.343)       0:00:08.838 *********
2026-05-20 20:56:35.407497 | controller | included: vexxhost.containers.download_artifact for controller
2026-05-20 20:56:35.407531 | controller |
2026-05-20 20:56:35.407685 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-20 20:56:35.410711 | controller | Wednesday 20 May 2026  20:56:35 +0000 (0:00:00.060)       0:00:08.899 *********
2026-05-20 20:56:35.464183 | controller | ok: [controller] => {
2026-05-20 20:56:35.464217 | controller |     "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz"
2026-05-20 20:56:35.464222 | controller | }
2026-05-20 20:56:35.464226 | controller |
2026-05-20 20:56:35.464230 | controller | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-20 20:56:35.464234 | controller | Wednesday 20 May 2026  20:56:35 +0000 (0:00:00.054)       0:00:08.954 *********
2026-05-20 20:56:35.932006 | controller | ok: [controller]
2026-05-20 20:56:35.932035 | controller |
2026-05-20 20:56:35.932039 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-20 20:56:35.932043 | controller | Wednesday 20 May 2026  20:56:35 +0000 (0:00:00.467)       0:00:09.421 *********
2026-05-20 20:56:37.612107 | controller | ok: [controller]
2026-05-20 20:56:37.612160 | controller |
2026-05-20 20:56:37.612242 | controller | PLAY RECAP *********************************************************************
2026-05-20 20:56:37.612324 | controller | controller                 : ok=16   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-20 20:56:37.614108 | controller |
2026-05-20 20:56:37.614135 | controller |
2026-05-20 20:56:37.614139 | controller | TASKS RECAP ********************************************************************
2026-05-20 20:56:37.614144 | controller | Wednesday 20 May 2026  20:56:37 +0000 (0:00:01.685)       0:00:11.106 *********
2026-05-20 20:56:37.614147 | controller | ===============================================================================
2026-05-20 20:56:37.614150 | controller | Gathering Facts --------------------------------------------------------- 2.11s
2026-05-20 20:56:37.614153 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.80s
2026-05-20 20:56:37.614157 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s
2026-05-20 20:56:37.614160 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.20s
2026-05-20 20:56:37.614163 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.61s
2026-05-20 20:56:37.614166 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.55s
2026-05-20 20:56:37.614170 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.51s
2026-05-20 20:56:37.614173 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-05-20 20:56:37.614177 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.47s
2026-05-20 20:56:37.614180 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s
2026-05-20 20:56:37.614194 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s
2026-05-20 20:56:37.614197 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.34s
2026-05-20 20:56:37.614200 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s
2026-05-20 20:56:37.614203 | controller | Install plugin ---------------------------------------------------------- 0.06s
2026-05-20 20:56:37.614207 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-05-20 20:56:37.614210 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s
2026-05-20 20:56:37.746232 | controller | INFO     [helm > idempotence] Executed: Successful
2026-05-20 20:56:37.756093 | controller | INFO     [helm > side_effect] Executing
2026-05-20 20:56:37.756582 | controller | WARNING  [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 20:56:37.763731 | controller | INFO     [helm > verify] Executing
2026-05-20 20:56:38.591649 | controller |
2026-05-20 20:56:38.591840 | controller | PLAY [Verify] ******************************************************************
2026-05-20 20:56:38.591988 | controller |
2026-05-20 20:56:38.592109 | controller | TASK [Gathering Facts] *********************************************************
2026-05-20 20:56:38.592222 | controller | Wednesday 20 May 2026  20:56:38 +0000 (0:00:00.010)       0:00:00.010 *********
2026-05-20 20:56:40.722851 | 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-20 20:56:40.729708 | controller | ok: [controller]
2026-05-20 20:56:40.729944 | controller |
2026-05-20 20:56:40.730185 | controller | TASK [Get the current Helm version] ********************************************
2026-05-20 20:56:40.730423 | controller | Wednesday 20 May 2026  20:56:40 +0000 (0:00:02.137)       0:00:02.148 *********
2026-05-20 20:56:41.231464 | controller | changed: [controller]
2026-05-20 20:56:41.231816 | controller |
2026-05-20 20:56:41.232091 | controller | TASK [Assert Helm version] *****************************************************
2026-05-20 20:56:41.232350 | controller | Wednesday 20 May 2026  20:56:41 +0000 (0:00:00.501)       0:00:02.650 *********
2026-05-20 20:56:41.263673 | controller | ok: [controller] => {
2026-05-20 20:56:41.263959 | controller |     "changed": false,
2026-05-20 20:56:41.264211 | controller |     "msg": "All assertions passed"
2026-05-20 20:56:41.264447 | controller | }
2026-05-20 20:56:41.264672 | controller |
2026-05-20 20:56:41.264912 | controller | PLAY RECAP *********************************************************************
2026-05-20 20:56:41.265179 | controller | controller                 : ok=3    changed=1    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-20 20:56:41.265402 | controller |
2026-05-20 20:56:41.265621 | controller |
2026-05-20 20:56:41.265859 | controller | TASKS RECAP ********************************************************************
2026-05-20 20:56:41.266103 | controller | Wednesday 20 May 2026  20:56:41 +0000 (0:00:00.033)       0:00:02.683 *********
2026-05-20 20:56:41.266420 | controller | ===============================================================================
2026-05-20 20:56:41.266699 | controller | Gathering Facts --------------------------------------------------------- 2.14s
2026-05-20 20:56:41.266947 | controller | Get the current Helm version -------------------------------------------- 0.50s
2026-05-20 20:56:41.267226 | controller | Assert Helm version ----------------------------------------------------- 0.03s
2026-05-20 20:56:41.365123 | controller | INFO     [helm > verify] Executed: Successful
2026-05-20 20:56:41.376741 | controller | INFO     [helm > cleanup] Executing
2026-05-20 20:56:41.379114 | controller | WARNING  [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-20 20:56:41.385017 | controller | INFO     [helm > destroy] Executing
2026-05-20 20:56:41.385125 | controller | WARNING  [helm > destroy] Skipping, '--destroy=never' requested.
2026-05-20 20:56:41.385244 | controller | INFO     [helm > destroy] Executed: Successful
2026-05-20 20:56:41.385597 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-05-20 20:56:41.851760 | controller | ok: Runtime: 0:02:58.366938
2026-05-20 20:56:41.857024 | 
2026-05-20 20:56:41.857168 | PLAY RECAP
2026-05-20 20:56:41.857218 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 20:56:41.857242 | 
2026-05-20 20:56:41.994735 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-20 20:56:41.997922 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-20 20:56:42.619807 | 
2026-05-20 20:56:42.620052 | PLAY [all]
2026-05-20 20:56:42.632044 | 
2026-05-20 20:56:42.632133 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-05-20 20:56:43.036890 | controller | changed
2026-05-20 20:56:43.043405 | 
2026-05-20 20:56:43.043485 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-05-20 20:56:43.486228 | 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-20 20:56:43.486325 | controller |
2026-05-20 20:56:43.493988 | controller | environment: line 1: kubectl: command not found
2026-05-20 20:56:43.495959 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-20 20:56:43.496260 | controller | environment: line 1: kubectl: command not found
2026-05-20 20:56:43.498318 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-20 20:56:43.502096 | controller | environment: line 1: kubectl: command not found
2026-05-20 20:56:43.502243 | controller | environment: line 1: kubectl: command not found
2026-05-20 20:56:43.503568 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-20 20:56:43.505000 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-20 20:56:43.506694 | controller | environment: line 1: kubectl: command not found
2026-05-20 20:56:43.508396 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-20 20:56:43.574253 | controller | ok: Runtime: 0:00:00.041187
2026-05-20 20:56:43.579754 | 
2026-05-20 20:56:43.579837 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-05-20 20:56:43.812633 | controller | changed
2026-05-20 20:56:43.818242 | 
2026-05-20 20:56:43.818344 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-05-20 20:56:44.080549 | controller | environment: line 5: kubectl: command not found
2026-05-20 20:56:44.081837 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-20 20:56:44.081920 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-20 20:56:44.082162 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-20 20:56:44.349764 | controller | ok: Runtime: 0:00:00.012326
2026-05-20 20:56:44.358005 | 
2026-05-20 20:56:44.358101 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-05-20 20:56:45.064938 | controller | changed:
2026-05-20 20:56:45.065116 | controller | created directory /var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/logs/controller
2026-05-20 20:56:45.065148 | controller | cd+++++++++ objects/
2026-05-20 20:56:45.065170 | controller | cd+++++++++ objects/cluster/
2026-05-20 20:56:45.065193 | controller | cd+++++++++ objects/namespaced/
2026-05-20 20:56:45.072033 | 
2026-05-20 20:56:45.072100 | TASK [gather-pod-logs : creating directory for pod logs]
2026-05-20 20:56:45.308847 | controller | changed
2026-05-20 20:56:45.314449 | 
2026-05-20 20:56:45.314516 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-05-20 20:56:45.547162 | controller | changed
2026-05-20 20:56:45.551261 | 
2026-05-20 20:56:45.551336 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-05-20 20:56:45.815522 | controller | environment: line 3: kubectl: command not found
2026-05-20 20:56:46.088120 | controller | ok: Runtime: 0:00:00.010151
2026-05-20 20:56:46.094634 | 
2026-05-20 20:56:46.094705 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-05-20 20:56:46.624655 | controller | changed:
2026-05-20 20:56:46.624881 | controller | cd+++++++++ pod-logs/
2026-05-20 20:56:46.624922 | controller | cd+++++++++ pod-logs/failed-pods/
2026-05-20 20:56:46.634904 | 
2026-05-20 20:56:46.634994 | LOOP [helm-release-status : creating directory for helm release status]
2026-05-20 20:56:46.871594 | controller | changed: "values"
2026-05-20 20:56:47.113088 | controller | changed: "releases"
2026-05-20 20:56:47.128190 | 
2026-05-20 20:56:47.128390 | TASK [helm-release-status : Gather get release status for helm charts]
2026-05-20 20:56:47.387935 | controller | /bin/bash: line 3: kubectl: command not found
2026-05-20 20:56:47.664714 | controller | ok: Runtime: 0:00:00.009307
2026-05-20 20:56:47.671495 | 
2026-05-20 20:56:47.671590 | TASK [helm-release-status : Downloads logs to executor]
2026-05-20 20:56:48.212571 | controller | changed:
2026-05-20 20:56:48.212780 | controller | cd+++++++++ helm/
2026-05-20 20:56:48.212820 | controller | cd+++++++++ helm/releases/
2026-05-20 20:56:48.212855 | controller | cd+++++++++ helm/values/
2026-05-20 20:56:48.219724 | 
2026-05-20 20:56:48.219822 | PLAY RECAP
2026-05-20 20:56:48.219876 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-20 20:56:48.219898 | 
2026-05-20 20:56:48.378215 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-20 20:56:48.380017 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-20 20:56:49.035261 | 
2026-05-20 20:56:49.035407 | PLAY [all]
2026-05-20 20:56:49.046932 | 
2026-05-20 20:56:49.047073 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-20 20:56:49.093009 | controller | skipping: Conditional result was False
2026-05-20 20:56:49.102248 | 
2026-05-20 20:56:49.102534 | TASK [fetch-output : Set log path for single node]
2026-05-20 20:56:49.146169 | controller | ok
2026-05-20 20:56:49.152111 | 
2026-05-20 20:56:49.152224 | LOOP [fetch-output : Ensure local output dirs]
2026-05-20 20:56:49.583235 | controller -> localhost | ok: "/var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/logs"
2026-05-20 20:56:49.791534 | controller -> localhost | changed: "/var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/artifacts"
2026-05-20 20:56:50.009922 | controller -> localhost | changed: "/var/lib/zuul/builds/89d07301e8184daba8bb4f0a440925e8/work/docs"
2026-05-20 20:56:50.028344 | 
2026-05-20 20:56:50.028490 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-20 20:56:50.737265 | controller | changed: .d..t...... ./
2026-05-20 20:56:51.675317 | controller | changed: All items complete
2026-05-20 20:56:51.675576 | 
2026-05-20 20:56:51.743903 | controller | changed: .d..t...... ./
2026-05-20 20:56:52.222934 | controller | changed: .d..t...... ./
2026-05-20 20:56:52.248344 | 
2026-05-20 20:56:52.249059 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-20 20:56:53.451977 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007379
2026-05-20 20:56:53.693382 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009374
2026-05-20 20:56:53.713831 | 
2026-05-20 20:56:53.713967 | PLAY [all]
2026-05-20 20:56:53.719144 | 
2026-05-20 20:56:53.719218 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-20 20:56:54.239930 | controller | changed
2026-05-20 20:56:54.247458 | 
2026-05-20 20:56:54.247514 | PLAY RECAP
2026-05-20 20:56:54.247565 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-20 20:56:54.247592 | 
2026-05-20 20:56:54.386561 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-20 20:56:54.389675 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-20 20:56:54.986057 | 
2026-05-20 20:56:54.986180 | PLAY [localhost]
2026-05-20 20:56:54.995780 | 
2026-05-20 20:56:54.995874 | TASK [Generate Zuul manifest]
2026-05-20 20:56:55.017773 | localhost | ok
2026-05-20 20:56:55.035570 | 
2026-05-20 20:56:55.035651 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-20 20:56:55.409344 | localhost | changed
2026-05-20 20:56:55.424310 | 
2026-05-20 20:56:55.424384 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-20 20:56:55.798108 | localhost | ok
2026-05-20 20:56:55.809782 | 
2026-05-20 20:56:55.809864 | TASK [Upload logs]
2026-05-20 20:56:55.831142 | localhost | ok
2026-05-20 20:56:55.889861 | 
2026-05-20 20:56:55.890009 | TASK [Set zuul-log-path fact]
2026-05-20 20:56:55.912834 | localhost | ok
2026-05-20 20:56:55.924913 | 
2026-05-20 20:56:55.924994 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-20 20:56:55.956100 | localhost | ok
2026-05-20 20:56:55.965968 | 
2026-05-20 20:56:55.966053 | TASK [upload-logs : Create log directories]
2026-05-20 20:56:56.380629 | localhost | changed
2026-05-20 20:56:56.387453 | 
2026-05-20 20:56:56.387537 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-20 20:56:56.785503 | localhost -> localhost | ok: Runtime: 0:00:00.006427
2026-05-20 20:56:56.793926 | 
2026-05-20 20:56:56.794022 | TASK [upload-logs : Upload logs to log server]
2026-05-20 20:56:57.276781 | localhost | Output suppressed because no_log was given
2026-05-20 20:56:57.281643 | 
2026-05-20 20:56:57.281715 | LOOP [upload-logs : Compress console log and json output]
2026-05-20 20:56:57.333787 | localhost | skipping: Conditional result was False
2026-05-20 20:56:57.389533 | localhost | skipping: Conditional result was False
2026-05-20 20:56:57.408660 | 
2026-05-20 20:56:57.408880 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-20 20:56:57.463883 | localhost | skipping: Conditional result was False
2026-05-20 20:56:57.465776 | 
2026-05-20 20:56:57.468388 | localhost | skipping: Conditional result was False
2026-05-20 20:56:57.484826 | 
2026-05-20 20:56:57.485030 | LOOP [upload-logs : Upload console log and json output]