2026-03-17 14:01:14.276978 | Job console starting 2026-03-17 14:01:14.304088 | Updating git repos 2026-03-17 14:01:14.356458 | Cloning repos into workspace 2026-03-17 14:01:14.741926 | Restoring repo states 2026-03-17 14:01:14.816813 | Merging changes 2026-03-17 14:01:15.804359 | Checking out repos 2026-03-17 14:01:15.988545 | Preparing playbooks 2026-03-17 14:01:18.498759 | Running Ansible setup 2026-03-17 14:01:22.215809 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 14:01:22.762505 | 2026-03-17 14:01:22.762609 | PLAY [localhost] 2026-03-17 14:01:22.769559 | 2026-03-17 14:01:22.769628 | TASK [Gathering Facts] 2026-03-17 14:01:23.780707 | localhost | ok 2026-03-17 14:01:23.793391 | 2026-03-17 14:01:23.793500 | TASK [Setup log path fact] 2026-03-17 14:01:23.815034 | localhost | ok 2026-03-17 14:01:23.827571 | 2026-03-17 14:01:23.827645 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 14:01:23.856042 | localhost | ok 2026-03-17 14:01:23.863938 | 2026-03-17 14:01:23.864008 | TASK [emit-job-header : Print job information] 2026-03-17 14:01:23.904114 | # Job Information 2026-03-17 14:01:23.904306 | Ansible Version: 2.16.16 2026-03-17 14:01:23.904366 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-17 14:01:23.904408 | Pipeline: check 2026-03-17 14:01:23.904445 | Executor: 0a8996d2b663 2026-03-17 14:01:23.904482 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-17 14:01:23.904525 | Event ID: 99ded8b0-2207-11f1-8026-f2420cbb33b9 2026-03-17 14:01:23.908333 | 2026-03-17 14:01:23.908403 | LOOP [emit-job-header : Print node information] 2026-03-17 14:01:23.990536 | localhost | ok: 2026-03-17 14:01:24.050344 | localhost | # Node Information 2026-03-17 14:01:24.050540 | localhost | Inventory Hostname: controller 2026-03-17 14:01:24.050604 | localhost | Hostname: np0000159361 2026-03-17 14:01:24.050655 | localhost | Username: zuul 2026-03-17 14:01:24.050776 | localhost | Distro: Debian 13.3 2026-03-17 14:01:24.050840 | localhost | Provider: yul1 2026-03-17 14:01:24.050893 | localhost | Region: ca-ymq-1 2026-03-17 14:01:24.050941 | localhost | Label: debian-trixie 2026-03-17 14:01:24.050989 | localhost | Product Name: OpenStack Nova 2026-03-17 14:01:24.051036 | localhost | Interface IP: 199.19.213.83 2026-03-17 14:01:24.067069 | 2026-03-17 14:01:24.067237 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 14:01:24.426018 | localhost -> localhost | changed 2026-03-17 14:01:24.433587 | 2026-03-17 14:01:24.433702 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 14:01:25.457557 | localhost -> localhost | changed 2026-03-17 14:01:25.470725 | 2026-03-17 14:01:25.470784 | PLAY [all] 2026-03-17 14:01:25.477145 | 2026-03-17 14:01:25.477210 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 14:01:25.682545 | controller -> localhost | ok 2026-03-17 14:01:25.691634 | 2026-03-17 14:01:25.691770 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 14:01:25.722321 | controller | ok 2026-03-17 14:01:25.740121 | controller | included: /var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 14:01:25.744504 | 2026-03-17 14:01:25.744561 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 14:01:26.433531 | controller -> localhost | Generating public/private rsa key pair. 2026-03-17 14:01:26.433721 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/fae7593ad814455799df8a4b39fea3b9_id_rsa 2026-03-17 14:01:26.433770 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/fae7593ad814455799df8a4b39fea3b9_id_rsa.pub 2026-03-17 14:01:26.433809 | controller -> localhost | The key fingerprint is: 2026-03-17 14:01:26.433846 | controller -> localhost | SHA256:twIaPeNryorLVaIhHd+0S7Ww3nIKSuyr9CV51+yuuoM zuul-build-sshkey 2026-03-17 14:01:26.433894 | controller -> localhost | The key's randomart image is: 2026-03-17 14:01:26.433925 | controller -> localhost | +---[RSA 3072]----+ 2026-03-17 14:01:26.433962 | controller -> localhost | | | 2026-03-17 14:01:26.433993 | controller -> localhost | | | 2026-03-17 14:01:26.434022 | controller -> localhost | | . o . | 2026-03-17 14:01:26.434051 | controller -> localhost | | . o + = . | 2026-03-17 14:01:26.434079 | controller -> localhost | |....o.X S . | 2026-03-17 14:01:26.434107 | controller -> localhost | |..o +* *o. . | 2026-03-17 14:01:26.434135 | controller -> localhost | | oo++o=.+o. | 2026-03-17 14:01:26.434163 | controller -> localhost | |o+oE+oo=.. | 2026-03-17 14:01:26.434194 | controller -> localhost | |++=+o=*.oo | 2026-03-17 14:01:26.434223 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 14:01:26.434284 | controller -> localhost | ok: Runtime: 0:00:00.223383 2026-03-17 14:01:26.440000 | 2026-03-17 14:01:26.440078 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 14:01:26.459032 | controller | ok 2026-03-17 14:01:26.466863 | controller | included: /var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 14:01:26.473056 | 2026-03-17 14:01:26.473113 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 14:01:26.496076 | controller | skipping: Conditional result was False 2026-03-17 14:01:26.505663 | 2026-03-17 14:01:26.505797 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 14:01:27.029043 | controller | changed 2026-03-17 14:01:27.035225 | 2026-03-17 14:01:27.035328 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 14:01:27.249074 | controller | ok 2026-03-17 14:01:27.255017 | 2026-03-17 14:01:27.255111 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 14:01:27.922549 | controller | changed 2026-03-17 14:01:27.931122 | 2026-03-17 14:01:27.931203 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 14:01:28.456716 | controller | changed 2026-03-17 14:01:28.462883 | 2026-03-17 14:01:28.462997 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 14:01:28.488504 | controller | skipping: Conditional result was False 2026-03-17 14:01:28.498435 | 2026-03-17 14:01:28.498535 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 14:01:28.845810 | controller -> localhost | changed 2026-03-17 14:01:28.858798 | 2026-03-17 14:01:28.858912 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 14:01:29.117348 | controller -> localhost | Identity added: /var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/fae7593ad814455799df8a4b39fea3b9_id_rsa (zuul-build-sshkey) 2026-03-17 14:01:29.117623 | controller -> localhost | ok: Runtime: 0:00:00.012724 2026-03-17 14:01:29.123341 | 2026-03-17 14:01:29.123421 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 14:01:29.449941 | controller | ok 2026-03-17 14:01:29.454991 | 2026-03-17 14:01:29.455076 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 14:01:29.488574 | controller | skipping: Conditional result was False 2026-03-17 14:01:29.501499 | 2026-03-17 14:01:29.501589 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 14:01:29.857422 | controller | ok 2026-03-17 14:01:29.866044 | 2026-03-17 14:01:29.866174 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 14:01:30.969681 | controller | Output suppressed because no_log was given 2026-03-17 14:01:30.979908 | 2026-03-17 14:01:30.980008 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 14:01:31.197646 | controller | ok: "logs" 2026-03-17 14:01:31.197959 | controller | ok: All items complete 2026-03-17 14:01:31.198010 | 2026-03-17 14:01:31.380980 | controller | ok: "artifacts" 2026-03-17 14:01:31.581374 | controller | ok: "docs" 2026-03-17 14:01:31.590854 | 2026-03-17 14:01:31.591061 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 14:01:31.814597 | controller | changed: "logs" 2026-03-17 14:01:32.003613 | controller | changed: "artifacts" 2026-03-17 14:01:32.237813 | controller | changed: "docs" 2026-03-17 14:01:32.257452 | 2026-03-17 14:01:32.257560 | PLAY RECAP 2026-03-17 14:01:32.257625 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-17 14:01:32.257668 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 14:01:32.257697 | 2026-03-17 14:01:32.374483 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 14:01:32.377009 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 14:01:32.937083 | 2026-03-17 14:01:32.937885 | PLAY [all] 2026-03-17 14:01:32.949023 | 2026-03-17 14:01:32.949136 | TASK [setup-uv : Extract archive] 2026-03-17 14:01:36.372600 | controller | changed 2026-03-17 14:01:36.382110 | 2026-03-17 14:01:36.382312 | TASK [setup-uv : Print version] 2026-03-17 14:01:36.753867 | controller | uv 0.8.13 2026-03-17 14:01:36.914666 | controller | ok: Runtime: 0:00:00.013366 2026-03-17 14:01:36.921548 | 2026-03-17 14:01:36.921639 | PLAY RECAP 2026-03-17 14:01:36.921714 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 14:01:36.921756 | 2026-03-17 14:01:37.025689 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 14:01:37.027350 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 14:01:37.604254 | 2026-03-17 14:01:37.604385 | PLAY [all] 2026-03-17 14:01:37.614313 | 2026-03-17 14:01:37.614403 | TASK [Copy inventory file for Zuul] 2026-03-17 14:01:38.610392 | controller | changed 2026-03-17 14:01:38.620457 | 2026-03-17 14:01:38.620546 | TASK [Switch "ansible_host" to private IP] 2026-03-17 14:01:38.950353 | controller | changed: 1 replacements made 2026-03-17 14:01:38.958010 | 2026-03-17 14:01:38.958145 | TASK [Run Molecule scenario] 2026-03-17 14:01:39.401042 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-17 14:01:39.401211 | controller | Creating virtual environment at: .venv 2026-03-17 14:01:39.682760 | controller | Downloading pygments (1.2MiB) 2026-03-17 14:01:39.683845 | controller | Downloading ansible-core (2.3MiB) 2026-03-17 14:01:39.696479 | controller | Downloading cryptography (4.3MiB) 2026-03-17 14:01:39.858835 | controller | Downloading cryptography 2026-03-17 14:01:39.920735 | controller | Downloading pygments 2026-03-17 14:01:40.100773 | controller | Downloading ansible-core 2026-03-17 14:01:40.151778 | controller | Installed 36 packages in 50ms 2026-03-17 14:01:40.902426 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-17 14:01:40.902497 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-17 14:01:41.863648 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-17 14:01:41.863699 | controller | INFO default scenario not found, disabling shared state. 2026-03-17 14:01:41.863821 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-17 14:01:41.863910 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-17 14:02:28.059701 | controller | INFO [helm > dependency] Executing 2026-03-17 14:02:28.059872 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-17 14:02:28.060071 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-17 14:02:28.060182 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-17 14:02:28.065923 | controller | INFO [helm > cleanup] Executing 2026-03-17 14:02:28.066220 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 14:02:28.072522 | controller | INFO [helm > destroy] Executing 2026-03-17 14:02:28.072558 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 14:02:28.072646 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 14:02:28.079195 | controller | INFO [helm > syntax] Executing 2026-03-17 14:02:29.057039 | controller | 2026-03-17 14:02:29.057172 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-17 14:02:29.119391 | controller | INFO [helm > syntax] Executed: Successful 2026-03-17 14:02:29.130711 | controller | INFO [helm > create] Executing 2026-03-17 14:02:29.132153 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 14:02:29.137558 | controller | INFO [helm > prepare] Executing 2026-03-17 14:02:30.059239 | controller | 2026-03-17 14:02:30.059412 | controller | PLAY [Prepare] ***************************************************************** 2026-03-17 14:02:30.059613 | controller | 2026-03-17 14:02:30.059929 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 14:02:30.060075 | controller | Tuesday 17 March 2026 14:02:30 +0000 (0:00:00.034) 0:00:00.034 ********* 2026-03-17 14:02:32.342774 | 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 14:02:32.347177 | controller | ok: [controller] 2026-03-17 14:02:32.347297 | controller | 2026-03-17 14:02:32.347469 | controller | TASK [Install Debian packages] ************************************************* 2026-03-17 14:02:32.347638 | controller | Tuesday 17 March 2026 14:02:32 +0000 (0:00:02.289) 0:00:02.323 ********* 2026-03-17 14:02:38.092530 | controller | ok: [controller] 2026-03-17 14:02:38.092809 | controller | 2026-03-17 14:02:38.093075 | controller | PLAY RECAP ********************************************************************* 2026-03-17 14:02:38.093316 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 14:02:38.093512 | controller | 2026-03-17 14:02:38.093954 | controller | 2026-03-17 14:02:38.094173 | controller | TASKS RECAP ******************************************************************** 2026-03-17 14:02:38.094379 | controller | Tuesday 17 March 2026 14:02:38 +0000 (0:00:05.745) 0:00:08.069 ********* 2026-03-17 14:02:38.094564 | controller | =============================================================================== 2026-03-17 14:02:38.094752 | controller | Install Debian packages ------------------------------------------------- 5.75s 2026-03-17 14:02:38.094942 | controller | Gathering Facts --------------------------------------------------------- 2.29s 2026-03-17 14:02:38.264586 | controller | INFO [helm > prepare] Executed: Successful 2026-03-17 14:02:38.274054 | controller | INFO [helm > converge] Executing 2026-03-17 14:02:39.172485 | controller | 2026-03-17 14:02:39.172555 | controller | PLAY [Converge] **************************************************************** 2026-03-17 14:02:39.172622 | controller | 2026-03-17 14:02:39.172770 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 14:02:39.172920 | controller | Tuesday 17 March 2026 14:02:39 +0000 (0:00:00.016) 0:00:00.016 ********* 2026-03-17 14:02:40.316966 | 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 14:02:40.323872 | controller | ok: [controller] 2026-03-17 14:02:40.324045 | controller | 2026-03-17 14:02:40.324296 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 14:02:40.324520 | controller | Tuesday 17 March 2026 14:02:40 +0000 (0:00:01.152) 0:00:01.169 ********* 2026-03-17 14:02:40.822606 | controller | ok: [controller] 2026-03-17 14:02:40.822750 | controller | 2026-03-17 14:02:40.822977 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 14:02:40.823185 | controller | Tuesday 17 March 2026 14:02:40 +0000 (0:00:00.498) 0:00:01.667 ********* 2026-03-17 14:02:42.033213 | controller | ok: [controller] 2026-03-17 14:02:42.033479 | controller | 2026-03-17 14:02:42.033743 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 14:02:42.033981 | controller | Tuesday 17 March 2026 14:02:42 +0000 (0:00:01.210) 0:00:02.877 ********* 2026-03-17 14:02:42.487808 | controller | changed: [controller] 2026-03-17 14:02:42.487928 | controller | 2026-03-17 14:02:42.488151 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 14:02:42.488609 | controller | Tuesday 17 March 2026 14:02:42 +0000 (0:00:00.454) 0:00:03.332 ********* 2026-03-17 14:02:42.553123 | controller | ok: [controller] => { 2026-03-17 14:02:42.553217 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 14:02:42.553230 | controller | } 2026-03-17 14:02:42.553247 | controller | 2026-03-17 14:02:42.553355 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 14:02:42.553478 | controller | Tuesday 17 March 2026 14:02:42 +0000 (0:00:00.064) 0:00:03.397 ********* 2026-03-17 14:02:43.474276 | 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 14:02:43.480709 | controller | changed: [controller] 2026-03-17 14:02:43.480810 | controller | 2026-03-17 14:02:43.480971 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 14:02:43.481107 | controller | Tuesday 17 March 2026 14:02:43 +0000 (0:00:00.928) 0:00:04.325 ********* 2026-03-17 14:02:45.692300 | controller | changed: [controller] 2026-03-17 14:02:45.692346 | controller | 2026-03-17 14:02:45.692355 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 14:02:45.692363 | controller | Tuesday 17 March 2026 14:02:45 +0000 (0:00:02.208) 0:00:06.534 ********* 2026-03-17 14:02:46.256744 | controller | ok: [controller] 2026-03-17 14:02:46.256816 | controller | 2026-03-17 14:02:46.256957 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 14:02:46.257094 | controller | Tuesday 17 March 2026 14:02:46 +0000 (0:00:00.564) 0:00:07.098 ********* 2026-03-17 14:02:46.703277 | controller | changed: [controller] 2026-03-17 14:02:46.703363 | controller | 2026-03-17 14:02:46.703438 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 14:02:46.703563 | controller | Tuesday 17 March 2026 14:02:46 +0000 (0:00:00.449) 0:00:07.548 ********* 2026-03-17 14:02:47.271250 | controller | ok: [controller] 2026-03-17 14:02:47.271383 | controller | 2026-03-17 14:02:47.271617 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 14:02:47.271828 | controller | Tuesday 17 March 2026 14:02:47 +0000 (0:00:00.567) 0:00:08.115 ********* 2026-03-17 14:02:47.600319 | controller | changed: [controller] 2026-03-17 14:02:47.600382 | controller | 2026-03-17 14:02:47.600449 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 14:02:47.600553 | controller | Tuesday 17 March 2026 14:02:47 +0000 (0:00:00.329) 0:00:08.445 ********* 2026-03-17 14:02:47.956301 | controller | ok: [controller] 2026-03-17 14:02:47.959941 | controller | 2026-03-17 14:02:47.960065 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 14:02:47.960187 | controller | Tuesday 17 March 2026 14:02:47 +0000 (0:00:00.355) 0:00:08.800 ********* 2026-03-17 14:02:48.018853 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 14:02:48.018899 | controller | 2026-03-17 14:02:48.018973 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 14:02:48.019062 | controller | Tuesday 17 March 2026 14:02:48 +0000 (0:00:00.062) 0:00:08.863 ********* 2026-03-17 14:02:48.083742 | controller | ok: [controller] => { 2026-03-17 14:02:48.083786 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 14:02:48.083793 | controller | } 2026-03-17 14:02:48.083799 | controller | 2026-03-17 14:02:48.083805 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 14:02:48.083812 | controller | Tuesday 17 March 2026 14:02:48 +0000 (0:00:00.060) 0:00:08.924 ********* 2026-03-17 14:02:48.867033 | controller | changed: [controller] 2026-03-17 14:02:48.867179 | controller | 2026-03-17 14:02:48.867392 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 14:02:48.867593 | controller | Tuesday 17 March 2026 14:02:48 +0000 (0:00:00.786) 0:00:09.711 ********* 2026-03-17 14:02:51.036287 | controller | changed: [controller] 2026-03-17 14:02:51.036338 | controller | 2026-03-17 14:02:51.036344 | controller | PLAY RECAP ********************************************************************* 2026-03-17 14:02:51.036352 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 14:02:51.036357 | controller | 2026-03-17 14:02:51.036362 | controller | 2026-03-17 14:02:51.036367 | controller | TASKS RECAP ******************************************************************** 2026-03-17 14:02:51.036372 | controller | Tuesday 17 March 2026 14:02:51 +0000 (0:00:02.166) 0:00:11.878 ********* 2026-03-17 14:02:51.036377 | controller | =============================================================================== 2026-03-17 14:02:51.036381 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.21s 2026-03-17 14:02:51.036386 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.17s 2026-03-17 14:02:51.036391 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.21s 2026-03-17 14:02:51.036395 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-03-17 14:02:51.036400 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.93s 2026-03-17 14:02:51.036404 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.79s 2026-03-17 14:02:51.036409 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.57s 2026-03-17 14:02:51.036413 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s 2026-03-17 14:02:51.036418 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-03-17 14:02:51.036423 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-17 14:02:51.036447 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.45s 2026-03-17 14:02:51.036451 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.36s 2026-03-17 14:02:51.036456 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-03-17 14:02:51.036461 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-17 14:02:51.036465 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-17 14:02:51.036470 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-17 14:02:51.204411 | controller | INFO [helm > converge] Executed: Successful 2026-03-17 14:02:51.208266 | controller | INFO [helm > idempotence] Executing 2026-03-17 14:02:52.102528 | controller | 2026-03-17 14:02:52.102831 | controller | PLAY [Converge] **************************************************************** 2026-03-17 14:02:52.103092 | controller | 2026-03-17 14:02:52.103360 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 14:02:52.103643 | controller | Tuesday 17 March 2026 14:02:52 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-03-17 14:02:53.256870 | 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 14:02:53.259755 | controller | ok: [controller] 2026-03-17 14:02:53.259938 | controller | 2026-03-17 14:02:53.260130 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 14:02:53.260368 | controller | Tuesday 17 March 2026 14:02:53 +0000 (0:00:01.157) 0:00:01.171 ********* 2026-03-17 14:02:53.724172 | controller | ok: [controller] 2026-03-17 14:02:53.724363 | controller | 2026-03-17 14:02:53.724595 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 14:02:53.724790 | controller | Tuesday 17 March 2026 14:02:53 +0000 (0:00:00.464) 0:00:01.635 ********* 2026-03-17 14:02:54.887265 | controller | ok: [controller] 2026-03-17 14:02:54.887314 | controller | 2026-03-17 14:02:54.887324 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 14:02:54.887332 | controller | Tuesday 17 March 2026 14:02:54 +0000 (0:00:01.162) 0:00:02.797 ********* 2026-03-17 14:02:55.373070 | controller | ok: [controller] 2026-03-17 14:02:55.373297 | controller | 2026-03-17 14:02:55.373569 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 14:02:55.373775 | controller | Tuesday 17 March 2026 14:02:55 +0000 (0:00:00.483) 0:00:03.281 ********* 2026-03-17 14:02:55.427799 | controller | ok: [controller] => { 2026-03-17 14:02:55.427870 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 14:02:55.428690 | controller | } 2026-03-17 14:02:55.428725 | controller | 2026-03-17 14:02:55.428731 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 14:02:55.428736 | controller | Tuesday 17 March 2026 14:02:55 +0000 (0:00:00.057) 0:00:03.339 ********* 2026-03-17 14:02:56.044576 | controller | ok: [controller] 2026-03-17 14:02:56.044650 | controller | 2026-03-17 14:02:56.044664 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 14:02:56.044675 | controller | Tuesday 17 March 2026 14:02:56 +0000 (0:00:00.608) 0:00:03.947 ********* 2026-03-17 14:02:57.824672 | controller | ok: [controller] 2026-03-17 14:02:57.824743 | controller | 2026-03-17 14:02:57.824760 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 14:02:57.827190 | controller | Tuesday 17 March 2026 14:02:57 +0000 (0:00:01.786) 0:00:05.733 ********* 2026-03-17 14:02:58.427984 | controller | ok: [controller] 2026-03-17 14:02:58.428167 | controller | 2026-03-17 14:02:58.428498 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 14:02:58.428702 | controller | Tuesday 17 March 2026 14:02:58 +0000 (0:00:00.605) 0:00:06.339 ********* 2026-03-17 14:02:58.901371 | controller | ok: [controller] 2026-03-17 14:02:58.901686 | controller | 2026-03-17 14:02:58.901971 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 14:02:58.902273 | controller | Tuesday 17 March 2026 14:02:58 +0000 (0:00:00.472) 0:00:06.811 ********* 2026-03-17 14:02:59.404759 | controller | ok: [controller] 2026-03-17 14:02:59.404911 | controller | 2026-03-17 14:02:59.405070 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 14:02:59.405197 | controller | Tuesday 17 March 2026 14:02:59 +0000 (0:00:00.502) 0:00:07.314 ********* 2026-03-17 14:02:59.715873 | controller | ok: [controller] 2026-03-17 14:02:59.716005 | controller | 2026-03-17 14:02:59.716244 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 14:02:59.716440 | controller | Tuesday 17 March 2026 14:02:59 +0000 (0:00:00.312) 0:00:07.627 ********* 2026-03-17 14:03:00.032746 | controller | ok: [controller] 2026-03-17 14:03:00.032847 | controller | 2026-03-17 14:03:00.032994 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 14:03:00.033133 | controller | Tuesday 17 March 2026 14:03:00 +0000 (0:00:00.314) 0:00:07.942 ********* 2026-03-17 14:03:00.102536 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 14:03:00.102575 | controller | 2026-03-17 14:03:00.102657 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 14:03:00.102767 | controller | Tuesday 17 March 2026 14:03:00 +0000 (0:00:00.071) 0:00:08.013 ********* 2026-03-17 14:03:00.156668 | controller | ok: [controller] => { 2026-03-17 14:03:00.156842 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 14:03:00.156951 | controller | } 2026-03-17 14:03:00.157106 | controller | 2026-03-17 14:03:00.157246 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 14:03:00.157343 | controller | Tuesday 17 March 2026 14:03:00 +0000 (0:00:00.050) 0:00:08.064 ********* 2026-03-17 14:03:00.618475 | controller | ok: [controller] 2026-03-17 14:03:00.618613 | controller | 2026-03-17 14:03:00.618790 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 14:03:00.618958 | controller | Tuesday 17 March 2026 14:03:00 +0000 (0:00:00.465) 0:00:08.529 ********* 2026-03-17 14:03:02.344962 | controller | ok: [controller] 2026-03-17 14:03:02.345032 | controller | 2026-03-17 14:03:02.345199 | controller | PLAY RECAP ********************************************************************* 2026-03-17 14:03:02.345388 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 14:03:02.345550 | controller | 2026-03-17 14:03:02.345695 | controller | 2026-03-17 14:03:02.345851 | controller | TASKS RECAP ******************************************************************** 2026-03-17 14:03:02.346005 | controller | Tuesday 17 March 2026 14:03:02 +0000 (0:00:01.727) 0:00:10.256 ********* 2026-03-17 14:03:02.346151 | controller | =============================================================================== 2026-03-17 14:03:02.346333 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.79s 2026-03-17 14:03:02.346482 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.73s 2026-03-17 14:03:02.346635 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.16s 2026-03-17 14:03:02.346786 | controller | Gathering Facts --------------------------------------------------------- 1.16s 2026-03-17 14:03:02.346938 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.61s 2026-03-17 14:03:02.347090 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.61s 2026-03-17 14:03:02.347245 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.50s 2026-03-17 14:03:02.347406 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.48s 2026-03-17 14:03:02.347563 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.47s 2026-03-17 14:03:02.347715 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.47s 2026-03-17 14:03:02.347861 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-03-17 14:03:02.348020 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-17 14:03:02.348229 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-17 14:03:02.353884 | controller | Install plugin ---------------------------------------------------------- 0.07s 2026-03-17 14:03:02.353947 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-17 14:03:02.353960 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-17 14:03:02.507394 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-17 14:03:02.520761 | controller | INFO [helm > side_effect] Executing 2026-03-17 14:03:02.521384 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 14:03:02.533649 | controller | INFO [helm > verify] Executing 2026-03-17 14:03:03.415200 | controller | 2026-03-17 14:03:03.415453 | controller | PLAY [Verify] ****************************************************************** 2026-03-17 14:03:03.415635 | controller | 2026-03-17 14:03:03.415827 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 14:03:03.416016 | controller | Tuesday 17 March 2026 14:03:03 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-03-17 14:03:04.595368 | 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 14:03:04.603133 | controller | ok: [controller] 2026-03-17 14:03:04.603157 | controller | 2026-03-17 14:03:04.603166 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-17 14:03:04.603174 | controller | Tuesday 17 March 2026 14:03:04 +0000 (0:00:01.187) 0:00:01.201 ********* 2026-03-17 14:03:05.120670 | controller | changed: [controller] 2026-03-17 14:03:05.120698 | controller | 2026-03-17 14:03:05.120703 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-17 14:03:05.120709 | controller | Tuesday 17 March 2026 14:03:05 +0000 (0:00:00.514) 0:00:01.716 ********* 2026-03-17 14:03:05.152425 | controller | ok: [controller] => { 2026-03-17 14:03:05.152458 | controller | "changed": false, 2026-03-17 14:03:05.152471 | controller | "msg": "All assertions passed" 2026-03-17 14:03:05.152483 | controller | } 2026-03-17 14:03:05.152495 | controller | 2026-03-17 14:03:05.152507 | controller | PLAY RECAP ********************************************************************* 2026-03-17 14:03:05.152701 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 14:03:05.152930 | controller | 2026-03-17 14:03:05.153145 | controller | 2026-03-17 14:03:05.153397 | controller | TASKS RECAP ******************************************************************** 2026-03-17 14:03:05.153649 | controller | Tuesday 17 March 2026 14:03:05 +0000 (0:00:00.035) 0:00:01.751 ********* 2026-03-17 14:03:05.153879 | controller | =============================================================================== 2026-03-17 14:03:05.154214 | controller | Gathering Facts --------------------------------------------------------- 1.19s 2026-03-17 14:03:05.154416 | controller | Get the current Helm version -------------------------------------------- 0.51s 2026-03-17 14:03:05.154651 | controller | Assert Helm version ----------------------------------------------------- 0.04s 2026-03-17 14:03:05.336559 | controller | INFO [helm > verify] Executed: Successful 2026-03-17 14:03:05.348237 | controller | INFO [helm > cleanup] Executing 2026-03-17 14:03:05.348768 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 14:03:05.356668 | controller | INFO [helm > destroy] Executing 2026-03-17 14:03:05.356711 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 14:03:05.356802 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 14:03:05.357202 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-17 14:03:05.551509 | controller | ok: Runtime: 0:01:26.126536 2026-03-17 14:03:05.556767 | 2026-03-17 14:03:05.556833 | PLAY RECAP 2026-03-17 14:03:05.556892 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 14:03:05.556924 | 2026-03-17 14:03:05.661951 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 14:03:05.664616 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 14:03:06.242867 | 2026-03-17 14:03:06.242994 | PLAY [all] 2026-03-17 14:03:06.253439 | 2026-03-17 14:03:06.253535 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 14:03:06.297704 | controller | skipping: Conditional result was False 2026-03-17 14:03:06.305898 | 2026-03-17 14:03:06.306105 | TASK [fetch-output : Set log path for single node] 2026-03-17 14:03:06.349082 | controller | ok 2026-03-17 14:03:06.354733 | 2026-03-17 14:03:06.354802 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 14:03:06.767649 | controller -> localhost | ok: "/var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/logs" 2026-03-17 14:03:06.981184 | controller -> localhost | changed: "/var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/artifacts" 2026-03-17 14:03:07.193597 | controller -> localhost | changed: "/var/lib/zuul/builds/fae7593ad814455799df8a4b39fea3b9/work/docs" 2026-03-17 14:03:07.207209 | 2026-03-17 14:03:07.207429 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 14:03:07.862316 | controller | changed: .d..t...... ./ 2026-03-17 14:03:07.862650 | controller | changed: All items complete 2026-03-17 14:03:07.862692 | 2026-03-17 14:03:08.340611 | controller | changed: .d..t...... ./ 2026-03-17 14:03:08.843641 | controller | changed: .d..t...... ./ 2026-03-17 14:03:08.862675 | 2026-03-17 14:03:08.862798 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 14:03:09.289664 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007399 2026-03-17 14:03:09.540686 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006956 2026-03-17 14:03:09.558811 | 2026-03-17 14:03:09.558942 | PLAY [all] 2026-03-17 14:03:09.575693 | 2026-03-17 14:03:09.575808 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-17 14:03:10.039249 | controller | changed 2026-03-17 14:03:10.048523 | 2026-03-17 14:03:10.048615 | PLAY RECAP 2026-03-17 14:03:10.048662 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-17 14:03:10.048684 | 2026-03-17 14:03:10.145330 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 14:03:10.147884 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-17 14:03:10.739968 | 2026-03-17 14:03:10.740105 | PLAY [localhost] 2026-03-17 14:03:10.749941 | 2026-03-17 14:03:10.750044 | TASK [Generate Zuul manifest] 2026-03-17 14:03:10.769890 | localhost | ok 2026-03-17 14:03:10.785122 | 2026-03-17 14:03:10.785237 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 14:03:11.102069 | localhost | changed 2026-03-17 14:03:11.116658 | 2026-03-17 14:03:11.116736 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 14:03:11.147007 | localhost | ok 2026-03-17 14:03:11.157790 | 2026-03-17 14:03:11.157904 | TASK [Upload logs] 2026-03-17 14:03:11.178387 | localhost | ok 2026-03-17 14:03:11.237830 | 2026-03-17 14:03:11.237950 | TASK [Set zuul-log-path fact] 2026-03-17 14:03:11.258130 | localhost | ok 2026-03-17 14:03:11.271891 | 2026-03-17 14:03:11.272025 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 14:03:11.303967 | localhost | ok 2026-03-17 14:03:11.313441 | 2026-03-17 14:03:11.313598 | TASK [upload-logs : Create log directories] 2026-03-17 14:03:11.699415 | localhost | changed 2026-03-17 14:03:11.705004 | 2026-03-17 14:03:11.705099 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-17 14:03:12.091328 | localhost -> localhost | ok: Runtime: 0:00:00.004986 2026-03-17 14:03:12.102210 | 2026-03-17 14:03:12.102326 | TASK [upload-logs : Upload logs to log server] 2026-03-17 14:03:12.588214 | localhost | Output suppressed because no_log was given 2026-03-17 14:03:12.592648 | 2026-03-17 14:03:12.592714 | LOOP [upload-logs : Compress console log and json output] 2026-03-17 14:03:12.638121 | localhost | skipping: Conditional result was False 2026-03-17 14:03:12.645447 | localhost | skipping: Conditional result was False 2026-03-17 14:03:12.655510 | 2026-03-17 14:03:12.655657 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-17 14:03:12.689365 | localhost | skipping: Conditional result was False 2026-03-17 14:03:12.689660 | 2026-03-17 14:03:12.693656 | localhost | skipping: Conditional result was False 2026-03-17 14:03:12.708371 | 2026-03-17 14:03:12.708509 | LOOP [upload-logs : Upload console log and json output]