2026-03-17 18:55:32.677241 | Job console starting 2026-03-17 18:55:32.684433 | Updating git repos 2026-03-17 18:55:32.713442 | Cloning repos into workspace 2026-03-17 18:55:32.772101 | Restoring repo states 2026-03-17 18:55:32.785811 | Merging changes 2026-03-17 18:55:33.302546 | Checking out repos 2026-03-17 18:55:33.385197 | Preparing playbooks 2026-03-17 18:55:34.284054 | Running Ansible setup 2026-03-17 18:55:41.273218 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 18:55:41.828948 | 2026-03-17 18:55:41.829127 | PLAY [localhost] 2026-03-17 18:55:41.836719 | 2026-03-17 18:55:41.836788 | TASK [Gathering Facts] 2026-03-17 18:55:42.653975 | localhost | ok 2026-03-17 18:55:42.663838 | 2026-03-17 18:55:42.663911 | TASK [Setup log path fact] 2026-03-17 18:55:42.682429 | localhost | ok 2026-03-17 18:55:42.695218 | 2026-03-17 18:55:42.695301 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 18:55:42.724439 | localhost | ok 2026-03-17 18:55:42.733652 | 2026-03-17 18:55:42.733749 | TASK [emit-job-header : Print job information] 2026-03-17 18:55:42.773997 | # Job Information 2026-03-17 18:55:42.774166 | Ansible Version: 2.16.16 2026-03-17 18:55:42.774261 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-17 18:55:42.774294 | Pipeline: check 2026-03-17 18:55:42.774323 | Executor: 0a8996d2b663 2026-03-17 18:55:42.774351 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-17 18:55:42.774381 | Event ID: 728760e0-2232-11f1-89e0-7dc7177ef4eb 2026-03-17 18:55:42.778196 | 2026-03-17 18:55:42.778280 | LOOP [emit-job-header : Print node information] 2026-03-17 18:55:42.859446 | localhost | ok: 2026-03-17 18:55:42.859711 | localhost | # Node Information 2026-03-17 18:55:42.859767 | localhost | Inventory Hostname: controller 2026-03-17 18:55:42.859800 | localhost | Hostname: np0000159474 2026-03-17 18:55:42.859830 | localhost | Username: zuul 2026-03-17 18:55:42.859863 | localhost | Distro: Debian 13.3 2026-03-17 18:55:42.859893 | localhost | Provider: yul1 2026-03-17 18:55:42.859922 | localhost | Region: ca-ymq-1 2026-03-17 18:55:42.859950 | localhost | Label: debian-trixie 2026-03-17 18:55:42.859978 | localhost | Product Name: OpenStack Nova 2026-03-17 18:55:42.860006 | localhost | Interface IP: 199.204.45.95 2026-03-17 18:55:42.878910 | 2026-03-17 18:55:42.879073 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 18:55:43.239232 | localhost -> localhost | changed 2026-03-17 18:55:43.247568 | 2026-03-17 18:55:43.247675 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 18:55:44.081526 | localhost -> localhost | changed 2026-03-17 18:55:44.090046 | 2026-03-17 18:55:44.090125 | PLAY [all] 2026-03-17 18:55:44.099034 | 2026-03-17 18:55:44.099101 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 18:55:44.305140 | controller -> localhost | ok 2026-03-17 18:55:44.312543 | 2026-03-17 18:55:44.312628 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 18:55:44.341930 | controller | ok 2026-03-17 18:55:44.357460 | controller | included: /var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 18:55:44.361834 | 2026-03-17 18:55:44.361891 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 18:55:46.019121 | controller -> localhost | Generating public/private rsa key pair. 2026-03-17 18:55:46.019286 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/7db1d360ed084070b3f3d92adc6a692e_id_rsa 2026-03-17 18:55:46.019317 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/7db1d360ed084070b3f3d92adc6a692e_id_rsa.pub 2026-03-17 18:55:46.019339 | controller -> localhost | The key fingerprint is: 2026-03-17 18:55:46.019361 | controller -> localhost | SHA256:WImZfuzE+bcS4rGZEKLxKcKCQqJVATy1Ts2U18424dM zuul-build-sshkey 2026-03-17 18:55:46.019395 | controller -> localhost | The key's randomart image is: 2026-03-17 18:55:46.019416 | controller -> localhost | +---[RSA 3072]----+ 2026-03-17 18:55:46.019440 | controller -> localhost | | ..oo... . | 2026-03-17 18:55:46.019462 | controller -> localhost | | o .=.+..o | 2026-03-17 18:55:46.019482 | controller -> localhost | | oo *.o+ o | 2026-03-17 18:55:46.019503 | controller -> localhost | |..oo...= .B E | 2026-03-17 18:55:46.019522 | controller -> localhost | |*. +.oo.S. o | 2026-03-17 18:55:46.019541 | controller -> localhost | |*.o o .+o.. | 2026-03-17 18:55:46.019560 | controller -> localhost | |o. . o.*... | 2026-03-17 18:55:46.019580 | controller -> localhost | | = .. . | 2026-03-17 18:55:46.019601 | controller -> localhost | | .. | 2026-03-17 18:55:46.019621 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 18:55:46.019669 | controller -> localhost | ok: Runtime: 0:00:01.297554 2026-03-17 18:55:46.024447 | 2026-03-17 18:55:46.024513 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 18:55:46.051422 | controller | ok 2026-03-17 18:55:46.070275 | controller | included: /var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 18:55:46.077725 | 2026-03-17 18:55:46.077787 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 18:55:46.101743 | controller | skipping: Conditional result was False 2026-03-17 18:55:46.108208 | 2026-03-17 18:55:46.108290 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 18:55:46.614816 | controller | changed 2026-03-17 18:55:46.619941 | 2026-03-17 18:55:46.620020 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 18:55:46.824232 | controller | ok 2026-03-17 18:55:46.829979 | 2026-03-17 18:55:46.830281 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 18:55:47.370380 | controller | changed 2026-03-17 18:55:47.376902 | 2026-03-17 18:55:47.543376 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 18:55:48.070751 | controller | changed 2026-03-17 18:55:48.076395 | 2026-03-17 18:55:48.076517 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 18:55:48.099731 | controller | skipping: Conditional result was False 2026-03-17 18:55:48.108871 | 2026-03-17 18:55:48.109026 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 18:55:48.557122 | controller -> localhost | changed 2026-03-17 18:55:48.569021 | 2026-03-17 18:55:48.569093 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 18:55:48.830141 | controller -> localhost | Identity added: /var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/7db1d360ed084070b3f3d92adc6a692e_id_rsa (zuul-build-sshkey) 2026-03-17 18:55:48.830345 | controller -> localhost | ok: Runtime: 0:00:00.014364 2026-03-17 18:55:48.835756 | 2026-03-17 18:55:48.835816 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 18:55:49.156898 | controller | ok 2026-03-17 18:55:49.160461 | 2026-03-17 18:55:49.160518 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 18:55:49.183838 | controller | skipping: Conditional result was False 2026-03-17 18:55:49.195000 | 2026-03-17 18:55:49.195085 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 18:55:49.548976 | controller | ok 2026-03-17 18:55:49.558068 | 2026-03-17 18:55:49.558160 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 18:55:50.592805 | controller | Output suppressed because no_log was given 2026-03-17 18:55:50.602303 | 2026-03-17 18:55:50.602399 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 18:55:50.817035 | controller | ok: "logs" 2026-03-17 18:55:50.817253 | controller | ok: All items complete 2026-03-17 18:55:50.817283 | 2026-03-17 18:55:50.993336 | controller | ok: "artifacts" 2026-03-17 18:55:51.167352 | controller | ok: "docs" 2026-03-17 18:55:51.186788 | 2026-03-17 18:55:51.186942 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 18:55:51.392307 | controller | changed: "logs" 2026-03-17 18:55:51.598863 | controller | changed: "artifacts" 2026-03-17 18:55:51.779809 | controller | changed: "docs" 2026-03-17 18:55:51.802953 | 2026-03-17 18:55:51.803072 | PLAY RECAP 2026-03-17 18:55:51.803134 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-17 18:55:51.803176 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 18:55:51.803209 | 2026-03-17 18:55:51.918398 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 18:55:51.920836 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 18:55:52.454877 | 2026-03-17 18:55:52.454980 | PLAY [all] 2026-03-17 18:55:52.464695 | 2026-03-17 18:55:52.464770 | TASK [setup-uv : Extract archive] 2026-03-17 18:55:54.879371 | controller | changed 2026-03-17 18:55:54.885914 | 2026-03-17 18:55:54.886014 | TASK [setup-uv : Print version] 2026-03-17 18:55:55.241930 | controller | uv 0.8.13 2026-03-17 18:55:55.414084 | controller | ok: Runtime: 0:00:00.011800 2026-03-17 18:55:55.420599 | 2026-03-17 18:55:55.420663 | PLAY RECAP 2026-03-17 18:55:55.420721 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 18:55:55.420756 | 2026-03-17 18:55:55.521048 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 18:55:55.523482 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 18:55:56.052889 | 2026-03-17 18:55:56.053060 | PLAY [all] 2026-03-17 18:55:56.062346 | 2026-03-17 18:55:56.062417 | TASK [Copy inventory file for Zuul] 2026-03-17 18:55:57.005839 | controller | changed 2026-03-17 18:55:57.011584 | 2026-03-17 18:55:57.011687 | TASK [Switch "ansible_host" to private IP] 2026-03-17 18:55:57.301963 | controller | changed: 1 replacements made 2026-03-17 18:55:57.308394 | 2026-03-17 18:55:57.308469 | TASK [Run Molecule scenario] 2026-03-17 18:55:57.737969 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-17 18:55:57.738075 | controller | Creating virtual environment at: .venv 2026-03-17 18:55:58.025319 | controller | Downloading pygments (1.2MiB) 2026-03-17 18:55:58.027338 | controller | Downloading ansible-core (2.3MiB) 2026-03-17 18:55:58.035565 | controller | Downloading cryptography (4.3MiB) 2026-03-17 18:55:58.189512 | controller | Downloading cryptography 2026-03-17 18:55:58.248971 | controller | Downloading pygments 2026-03-17 18:55:58.430039 | controller | Downloading ansible-core 2026-03-17 18:55:58.480839 | controller | Installed 36 packages in 50ms 2026-03-17 18:55:59.153126 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-17 18:55:59.153161 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-17 18:55:59.994905 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-17 18:55:59.994998 | controller | INFO default scenario not found, disabling shared state. 2026-03-17 18:55:59.995025 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-17 18:55:59.995037 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-17 18:56:14.666062 | controller | INFO [helm > dependency] Executing 2026-03-17 18:56:14.666320 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-17 18:56:14.666674 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-17 18:56:14.666843 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-17 18:56:14.673609 | controller | INFO [helm > cleanup] Executing 2026-03-17 18:56:14.674049 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 18:56:14.680128 | controller | INFO [helm > destroy] Executing 2026-03-17 18:56:14.680156 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 18:56:14.680257 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 18:56:14.685756 | controller | INFO [helm > syntax] Executing 2026-03-17 18:56:15.567603 | controller | 2026-03-17 18:56:15.567824 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-17 18:56:15.648829 | controller | INFO [helm > syntax] Executed: Successful 2026-03-17 18:56:15.659447 | controller | INFO [helm > create] Executing 2026-03-17 18:56:15.661407 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 18:56:15.667329 | controller | INFO [helm > prepare] Executing 2026-03-17 18:56:16.501763 | controller | 2026-03-17 18:56:16.501859 | controller | PLAY [Prepare] ***************************************************************** 2026-03-17 18:56:16.502057 | controller | 2026-03-17 18:56:16.502271 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 18:56:16.502474 | controller | Tuesday 17 March 2026 18:56:16 +0000 (0:00:00.029) 0:00:00.029 ********* 2026-03-17 18:56:17.788369 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 18:56:17.794011 | controller | ok: [controller] 2026-03-17 18:56:17.794182 | controller | 2026-03-17 18:56:17.794373 | controller | TASK [Install Debian packages] ************************************************* 2026-03-17 18:56:17.794638 | controller | Tuesday 17 March 2026 18:56:17 +0000 (0:00:01.293) 0:00:01.322 ********* 2026-03-17 18:56:22.903231 | controller | ok: [controller] 2026-03-17 18:56:22.903282 | controller | 2026-03-17 18:56:22.903376 | controller | PLAY RECAP ********************************************************************* 2026-03-17 18:56:22.903559 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 18:56:22.903621 | controller | 2026-03-17 18:56:22.903779 | controller | 2026-03-17 18:56:22.903846 | controller | TASKS RECAP ******************************************************************** 2026-03-17 18:56:22.903978 | controller | Tuesday 17 March 2026 18:56:22 +0000 (0:00:05.107) 0:00:06.430 ********* 2026-03-17 18:56:22.904080 | controller | =============================================================================== 2026-03-17 18:56:22.904210 | controller | Install Debian packages ------------------------------------------------- 5.11s 2026-03-17 18:56:22.904318 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-03-17 18:56:22.998853 | controller | INFO [helm > prepare] Executed: Successful 2026-03-17 18:56:23.008175 | controller | INFO [helm > converge] Executing 2026-03-17 18:56:23.876993 | controller | 2026-03-17 18:56:23.877161 | controller | PLAY [Converge] **************************************************************** 2026-03-17 18:56:23.877341 | controller | 2026-03-17 18:56:23.877546 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 18:56:23.877744 | controller | Tuesday 17 March 2026 18:56:23 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-17 18:56:24.983136 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 18:56:24.986535 | controller | ok: [controller] 2026-03-17 18:56:24.986600 | controller | 2026-03-17 18:56:24.986698 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 18:56:24.986786 | controller | Tuesday 17 March 2026 18:56:24 +0000 (0:00:01.109) 0:00:01.122 ********* 2026-03-17 18:56:25.454760 | controller | ok: [controller] 2026-03-17 18:56:25.454886 | controller | 2026-03-17 18:56:25.455107 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 18:56:25.455300 | controller | Tuesday 17 March 2026 18:56:25 +0000 (0:00:00.467) 0:00:01.590 ********* 2026-03-17 18:56:26.615908 | controller | ok: [controller] 2026-03-17 18:56:26.615999 | controller | 2026-03-17 18:56:26.616273 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 18:56:26.616467 | controller | Tuesday 17 March 2026 18:56:26 +0000 (0:00:01.161) 0:00:02.751 ********* 2026-03-17 18:56:27.058743 | controller | changed: [controller] 2026-03-17 18:56:27.058894 | controller | 2026-03-17 18:56:27.059128 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 18:56:27.059337 | controller | Tuesday 17 March 2026 18:56:27 +0000 (0:00:00.443) 0:00:03.194 ********* 2026-03-17 18:56:27.113864 | controller | ok: [controller] => { 2026-03-17 18:56:27.114042 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 18:56:27.114225 | controller | } 2026-03-17 18:56:27.114444 | controller | 2026-03-17 18:56:27.114648 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 18:56:27.114840 | controller | Tuesday 17 March 2026 18:56:27 +0000 (0:00:00.055) 0:00:03.249 ********* 2026-03-17 18:56:28.099007 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-17 18:56:28.109362 | controller | changed: [controller] 2026-03-17 18:56:28.109512 | controller | 2026-03-17 18:56:28.109724 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 18:56:28.109938 | controller | Tuesday 17 March 2026 18:56:28 +0000 (0:00:00.995) 0:00:04.244 ********* 2026-03-17 18:56:30.135859 | controller | changed: [controller] 2026-03-17 18:56:30.136026 | controller | 2026-03-17 18:56:30.136237 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 18:56:30.136433 | controller | Tuesday 17 March 2026 18:56:30 +0000 (0:00:02.026) 0:00:06.270 ********* 2026-03-17 18:56:30.634203 | controller | ok: [controller] 2026-03-17 18:56:30.634382 | controller | 2026-03-17 18:56:30.634659 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 18:56:30.634852 | controller | Tuesday 17 March 2026 18:56:30 +0000 (0:00:00.498) 0:00:06.769 ********* 2026-03-17 18:56:31.029448 | controller | changed: [controller] 2026-03-17 18:56:31.029571 | controller | 2026-03-17 18:56:31.029777 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 18:56:31.029972 | controller | Tuesday 17 March 2026 18:56:31 +0000 (0:00:00.395) 0:00:07.164 ********* 2026-03-17 18:56:31.476891 | controller | ok: [controller] 2026-03-17 18:56:31.477036 | controller | 2026-03-17 18:56:31.477255 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 18:56:31.477451 | controller | Tuesday 17 March 2026 18:56:31 +0000 (0:00:00.447) 0:00:07.612 ********* 2026-03-17 18:56:31.807321 | controller | changed: [controller] 2026-03-17 18:56:31.807461 | controller | 2026-03-17 18:56:31.807728 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 18:56:31.807886 | controller | Tuesday 17 March 2026 18:56:31 +0000 (0:00:00.329) 0:00:07.942 ********* 2026-03-17 18:56:32.096811 | controller | ok: [controller] 2026-03-17 18:56:32.096987 | controller | 2026-03-17 18:56:32.097192 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 18:56:32.097403 | controller | Tuesday 17 March 2026 18:56:32 +0000 (0:00:00.290) 0:00:08.232 ********* 2026-03-17 18:56:32.149895 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 18:56:32.150206 | controller | 2026-03-17 18:56:32.150408 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 18:56:32.150647 | controller | Tuesday 17 March 2026 18:56:32 +0000 (0:00:00.053) 0:00:08.285 ********* 2026-03-17 18:56:32.192640 | controller | ok: [controller] => { 2026-03-17 18:56:32.192805 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 18:56:32.193070 | controller | } 2026-03-17 18:56:32.193190 | controller | 2026-03-17 18:56:32.193455 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 18:56:32.193576 | controller | Tuesday 17 March 2026 18:56:32 +0000 (0:00:00.042) 0:00:08.328 ********* 2026-03-17 18:56:32.965454 | controller | changed: [controller] 2026-03-17 18:56:32.965617 | controller | 2026-03-17 18:56:32.965824 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 18:56:32.966024 | controller | Tuesday 17 March 2026 18:56:32 +0000 (0:00:00.772) 0:00:09.100 ********* 2026-03-17 18:56:35.011216 | controller | changed: [controller] 2026-03-17 18:56:35.011368 | controller | 2026-03-17 18:56:35.011567 | controller | PLAY RECAP ********************************************************************* 2026-03-17 18:56:35.011784 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 18:56:35.011952 | controller | 2026-03-17 18:56:35.012118 | controller | 2026-03-17 18:56:35.012296 | controller | TASKS RECAP ******************************************************************** 2026-03-17 18:56:35.012565 | controller | Tuesday 17 March 2026 18:56:35 +0000 (0:00:02.046) 0:00:11.147 ********* 2026-03-17 18:56:35.012742 | controller | =============================================================================== 2026-03-17 18:56:35.012941 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.05s 2026-03-17 18:56:35.013133 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.03s 2026-03-17 18:56:35.013325 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.16s 2026-03-17 18:56:35.013508 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-17 18:56:35.013683 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.00s 2026-03-17 18:56:35.013872 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.77s 2026-03-17 18:56:35.014058 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-03-17 18:56:35.014245 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.47s 2026-03-17 18:56:35.014432 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-17 18:56:35.014687 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-03-17 18:56:35.014877 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-17 18:56:35.015073 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-03-17 18:56:35.015272 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-17 18:56:35.015464 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-17 18:56:35.015649 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-17 18:56:35.015835 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 18:56:35.177862 | controller | INFO [helm > converge] Executed: Successful 2026-03-17 18:56:35.187929 | controller | INFO [helm > idempotence] Executing 2026-03-17 18:56:36.037357 | controller | 2026-03-17 18:56:36.037541 | controller | PLAY [Converge] **************************************************************** 2026-03-17 18:56:36.037800 | controller | 2026-03-17 18:56:36.038008 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 18:56:36.038212 | controller | Tuesday 17 March 2026 18:56:36 +0000 (0:00:00.016) 0:00:00.016 ********* 2026-03-17 18:56:37.098274 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 18:56:37.103472 | controller | ok: [controller] 2026-03-17 18:56:37.103674 | controller | 2026-03-17 18:56:37.103888 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 18:56:37.104094 | controller | Tuesday 17 March 2026 18:56:37 +0000 (0:00:01.066) 0:00:01.083 ********* 2026-03-17 18:56:37.521781 | controller | ok: [controller] 2026-03-17 18:56:37.521989 | controller | 2026-03-17 18:56:37.522220 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 18:56:37.522436 | controller | Tuesday 17 March 2026 18:56:37 +0000 (0:00:00.417) 0:00:01.500 ********* 2026-03-17 18:56:38.509412 | controller | ok: [controller] 2026-03-17 18:56:38.509567 | controller | 2026-03-17 18:56:38.509781 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 18:56:38.509981 | controller | Tuesday 17 March 2026 18:56:38 +0000 (0:00:00.976) 0:00:02.476 ********* 2026-03-17 18:56:38.944003 | controller | ok: [controller] 2026-03-17 18:56:38.944061 | controller | 2026-03-17 18:56:38.944323 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 18:56:38.944477 | controller | Tuesday 17 March 2026 18:56:38 +0000 (0:00:00.446) 0:00:02.922 ********* 2026-03-17 18:56:39.004242 | controller | ok: [controller] => { 2026-03-17 18:56:39.004461 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 18:56:39.004603 | controller | } 2026-03-17 18:56:39.004827 | controller | 2026-03-17 18:56:39.004982 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 18:56:39.005185 | controller | Tuesday 17 March 2026 18:56:38 +0000 (0:00:00.060) 0:00:02.983 ********* 2026-03-17 18:56:39.580965 | controller | ok: [controller] 2026-03-17 18:56:39.581008 | controller | 2026-03-17 18:56:39.581018 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 18:56:39.581026 | controller | Tuesday 17 March 2026 18:56:39 +0000 (0:00:00.576) 0:00:03.559 ********* 2026-03-17 18:56:41.263016 | controller | ok: [controller] 2026-03-17 18:56:41.263071 | controller | 2026-03-17 18:56:41.263086 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 18:56:41.263189 | controller | Tuesday 17 March 2026 18:56:41 +0000 (0:00:01.681) 0:00:05.241 ********* 2026-03-17 18:56:41.756504 | controller | ok: [controller] 2026-03-17 18:56:41.756550 | controller | 2026-03-17 18:56:41.756606 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 18:56:41.756725 | controller | Tuesday 17 March 2026 18:56:41 +0000 (0:00:00.492) 0:00:05.733 ********* 2026-03-17 18:56:42.172059 | controller | ok: [controller] 2026-03-17 18:56:42.172184 | controller | 2026-03-17 18:56:42.172195 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 18:56:42.172203 | controller | Tuesday 17 March 2026 18:56:42 +0000 (0:00:00.413) 0:00:06.147 ********* 2026-03-17 18:56:42.625763 | controller | ok: [controller] 2026-03-17 18:56:42.625856 | controller | 2026-03-17 18:56:42.625866 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 18:56:42.625946 | controller | Tuesday 17 March 2026 18:56:42 +0000 (0:00:00.456) 0:00:06.603 ********* 2026-03-17 18:56:42.929181 | controller | ok: [controller] 2026-03-17 18:56:42.929268 | controller | 2026-03-17 18:56:42.929412 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 18:56:42.929543 | controller | Tuesday 17 March 2026 18:56:42 +0000 (0:00:00.305) 0:00:06.908 ********* 2026-03-17 18:56:43.245517 | controller | ok: [controller] 2026-03-17 18:56:43.245619 | controller | 2026-03-17 18:56:43.245739 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 18:56:43.245826 | controller | Tuesday 17 March 2026 18:56:43 +0000 (0:00:00.316) 0:00:07.224 ********* 2026-03-17 18:56:43.306280 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 18:56:43.306372 | controller | 2026-03-17 18:56:43.306379 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 18:56:43.306433 | controller | Tuesday 17 March 2026 18:56:43 +0000 (0:00:00.058) 0:00:07.283 ********* 2026-03-17 18:56:43.348019 | controller | ok: [controller] => { 2026-03-17 18:56:43.348215 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 18:56:43.349051 | controller | } 2026-03-17 18:56:43.349094 | controller | 2026-03-17 18:56:43.349104 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 18:56:43.349112 | controller | Tuesday 17 March 2026 18:56:43 +0000 (0:00:00.043) 0:00:07.327 ********* 2026-03-17 18:56:43.786817 | controller | ok: [controller] 2026-03-17 18:56:43.786870 | controller | 2026-03-17 18:56:43.786931 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 18:56:43.787039 | controller | Tuesday 17 March 2026 18:56:43 +0000 (0:00:00.439) 0:00:07.766 ********* 2026-03-17 18:56:45.451020 | controller | ok: [controller] 2026-03-17 18:56:45.451072 | controller | 2026-03-17 18:56:45.451086 | controller | PLAY RECAP ********************************************************************* 2026-03-17 18:56:45.451210 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 18:56:45.451284 | controller | 2026-03-17 18:56:45.451363 | controller | 2026-03-17 18:56:45.451434 | controller | TASKS RECAP ******************************************************************** 2026-03-17 18:56:45.451535 | controller | Tuesday 17 March 2026 18:56:45 +0000 (0:00:01.661) 0:00:09.428 ********* 2026-03-17 18:56:45.451604 | controller | =============================================================================== 2026-03-17 18:56:45.452924 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s 2026-03-17 18:56:45.452956 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-03-17 18:56:45.452959 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-17 18:56:45.452963 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.98s 2026-03-17 18:56:45.452966 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.58s 2026-03-17 18:56:45.452970 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s 2026-03-17 18:56:45.452973 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-03-17 18:56:45.452976 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-17 18:56:45.452980 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s 2026-03-17 18:56:45.452984 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s 2026-03-17 18:56:45.452994 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-17 18:56:45.452997 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-17 18:56:45.453001 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-17 18:56:45.453004 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-17 18:56:45.453008 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-17 18:56:45.453011 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 18:56:45.567502 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-17 18:56:45.576658 | controller | INFO [helm > side_effect] Executing 2026-03-17 18:56:45.577121 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 18:56:45.584017 | controller | INFO [helm > verify] Executing 2026-03-17 18:56:46.388017 | controller | 2026-03-17 18:56:46.388287 | controller | PLAY [Verify] ****************************************************************** 2026-03-17 18:56:46.388411 | controller | 2026-03-17 18:56:46.388523 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 18:56:46.388635 | controller | Tuesday 17 March 2026 18:56:46 +0000 (0:00:00.009) 0:00:00.009 ********* 2026-03-17 18:56:47.432717 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 18:56:47.443929 | controller | ok: [controller] 2026-03-17 18:56:47.444112 | controller | 2026-03-17 18:56:47.444304 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-17 18:56:47.444491 | controller | Tuesday 17 March 2026 18:56:47 +0000 (0:00:01.050) 0:00:01.059 ********* 2026-03-17 18:56:47.901992 | controller | changed: [controller] 2026-03-17 18:56:47.902037 | controller | 2026-03-17 18:56:47.902083 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-17 18:56:47.902171 | controller | Tuesday 17 March 2026 18:56:47 +0000 (0:00:00.463) 0:00:01.523 ********* 2026-03-17 18:56:47.935252 | controller | ok: [controller] => { 2026-03-17 18:56:47.935475 | controller | "changed": false, 2026-03-17 18:56:47.935669 | controller | "msg": "All assertions passed" 2026-03-17 18:56:47.935814 | controller | } 2026-03-17 18:56:47.935977 | controller | 2026-03-17 18:56:47.936160 | controller | PLAY RECAP ********************************************************************* 2026-03-17 18:56:47.936371 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 18:56:47.936530 | controller | 2026-03-17 18:56:47.936693 | controller | 2026-03-17 18:56:47.936873 | controller | TASKS RECAP ******************************************************************** 2026-03-17 18:56:47.937061 | controller | Tuesday 17 March 2026 18:56:47 +0000 (0:00:00.030) 0:00:01.554 ********* 2026-03-17 18:56:47.937235 | controller | =============================================================================== 2026-03-17 18:56:47.937424 | controller | Gathering Facts --------------------------------------------------------- 1.05s 2026-03-17 18:56:47.937609 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-03-17 18:56:47.937790 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-17 18:56:48.032243 | controller | INFO [helm > verify] Executed: Successful 2026-03-17 18:56:48.042541 | controller | INFO [helm > cleanup] Executing 2026-03-17 18:56:48.042876 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 18:56:48.048184 | controller | INFO [helm > destroy] Executing 2026-03-17 18:56:48.048208 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 18:56:48.048258 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 18:56:48.048587 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-17 18:56:48.534084 | controller | ok: Runtime: 0:00:50.474719 2026-03-17 18:56:48.540630 | 2026-03-17 18:56:48.540682 | PLAY RECAP 2026-03-17 18:56:48.540727 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 18:56:48.540749 | 2026-03-17 18:56:48.640291 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 18:56:48.642338 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 18:56:49.191993 | 2026-03-17 18:56:49.192136 | PLAY [all] 2026-03-17 18:56:49.202222 | 2026-03-17 18:56:49.202300 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 18:56:49.236037 | controller | skipping: Conditional result was False 2026-03-17 18:56:49.241600 | 2026-03-17 18:56:49.241698 | TASK [fetch-output : Set log path for single node] 2026-03-17 18:56:49.282280 | controller | ok 2026-03-17 18:56:49.287048 | 2026-03-17 18:56:49.287126 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 18:56:49.647649 | controller -> localhost | ok: "/var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/logs" 2026-03-17 18:56:49.851552 | controller -> localhost | changed: "/var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/artifacts" 2026-03-17 18:56:50.049834 | controller -> localhost | changed: "/var/lib/zuul/builds/7db1d360ed084070b3f3d92adc6a692e/work/docs" 2026-03-17 18:56:50.070825 | 2026-03-17 18:56:50.070954 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 18:56:50.695881 | controller | ok 2026-03-17 18:56:50.696121 | controller | changed: All items complete 2026-03-17 18:56:50.696150 | 2026-03-17 18:56:51.162606 | controller | changed: .d..t...... ./ 2026-03-17 18:56:51.644901 | controller | changed: .d..t...... ./ 2026-03-17 18:56:51.661423 | 2026-03-17 18:56:51.661534 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 18:56:52.067435 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007099 2026-03-17 18:56:52.294724 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.005758 2026-03-17 18:56:52.309017 | 2026-03-17 18:56:52.309073 | PLAY [all] 2026-03-17 18:56:52.313621 | 2026-03-17 18:56:52.313681 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-17 18:56:52.766186 | controller | changed 2026-03-17 18:56:52.772462 | 2026-03-17 18:56:52.772507 | PLAY RECAP 2026-03-17 18:56:52.772549 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-17 18:56:52.772571 | 2026-03-17 18:56:52.857879 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 18:56:52.860417 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-17 18:56:53.383175 | 2026-03-17 18:56:53.383286 | PLAY [localhost] 2026-03-17 18:56:53.392745 | 2026-03-17 18:56:53.392815 | TASK [Generate Zuul manifest] 2026-03-17 18:56:53.412260 | localhost | ok 2026-03-17 18:56:53.428373 | 2026-03-17 18:56:53.428458 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 18:56:53.742772 | localhost | changed 2026-03-17 18:56:53.753630 | 2026-03-17 18:56:53.753702 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 18:56:53.783907 | localhost | ok 2026-03-17 18:56:53.793203 | 2026-03-17 18:56:53.793267 | TASK [Upload logs] 2026-03-17 18:56:53.811743 | localhost | ok 2026-03-17 18:56:53.870871 | 2026-03-17 18:56:53.871000 | TASK [Set zuul-log-path fact] 2026-03-17 18:56:53.891145 | localhost | ok 2026-03-17 18:56:53.902649 | 2026-03-17 18:56:53.902718 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 18:56:53.934759 | localhost | ok 2026-03-17 18:56:53.943487 | 2026-03-17 18:56:53.943560 | TASK [upload-logs : Create log directories] 2026-03-17 18:56:54.351549 | localhost | changed 2026-03-17 18:56:54.357524 | 2026-03-17 18:56:54.357614 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-17 18:56:54.743892 | localhost -> localhost | ok: Runtime: 0:00:00.005206 2026-03-17 18:56:54.749984 | 2026-03-17 18:56:54.750050 | TASK [upload-logs : Upload logs to log server] 2026-03-17 18:56:55.207546 | localhost | Output suppressed because no_log was given 2026-03-17 18:56:55.214067 | 2026-03-17 18:56:55.214150 | LOOP [upload-logs : Compress console log and json output] 2026-03-17 18:56:55.255150 | localhost | skipping: Conditional result was False 2026-03-17 18:56:55.261752 | localhost | skipping: Conditional result was False 2026-03-17 18:56:55.283996 | 2026-03-17 18:56:55.284121 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-17 18:56:55.324018 | localhost | skipping: Conditional result was False 2026-03-17 18:56:55.324361 | 2026-03-17 18:56:55.328163 | localhost | skipping: Conditional result was False 2026-03-17 18:56:55.348761 | 2026-03-17 18:56:55.348924 | LOOP [upload-logs : Upload console log and json output]