2026-03-17 14:00:08.818745 | Job console starting
2026-03-17 14:00:08.830696 | Updating git repos
2026-03-17 14:00:08.876060 | Cloning repos into workspace
2026-03-17 14:00:08.981237 | Restoring repo states
2026-03-17 14:00:09.009124 | Merging changes
2026-03-17 14:00:10.163180 | Checking out repos
2026-03-17 14:00:10.418225 | Preparing playbooks
2026-03-17 14:00:12.661762 | Running Ansible setup
2026-03-17 14:00:17.233034 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-17 14:00:17.818923 | 
2026-03-17 14:00:17.819040 | PLAY [localhost]
2026-03-17 14:00:17.826378 | 
2026-03-17 14:00:17.826449 | TASK [Gathering Facts]
2026-03-17 14:00:19.165606 | localhost | ok
2026-03-17 14:00:19.172781 | 
2026-03-17 14:00:19.172857 | TASK [Setup log path fact]
2026-03-17 14:00:19.191751 | localhost | ok
2026-03-17 14:00:19.203833 | 
2026-03-17 14:00:19.203898 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-17 14:00:19.232490 | localhost | ok
2026-03-17 14:00:19.241469 | 
2026-03-17 14:00:19.241555 | TASK [emit-job-header : Print job information]
2026-03-17 14:00:19.280265 | # Job Information
2026-03-17 14:00:19.280442 | Ansible Version: 2.16.16
2026-03-17 14:00:19.280489 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-03-17 14:00:19.280522 | Pipeline: check
2026-03-17 14:00:19.280551 | Executor: 0a8996d2b663
2026-03-17 14:00:19.280579 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238
2026-03-17 14:00:19.280610 | Event ID: 99ded8b0-2207-11f1-8026-f2420cbb33b9
2026-03-17 14:00:19.284469 | 
2026-03-17 14:00:19.284562 | LOOP [emit-job-header : Print node information]
2026-03-17 14:00:19.370533 | localhost | ok:
2026-03-17 14:00:19.371068 | localhost | # Node Information
2026-03-17 14:00:19.371119 | localhost | Inventory Hostname: controller
2026-03-17 14:00:19.371186 | localhost | Hostname: np0000159350
2026-03-17 14:00:19.371226 | localhost | Username: zuul
2026-03-17 14:00:19.371259 | localhost | Distro: Debian 13.3
2026-03-17 14:00:19.371288 | localhost | Provider: yul1
2026-03-17 14:00:19.371313 | localhost | Region: ca-ymq-1
2026-03-17 14:00:19.371339 | localhost | Label: debian-trixie
2026-03-17 14:00:19.371365 | localhost | Product Name: OpenStack Nova
2026-03-17 14:00:19.371401 | localhost | Interface IP: 199.204.45.244
2026-03-17 14:00:19.390450 | 
2026-03-17 14:00:19.390583 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-17 14:00:19.778774 | localhost -> localhost | changed
2026-03-17 14:00:19.786903 | 
2026-03-17 14:00:19.786993 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-17 14:00:20.630993 | localhost -> localhost | changed
2026-03-17 14:00:20.640430 | 
2026-03-17 14:00:20.640491 | PLAY [all]
2026-03-17 14:00:20.646763 | 
2026-03-17 14:00:20.646829 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-17 14:00:20.852405 | controller -> localhost | ok
2026-03-17 14:00:20.861624 | 
2026-03-17 14:00:20.861720 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-17 14:00:20.891443 | controller | ok
2026-03-17 14:00:20.909158 | controller | included: /var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-17 14:00:20.913941 | 
2026-03-17 14:00:20.914023 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-17 14:00:21.724418 | controller -> localhost | Generating public/private rsa key pair.
2026-03-17 14:00:21.724571 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/8696fe6147b048ceb687d6e220858aab_id_rsa
2026-03-17 14:00:21.724603 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/8696fe6147b048ceb687d6e220858aab_id_rsa.pub
2026-03-17 14:00:21.724627 | controller -> localhost | The key fingerprint is:
2026-03-17 14:00:21.724649 | controller -> localhost | SHA256:+RzwpHPdnac6aBNCe7HZxli5LNhwS3Hu+L2XDx9Xhrk zuul-build-sshkey
2026-03-17 14:00:21.724684 | controller -> localhost | The key's randomart image is:
2026-03-17 14:00:21.724707 | controller -> localhost | +---[RSA 3072]----+
2026-03-17 14:00:21.724735 | controller -> localhost | |                 |
2026-03-17 14:00:21.724758 | controller -> localhost | |          . .    |
2026-03-17 14:00:21.724778 | controller -> localhost | |        . .+ .   |
2026-03-17 14:00:21.724799 | controller -> localhost | |        o*+.+. +.|
2026-03-17 14:00:21.724819 | controller -> localhost | |       .SB+&..+.=|
2026-03-17 14:00:21.724839 | controller -> localhost | |        +=@.B  +o|
2026-03-17 14:00:21.724859 | controller -> localhost | |         oo* .E.o|
2026-03-17 14:00:21.724879 | controller -> localhost | |          + o..++|
2026-03-17 14:00:21.724903 | controller -> localhost | |         . ....o+|
2026-03-17 14:00:21.724923 | controller -> localhost | +----[SHA256]-----+
2026-03-17 14:00:21.724996 | controller -> localhost | ok: Runtime: 0:00:00.372662
2026-03-17 14:00:21.729641 | 
2026-03-17 14:00:21.729724 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-17 14:00:21.757435 | controller | ok
2026-03-17 14:00:21.767098 | controller | included: /var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-17 14:00:21.773286 | 
2026-03-17 14:00:21.773344 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-17 14:00:21.796268 | controller | skipping: Conditional result was False
2026-03-17 14:00:21.802980 | 
2026-03-17 14:00:21.803064 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-17 14:00:22.333408 | controller | changed
2026-03-17 14:00:22.342448 | 
2026-03-17 14:00:22.342649 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-17 14:00:22.545634 | controller | ok
2026-03-17 14:00:22.550864 | 
2026-03-17 14:00:22.550947 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-17 14:00:23.144403 | controller | changed
2026-03-17 14:00:23.185592 | 
2026-03-17 14:00:23.185705 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-17 14:00:23.713246 | controller | changed
2026-03-17 14:00:23.718779 | 
2026-03-17 14:00:23.719066 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-17 14:00:23.743310 | controller | skipping: Conditional result was False
2026-03-17 14:00:23.751553 | 
2026-03-17 14:00:23.751641 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-17 14:00:24.140830 | controller -> localhost | changed
2026-03-17 14:00:24.153201 | 
2026-03-17 14:00:24.153316 | TASK [add-build-sshkey : Add back temp key]
2026-03-17 14:00:24.439545 | controller -> localhost | Identity added: /var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/8696fe6147b048ceb687d6e220858aab_id_rsa (zuul-build-sshkey)
2026-03-17 14:00:24.439820 | controller -> localhost | ok: Runtime: 0:00:00.012827
2026-03-17 14:00:24.446480 | 
2026-03-17 14:00:24.446698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-17 14:00:24.795503 | controller | ok
2026-03-17 14:00:24.800737 | 
2026-03-17 14:00:24.800799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-17 14:00:24.824342 | controller | skipping: Conditional result was False
2026-03-17 14:00:24.835226 | 
2026-03-17 14:00:24.835406 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-17 14:00:25.213795 | controller | ok
2026-03-17 14:00:25.223203 | 
2026-03-17 14:00:25.223337 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-17 14:00:26.290225 | controller | Output suppressed because no_log was given
2026-03-17 14:00:26.298571 | 
2026-03-17 14:00:26.298638 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-17 14:00:26.540497 | controller | ok: "logs"
2026-03-17 14:00:26.540733 | controller | ok: All items complete
2026-03-17 14:00:26.540782 | 
2026-03-17 14:00:26.747057 | controller | ok: "artifacts"
2026-03-17 14:00:26.935113 | controller | ok: "docs"
2026-03-17 14:00:26.949188 | 
2026-03-17 14:00:26.949324 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-17 14:00:27.156842 | controller | changed: "logs"
2026-03-17 14:00:27.342063 | controller | changed: "artifacts"
2026-03-17 14:00:27.523550 | controller | changed: "docs"
2026-03-17 14:00:27.533727 | 
2026-03-17 14:00:27.533819 | PLAY RECAP
2026-03-17 14:00:27.533864 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-17 14:00:27.533892 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 14:00:27.533913 | 
2026-03-17 14:00:27.632375 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-17 14:00:27.633652 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-17 14:00:28.170514 | 
2026-03-17 14:00:28.170628 | PLAY [all]
2026-03-17 14:00:28.180442 | 
2026-03-17 14:00:28.180518 | TASK [setup-uv : Extract archive]
2026-03-17 14:00:31.656014 | controller | changed
2026-03-17 14:00:31.662654 | 
2026-03-17 14:00:31.662731 | TASK [setup-uv : Print version]
2026-03-17 14:00:32.038612 | controller | uv 0.8.13
2026-03-17 14:00:32.191084 | controller | ok: Runtime: 0:00:00.016661
2026-03-17 14:00:32.197388 | 
2026-03-17 14:00:32.197437 | PLAY RECAP
2026-03-17 14:00:32.197477 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 14:00:32.197500 | 
2026-03-17 14:00:32.281558 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-17 14:00:32.284164 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-17 14:00:32.836775 | 
2026-03-17 14:00:32.836883 | PLAY [all]
2026-03-17 14:00:32.846744 | 
2026-03-17 14:00:32.846818 | TASK [Copy inventory file for Zuul]
2026-03-17 14:00:33.792396 | controller | changed
2026-03-17 14:00:33.798300 | 
2026-03-17 14:00:33.798397 | TASK [Switch "ansible_host" to private IP]
2026-03-17 14:00:34.089263 | controller | changed: 1 replacements made
2026-03-17 14:00:34.094778 | 
2026-03-17 14:00:34.094849 | TASK [Run Molecule scenario]
2026-03-17 14:00:34.498454 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-03-17 14:00:34.498630 | controller | Creating virtual environment at: .venv
2026-03-17 14:00:34.768898 | controller | Downloading pygments (1.2MiB)
2026-03-17 14:00:34.769264 | controller | Downloading cryptography (4.3MiB)
2026-03-17 14:00:34.769512 | controller | Downloading ansible-core (2.3MiB)
2026-03-17 14:00:34.938537 | controller |  Downloading cryptography
2026-03-17 14:00:34.995899 | controller |  Downloading pygments
2026-03-17 14:00:35.188753 | controller |  Downloading ansible-core
2026-03-17 14:00:35.238642 | controller | Installed 36 packages in 49ms
2026-03-17 14:00:35.921472 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-03-17 14:00:35.921571 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-03-17 14:00:36.781546 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-03-17 14:00:36.781604 | controller | INFO     default scenario not found, disabling shared state.
2026-03-17 14:00:36.781726 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-03-17 14:00:36.781802 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-03-17 14:01:56.927988 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-03-17 14:01:56.928072 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-03-17 14:01:56.928083 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-03-17 14:01:56.928115 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-17 14:01:56.932843 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-17 14:01:56.933190 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 14:01:56.938548 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-17 14:01:56.938573 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-17 14:01:56.938650 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-17 14:01:56.944047 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-03-17 14:01:57.885037 | controller |
2026-03-17 14:01:57.885136 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-03-17 14:01:57.947885 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-03-17 14:01:57.957767 | controller | INFO     [upload-helm-chart > create] Executing
2026-03-17 14:01:57.959203 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 14:01:57.964618 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-03-17 14:01:57.964860 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 14:01:57.970112 | controller | INFO     [upload-helm-chart > converge] Executing
2026-03-17 14:01:58.820505 | controller |
2026-03-17 14:01:58.820722 | controller | PLAY [Converge] ****************************************************************
2026-03-17 14:01:58.820925 | controller |
2026-03-17 14:01:58.821137 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 14:01:58.821346 | controller | Tuesday 17 March 2026  14:01:58 +0000 (0:00:00.030)       0:00:00.030 *********
2026-03-17 14:02:00.134091 | 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:00.142499 | controller | ok: [controller]
2026-03-17 14:02:00.142689 | controller |
2026-03-17 14:02:00.142923 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:00.143126 | controller | Tuesday 17 March 2026  14:02:00 +0000 (0:00:01.322)       0:00:01.353 *********
2026-03-17 14:02:00.226739 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 14:02:00.226952 | controller |
2026-03-17 14:02:00.227158 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 14:02:00.227350 | controller | Tuesday 17 March 2026  14:02:00 +0000 (0:00:00.084)       0:00:01.437 *********
2026-03-17 14:02:00.958320 | controller | changed: [controller]
2026-03-17 14:02:00.958443 | controller |
2026-03-17 14:02:00.958679 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:00.958880 | controller | Tuesday 17 March 2026  14:02:00 +0000 (0:00:00.731)       0:00:02.168 *********
2026-03-17 14:02:01.015125 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 14:02:01.015167 | controller |
2026-03-17 14:02:01.015177 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 14:02:01.015185 | controller | Tuesday 17 March 2026  14:02:01 +0000 (0:00:00.056)       0:00:02.224 *********
2026-03-17 14:02:01.423141 | controller | changed: [controller]
2026-03-17 14:02:01.423337 | controller |
2026-03-17 14:02:01.423611 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 14:02:01.423831 | controller | Tuesday 17 March 2026  14:02:01 +0000 (0:00:00.408)       0:00:02.633 *********
2026-03-17 14:02:02.565862 | controller | changed: [controller]
2026-03-17 14:02:02.566029 | controller |
2026-03-17 14:02:02.566246 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 14:02:02.566443 | controller | Tuesday 17 March 2026  14:02:02 +0000 (0:00:01.143)       0:00:03.776 *********
2026-03-17 14:02:02.969759 | controller | ok: [controller]
2026-03-17 14:02:02.969906 | controller |
2026-03-17 14:02:02.970138 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 14:02:02.970343 | controller | Tuesday 17 March 2026  14:02:02 +0000 (0:00:00.403)       0:00:04.180 *********
2026-03-17 14:02:03.024340 | controller | skipping: [controller]
2026-03-17 14:02:03.024652 | controller |
2026-03-17 14:02:03.024891 | controller | PLAY RECAP *********************************************************************
2026-03-17 14:02:03.025145 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-17 14:02:03.025334 | controller |
2026-03-17 14:02:03.025516 | controller |
2026-03-17 14:02:03.025711 | controller | TASKS RECAP ********************************************************************
2026-03-17 14:02:03.025926 | controller | Tuesday 17 March 2026  14:02:03 +0000 (0:00:00.055)       0:00:04.235 *********
2026-03-17 14:02:03.026109 | controller | ===============================================================================
2026-03-17 14:02:03.026308 | controller | Gathering Facts --------------------------------------------------------- 1.32s
2026-03-17 14:02:03.026523 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.14s
2026-03-17 14:02:03.026729 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-17 14:02:03.026948 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-03-17 14:02:03.027137 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-03-17 14:02:03.027349 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-17 14:02:03.027625 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.06s
2026-03-17 14:02:03.027940 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-03-17 14:02:03.147157 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-03-17 14:02:03.160180 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-03-17 14:02:04.038760 | controller |
2026-03-17 14:02:04.038829 | controller | PLAY [Converge] ****************************************************************
2026-03-17 14:02:04.038901 | controller |
2026-03-17 14:02:04.039035 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 14:02:04.039172 | controller | Tuesday 17 March 2026  14:02:04 +0000 (0:00:00.016)       0:00:00.016 *********
2026-03-17 14:02:05.232618 | 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:05.237650 | controller | ok: [controller]
2026-03-17 14:02:05.237811 | controller |
2026-03-17 14:02:05.237992 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:05.238157 | controller | Tuesday 17 March 2026  14:02:05 +0000 (0:00:01.198)       0:00:01.214 *********
2026-03-17 14:02:05.319728 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 14:02:05.319933 | controller |
2026-03-17 14:02:05.320121 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 14:02:05.320249 | controller | Tuesday 17 March 2026  14:02:05 +0000 (0:00:00.081)       0:00:01.296 *********
2026-03-17 14:02:06.171713 | controller | ok: [controller]
2026-03-17 14:02:06.171895 | controller |
2026-03-17 14:02:06.172193 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:06.172472 | controller | Tuesday 17 March 2026  14:02:06 +0000 (0:00:00.851)       0:00:02.148 *********
2026-03-17 14:02:06.218015 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 14:02:06.218199 | controller |
2026-03-17 14:02:06.218402 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 14:02:06.218591 | controller | Tuesday 17 March 2026  14:02:06 +0000 (0:00:00.046)       0:00:02.195 *********
2026-03-17 14:02:06.663028 | controller | ok: [controller]
2026-03-17 14:02:06.663072 | controller |
2026-03-17 14:02:06.663078 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 14:02:06.663084 | controller | Tuesday 17 March 2026  14:02:06 +0000 (0:00:00.440)       0:00:02.636 *********
2026-03-17 14:02:07.788188 | controller | ok: [controller]
2026-03-17 14:02:07.788246 | controller |
2026-03-17 14:02:07.788252 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 14:02:07.788257 | controller | Tuesday 17 March 2026  14:02:07 +0000 (0:00:01.124)       0:00:03.760 *********
2026-03-17 14:02:08.192548 | controller | ok: [controller]
2026-03-17 14:02:08.192623 | controller |
2026-03-17 14:02:08.192633 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 14:02:08.192642 | controller | Tuesday 17 March 2026  14:02:08 +0000 (0:00:00.408)       0:00:04.168 *********
2026-03-17 14:02:08.240457 | controller | skipping: [controller]
2026-03-17 14:02:08.240620 | controller |
2026-03-17 14:02:08.240850 | controller | PLAY RECAP *********************************************************************
2026-03-17 14:02:08.241042 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-03-17 14:02:08.241213 | controller |
2026-03-17 14:02:08.241379 | controller |
2026-03-17 14:02:08.241557 | controller | TASKS RECAP ********************************************************************
2026-03-17 14:02:08.241747 | controller | Tuesday 17 March 2026  14:02:08 +0000 (0:00:00.049)       0:00:04.218 *********
2026-03-17 14:02:08.241933 | controller | ===============================================================================
2026-03-17 14:02:08.242193 | controller | Gathering Facts --------------------------------------------------------- 1.20s
2026-03-17 14:02:08.242391 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.12s
2026-03-17 14:02:08.242578 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.85s
2026-03-17 14:02:08.242766 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-17 14:02:08.242957 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-03-17 14:02:08.243100 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-03-17 14:02:08.243223 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-03-17 14:02:08.243343 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-17 14:02:08.355933 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-03-17 14:02:08.365212 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-03-17 14:02:09.197610 | controller |
2026-03-17 14:02:09.197754 | controller | PLAY [Side effect] *************************************************************
2026-03-17 14:02:09.197964 | controller |
2026-03-17 14:02:09.198179 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 14:02:09.198444 | controller | Tuesday 17 March 2026  14:02:09 +0000 (0:00:00.010)       0:00:00.010 *********
2026-03-17 14:02:10.238350 | 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:10.243133 | controller | ok: [controller]
2026-03-17 14:02:10.243319 | controller |
2026-03-17 14:02:10.243533 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:10.243733 | controller | Tuesday 17 March 2026  14:02:10 +0000 (0:00:01.045)       0:00:01.056 *********
2026-03-17 14:02:10.330295 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-03-17 14:02:10.330439 | controller |
2026-03-17 14:02:10.330654 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-03-17 14:02:10.330855 | controller | Tuesday 17 March 2026  14:02:10 +0000 (0:00:00.086)       0:00:01.142 *********
2026-03-17 14:02:11.061574 | controller | changed: [controller]
2026-03-17 14:02:11.061802 | controller |
2026-03-17 14:02:11.062013 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-03-17 14:02:11.062209 | controller | Tuesday 17 March 2026  14:02:11 +0000 (0:00:00.731)       0:00:01.874 *********
2026-03-17 14:02:11.107678 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-03-17 14:02:11.107828 | controller |
2026-03-17 14:02:11.108109 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-03-17 14:02:11.108347 | controller | Tuesday 17 March 2026  14:02:11 +0000 (0:00:00.046)       0:00:01.920 *********
2026-03-17 14:02:11.546027 | controller | ok: [controller]
2026-03-17 14:02:11.546072 | controller |
2026-03-17 14:02:11.546082 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-03-17 14:02:11.546092 | controller | Tuesday 17 March 2026  14:02:11 +0000 (0:00:00.437)       0:00:02.357 *********
2026-03-17 14:02:12.741242 | controller | ok: [controller]
2026-03-17 14:02:12.741272 | controller |
2026-03-17 14:02:12.741278 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-03-17 14:02:12.741283 | controller | Tuesday 17 March 2026  14:02:12 +0000 (0:00:01.192)       0:00:03.550 *********
2026-03-17 14:02:13.135287 | controller | ok: [controller]
2026-03-17 14:02:13.135313 | controller |
2026-03-17 14:02:13.135318 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-03-17 14:02:13.135322 | controller | Tuesday 17 March 2026  14:02:13 +0000 (0:00:00.397)       0:00:03.947 *********
2026-03-17 14:02:13.465749 | controller | changed: [controller] => (item=/file)
2026-03-17 14:02:13.465895 | controller |
2026-03-17 14:02:13.466038 | controller | PLAY RECAP *********************************************************************
2026-03-17 14:02:13.466194 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-17 14:02:13.466307 | controller |
2026-03-17 14:02:13.466413 | controller |
2026-03-17 14:02:13.473652 | controller | TASKS RECAP ********************************************************************
2026-03-17 14:02:13.473688 | controller | Tuesday 17 March 2026  14:02:13 +0000 (0:00:00.332)       0:00:04.279 *********
2026-03-17 14:02:13.473698 | controller | ===============================================================================
2026-03-17 14:02:13.473703 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.19s
2026-03-17 14:02:13.473708 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-03-17 14:02:13.473712 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s
2026-03-17 14:02:13.473717 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-03-17 14:02:13.473721 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-03-17 14:02:13.473726 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.33s
2026-03-17 14:02:13.473732 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s
2026-03-17 14:02:13.473735 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-03-17 14:02:13.599800 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-03-17 14:02:13.606138 | controller | INFO     [upload-helm-chart > verify] Executing
2026-03-17 14:02:14.462552 | controller |
2026-03-17 14:02:14.463508 | controller | PLAY [Verify] ******************************************************************
2026-03-17 14:02:14.463844 | controller |
2026-03-17 14:02:14.464151 | controller | TASK [Gathering Facts] *********************************************************
2026-03-17 14:02:14.464476 | controller | Tuesday 17 March 2026  14:02:14 +0000 (0:00:00.010)       0:00:00.010 *********
2026-03-17 14:02:15.604978 | 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:15.607482 | controller | ok: [controller]
2026-03-17 14:02:15.607657 | controller |
2026-03-17 14:02:15.607829 | controller | TASK [Stat file 1] *************************************************************
2026-03-17 14:02:15.608001 | controller | Tuesday 17 March 2026  14:02:15 +0000 (0:00:01.145)       0:00:01.155 *********
2026-03-17 14:02:16.012992 | controller | ok: [controller]
2026-03-17 14:02:16.013297 | controller |
2026-03-17 14:02:16.013568 | controller | TASK [Stat file 2] *************************************************************
2026-03-17 14:02:16.013832 | controller | Tuesday 17 March 2026  14:02:16 +0000 (0:00:00.404)       0:00:01.560 *********
2026-03-17 14:02:16.323880 | controller | ok: [controller]
2026-03-17 14:02:16.324167 | controller |
2026-03-17 14:02:16.324505 | controller | TASK [Stat removed file 1] *****************************************************
2026-03-17 14:02:16.324774 | controller | Tuesday 17 March 2026  14:02:16 +0000 (0:00:00.311)       0:00:01.871 *********
2026-03-17 14:02:16.625804 | controller | ok: [controller]
2026-03-17 14:02:16.626005 | controller |
2026-03-17 14:02:16.626182 | controller | TASK [Stat removed file 2] *****************************************************
2026-03-17 14:02:16.626362 | controller | Tuesday 17 March 2026  14:02:16 +0000 (0:00:00.301)       0:00:02.173 *********
2026-03-17 14:02:16.914225 | controller | ok: [controller]
2026-03-17 14:02:16.914506 | controller |
2026-03-17 14:02:16.914774 | controller | TASK [ansible.builtin.assert] **************************************************
2026-03-17 14:02:16.915043 | controller | Tuesday 17 March 2026  14:02:16 +0000 (0:00:00.288)       0:00:02.462 *********
2026-03-17 14:02:16.948844 | controller | ok: [controller] => {
2026-03-17 14:02:16.949162 | controller |     "changed": false,
2026-03-17 14:02:16.949424 | controller |     "msg": "All assertions passed"
2026-03-17 14:02:16.949673 | controller | }
2026-03-17 14:02:16.949906 | controller |
2026-03-17 14:02:16.950156 | controller | PLAY RECAP *********************************************************************
2026-03-17 14:02:16.950432 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-03-17 14:02:16.950673 | controller |
2026-03-17 14:02:16.950929 | controller |
2026-03-17 14:02:16.951181 | controller | TASKS RECAP ********************************************************************
2026-03-17 14:02:16.951440 | controller | Tuesday 17 March 2026  14:02:16 +0000 (0:00:00.035)       0:00:02.497 *********
2026-03-17 14:02:16.951718 | controller | ===============================================================================
2026-03-17 14:02:16.951967 | controller | Gathering Facts --------------------------------------------------------- 1.15s
2026-03-17 14:02:16.952215 | controller | Stat file 1 ------------------------------------------------------------- 0.40s
2026-03-17 14:02:16.952503 | controller | Stat file 2 ------------------------------------------------------------- 0.31s
2026-03-17 14:02:16.952757 | controller | Stat removed file 1 ----------------------------------------------------- 0.30s
2026-03-17 14:02:16.953005 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s
2026-03-17 14:02:16.953375 | controller | ansible.builtin.assert -------------------------------------------------- 0.04s
2026-03-17 14:02:17.057201 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-03-17 14:02:17.068870 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-03-17 14:02:17.069308 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-17 14:02:17.076664 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-03-17 14:02:17.076758 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-03-17 14:02:17.076874 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-03-17 14:02:17.077149 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-03-17 14:02:17.226538 | controller | ok: Runtime: 0:01:42.736059
2026-03-17 14:02:17.230139 | 
2026-03-17 14:02:17.230209 | PLAY RECAP
2026-03-17 14:02:17.230270 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-17 14:02:17.230301 | 
2026-03-17 14:02:17.342931 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-17 14:02:17.344407 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-17 14:02:17.990119 | 
2026-03-17 14:02:17.990283 | PLAY [all]
2026-03-17 14:02:18.000987 | 
2026-03-17 14:02:18.001076 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-17 14:02:18.046750 | controller | skipping: Conditional result was False
2026-03-17 14:02:18.056156 | 
2026-03-17 14:02:18.056276 | TASK [fetch-output : Set log path for single node]
2026-03-17 14:02:18.100935 | controller | ok
2026-03-17 14:02:18.106133 | 
2026-03-17 14:02:18.106250 | LOOP [fetch-output : Ensure local output dirs]
2026-03-17 14:02:18.490719 | controller -> localhost | ok: "/var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/logs"
2026-03-17 14:02:18.725206 | controller -> localhost | changed: "/var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/artifacts"
2026-03-17 14:02:18.950619 | controller -> localhost | changed: "/var/lib/zuul/builds/8696fe6147b048ceb687d6e220858aab/work/docs"
2026-03-17 14:02:18.963384 | 
2026-03-17 14:02:18.963522 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-17 14:02:19.669972 | controller | ok
2026-03-17 14:02:19.670285 | controller | changed: All items complete
2026-03-17 14:02:19.670349 | 
2026-03-17 14:02:20.143348 | controller | changed: .d..t...... ./
2026-03-17 14:02:20.629412 | controller | changed: .d..t...... ./
2026-03-17 14:02:20.648209 | 
2026-03-17 14:02:20.648299 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-17 14:02:21.056163 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006916
2026-03-17 14:02:21.275211 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006390
2026-03-17 14:02:21.295569 | 
2026-03-17 14:02:21.295697 | PLAY [all]
2026-03-17 14:02:21.302501 | 
2026-03-17 14:02:21.302592 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-17 14:02:21.755798 | controller | changed
2026-03-17 14:02:21.761821 | 
2026-03-17 14:02:21.761888 | PLAY RECAP
2026-03-17 14:02:21.761948 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-17 14:02:21.761979 | 
2026-03-17 14:02:21.851971 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-17 14:02:21.854485 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-17 14:02:22.407916 | 
2026-03-17 14:02:22.408074 | PLAY [localhost]
2026-03-17 14:02:22.421525 | 
2026-03-17 14:02:22.421677 | TASK [Generate Zuul manifest]
2026-03-17 14:02:22.440343 | localhost | ok
2026-03-17 14:02:22.460065 | 
2026-03-17 14:02:22.460221 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-17 14:02:22.775304 | localhost | changed
2026-03-17 14:02:22.787781 | 
2026-03-17 14:02:22.787868 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-17 14:02:22.817733 | localhost | ok
2026-03-17 14:02:22.826723 | 
2026-03-17 14:02:22.826812 | TASK [Upload logs]
2026-03-17 14:02:22.847753 | localhost | ok
2026-03-17 14:02:22.906208 | 
2026-03-17 14:02:22.906326 | TASK [Set zuul-log-path fact]
2026-03-17 14:02:22.924648 | localhost | ok
2026-03-17 14:02:22.938706 | 
2026-03-17 14:02:22.938777 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-17 14:02:22.969998 | localhost | ok
2026-03-17 14:02:22.979123 | 
2026-03-17 14:02:22.979217 | TASK [upload-logs : Create log directories]
2026-03-17 14:02:23.365147 | localhost | changed
2026-03-17 14:02:23.369923 | 
2026-03-17 14:02:23.370000 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-17 14:02:23.744779 | localhost -> localhost | ok: Runtime: 0:00:00.003880
2026-03-17 14:02:23.751304 | 
2026-03-17 14:02:23.751369 | TASK [upload-logs : Upload logs to log server]
2026-03-17 14:02:24.185188 | localhost | Output suppressed because no_log was given
2026-03-17 14:02:24.190070 | 
2026-03-17 14:02:24.190179 | LOOP [upload-logs : Compress console log and json output]
2026-03-17 14:02:24.233229 | localhost | skipping: Conditional result was False
2026-03-17 14:02:24.240433 | localhost | skipping: Conditional result was False
2026-03-17 14:02:24.249641 | 
2026-03-17 14:02:24.249733 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-17 14:02:24.288654 | localhost | skipping: Conditional result was False
2026-03-17 14:02:24.289046 | 
2026-03-17 14:02:24.293024 | localhost | skipping: Conditional result was False
2026-03-17 14:02:24.309037 | 
2026-03-17 14:02:24.309124 | LOOP [upload-logs : Upload console log and json output]