2026-05-28 21:38:37.358188 | Job console starting
2026-05-28 21:38:37.378027 | Updating git repos
2026-05-28 21:38:37.419994 | Cloning repos into workspace
2026-05-28 21:38:37.904810 | Restoring repo states
2026-05-28 21:38:37.932760 | Merging changes
2026-05-28 21:38:41.255745 | Checking out repos
2026-05-28 21:38:41.447772 | Preparing playbooks
2026-05-28 21:39:07.258645 | Running Ansible setup
2026-05-28 21:39:12.293663 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-28 21:39:13.036700 | 
2026-05-28 21:39:13.165575 | PLAY [localhost]
2026-05-28 21:39:13.180637 | 
2026-05-28 21:39:13.180806 | TASK [Gathering Facts]
2026-05-28 21:39:14.407019 | localhost | ok
2026-05-28 21:39:14.418547 | 
2026-05-28 21:39:14.418637 | TASK [Setup log path fact]
2026-05-28 21:39:14.449522 | localhost | ok
2026-05-28 21:39:15.156652 | 
2026-05-28 21:39:15.156785 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-28 21:39:15.189493 | localhost | ok
2026-05-28 21:39:15.198526 | 
2026-05-28 21:39:15.198630 | TASK [emit-job-header : Print job information]
2026-05-28 21:39:15.239983 | # Job Information
2026-05-28 21:39:15.240164 | Ansible Version: 2.16.18
2026-05-28 21:39:15.240213 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-05-28 21:39:15.240247 | Pipeline: check
2026-05-28 21:39:15.240279 | Executor: 2d72f0692154
2026-05-28 21:39:15.240309 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/278
2026-05-28 21:39:15.240345 | Event ID: 2a886490-5add-11f1-981f-df993a22b334
2026-05-28 21:39:15.245427 | 
2026-05-28 21:39:15.891127 | LOOP [emit-job-header : Print node information]
2026-05-28 21:39:15.980544 | localhost | ok:
2026-05-28 21:39:15.980706 | localhost | # Node Information
2026-05-28 21:39:15.980735 | localhost | Inventory Hostname: controller
2026-05-28 21:39:15.980757 | localhost | Hostname: np0000177315
2026-05-28 21:39:15.980777 | localhost | Username: zuul
2026-05-28 21:39:15.980799 | localhost | Distro: Debian 13.5
2026-05-28 21:39:15.980819 | localhost | Provider: yul1
2026-05-28 21:39:15.980838 | localhost | Region: ca-ymq-1
2026-05-28 21:39:15.980857 | localhost | Label: debian-trixie
2026-05-28 21:39:15.980875 | localhost | Product Name: OpenStack Nova
2026-05-28 21:39:15.980894 | localhost | Interface IP: 199.19.213.176
2026-05-28 21:39:15.996269 | 
2026-05-28 21:39:15.996437 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-28 21:39:18.055407 | localhost -> localhost | changed
2026-05-28 21:39:18.064150 | 
2026-05-28 21:39:18.064302 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-28 21:39:18.966471 | localhost -> localhost | changed
2026-05-28 21:39:18.976600 | 
2026-05-28 21:39:18.976687 | PLAY [all]
2026-05-28 21:39:18.984312 | 
2026-05-28 21:39:18.984401 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-28 21:39:19.222689 | controller -> localhost | ok
2026-05-28 21:39:19.229487 | 
2026-05-28 21:39:19.229632 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-28 21:39:19.263157 | controller | ok
2026-05-28 21:39:19.280296 | controller | included: /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-28 21:39:19.285231 | 
2026-05-28 21:39:19.285292 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-28 21:39:20.140012 | controller -> localhost | Generating public/private rsa key pair.
2026-05-28 21:39:20.140321 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/4d00884feef84c258bd68ecf3b0507ca_id_rsa
2026-05-28 21:39:20.140393 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/4d00884feef84c258bd68ecf3b0507ca_id_rsa.pub
2026-05-28 21:39:20.140444 | controller -> localhost | The key fingerprint is:
2026-05-28 21:39:20.140492 | controller -> localhost | SHA256:Okf7NQ4cDXeRsYYSRJ2H6VCYGneONksIFi/fbic8IgQ zuul-build-sshkey
2026-05-28 21:39:20.140563 | controller -> localhost | The key's randomart image is:
2026-05-28 21:39:20.140612 | controller -> localhost | +---[RSA 3072]----+
2026-05-28 21:39:20.140665 | controller -> localhost | |      .. o+=.+oo |
2026-05-28 21:39:20.140711 | controller -> localhost | |      o.. =.*.oo |
2026-05-28 21:39:20.140757 | controller -> localhost | |    E....=o*o.+  |
2026-05-28 21:39:20.140801 | controller -> localhost | |     . oo.==oo   |
2026-05-28 21:39:20.140845 | controller -> localhost | |      . Sooo.    |
2026-05-28 21:39:20.140888 | controller -> localhost | |     . o =..     |
2026-05-28 21:39:20.140930 | controller -> localhost | |      + + O +    |
2026-05-28 21:39:20.141010 | controller -> localhost | |       + + B .   |
2026-05-28 21:39:20.141064 | controller -> localhost | |          . .    |
2026-05-28 21:39:20.141110 | controller -> localhost | +----[SHA256]-----+
2026-05-28 21:39:20.141214 | controller -> localhost | ok: Runtime: 0:00:00.413376
2026-05-28 21:39:20.147995 | 
2026-05-28 21:39:20.148093 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-28 21:39:20.185780 | controller | ok
2026-05-28 21:39:20.196994 | controller | included: /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-28 21:39:20.205578 | 
2026-05-28 21:39:20.205666 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-28 21:39:20.231508 | controller | skipping: Conditional result was False
2026-05-28 21:39:20.238397 | 
2026-05-28 21:39:20.238577 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-28 21:39:20.784715 | controller | changed
2026-05-28 21:39:20.790702 | 
2026-05-28 21:39:20.790789 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-28 21:39:20.998042 | controller | ok
2026-05-28 21:39:21.006375 | 
2026-05-28 21:39:21.006439 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-28 21:39:21.546825 | controller | changed
2026-05-28 21:39:27.243100 | 
2026-05-28 21:39:27.243233 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-28 21:39:27.792154 | controller | changed
2026-05-28 21:39:27.796742 | 
2026-05-28 21:39:27.796824 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-28 21:39:27.821948 | controller | skipping: Conditional result was False
2026-05-28 21:39:27.831151 | 
2026-05-28 21:39:27.831243 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-28 21:39:28.201759 | controller -> localhost | changed
2026-05-28 21:39:28.218082 | 
2026-05-28 21:39:28.218205 | TASK [add-build-sshkey : Add back temp key]
2026-05-28 21:39:28.512570 | controller -> localhost | Identity added: /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/4d00884feef84c258bd68ecf3b0507ca_id_rsa (zuul-build-sshkey)
2026-05-28 21:39:28.512858 | controller -> localhost | ok: Runtime: 0:00:00.014855
2026-05-28 21:39:28.518876 | 
2026-05-28 21:39:28.518967 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-28 21:39:28.888617 | controller | ok
2026-05-28 21:39:28.893736 | 
2026-05-28 21:39:28.893800 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-28 21:39:28.919295 | controller | skipping: Conditional result was False
2026-05-28 21:39:28.935006 | 
2026-05-28 21:39:28.935111 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-28 21:39:29.312168 | controller | ok
2026-05-28 21:39:29.326363 | 
2026-05-28 21:39:29.326476 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-28 21:39:30.321701 | controller | Output suppressed because no_log was given
2026-05-28 21:39:30.333045 | 
2026-05-28 21:39:30.333151 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-28 21:39:30.542005 | controller | ok: "logs"
2026-05-28 21:39:30.542316 | controller | ok: All items complete
2026-05-28 21:39:30.542395 | 
2026-05-28 21:39:30.728030 | controller | ok: "artifacts"
2026-05-28 21:39:30.934789 | controller | ok: "docs"
2026-05-28 21:39:31.013655 | 
2026-05-28 21:39:31.013826 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-28 21:39:31.261449 | controller | changed: "logs"
2026-05-28 21:39:31.465465 | controller | changed: "artifacts"
2026-05-28 21:39:31.669236 | controller | changed: "docs"
2026-05-28 21:39:31.686352 | 
2026-05-28 21:39:31.686467 | PLAY RECAP
2026-05-28 21:39:31.686519 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-28 21:39:31.686550 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-28 21:39:31.686574 | 
2026-05-28 21:39:31.849406 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-28 21:39:31.854465 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-28 21:39:32.493801 | 
2026-05-28 21:39:32.493990 | PLAY [all]
2026-05-28 21:39:32.504880 | 
2026-05-28 21:39:32.504993 | TASK [setup-uv : Extract archive]
2026-05-28 21:39:34.902164 | controller | changed
2026-05-28 21:39:34.975000 | 
2026-05-28 21:39:34.975143 | TASK [setup-uv : Print version]
2026-05-28 21:39:35.353410 | controller | uv 0.8.13
2026-05-28 21:39:35.578611 | controller | ok: Runtime: 0:00:00.014400
2026-05-28 21:39:35.588731 | 
2026-05-28 21:39:35.588847 | TASK [Install Ansible collection siblings]
2026-05-28 21:39:36.032505 | controller | ok:
2026-05-28 21:39:36.032694 | controller | Skipping ansible.posix: no checked-out sibling
2026-05-28 21:39:36.032723 | controller | Skipping community.crypto: no checked-out sibling
2026-05-28 21:39:36.032745 | controller | Skipping community.general: no checked-out sibling
2026-05-28 21:39:36.032765 | controller | Skipping kubernetes.core: no checked-out sibling
2026-05-28 21:39:36.032793 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-05-28 21:39:36.034819 | 
2026-05-28 21:39:36.034873 | PLAY RECAP
2026-05-28 21:39:36.034936 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-28 21:39:36.034966 | 
2026-05-28 21:39:36.251239 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-28 21:39:36.253832 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-28 21:39:36.881544 | 
2026-05-28 21:39:36.881729 | PLAY [all]
2026-05-28 21:39:36.892520 | 
2026-05-28 21:39:36.892599 | TASK [Update apt cache]
2026-05-28 21:39:41.721780 | controller | ok
2026-05-28 21:39:41.727547 | 
2026-05-28 21:39:41.727649 | TASK [Disable firewalld]
2026-05-28 21:39:41.752318 | controller | skipping: Conditional result was False
2026-05-28 21:39:41.760860 | 
2026-05-28 21:39:41.760972 | TASK [Install "jq" for log collection]
2026-05-28 21:39:43.986646 | controller | changed
2026-05-28 21:39:43.989362 | 
2026-05-28 21:39:43.989443 | PLAY RECAP
2026-05-28 21:39:43.989509 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-28 21:39:43.989543 | 
2026-05-28 21:39:44.150870 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-28 21:39:44.155194 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-28 21:39:44.782833 | 
2026-05-28 21:39:44.782987 | PLAY [all]
2026-05-28 21:39:44.804894 | 
2026-05-28 21:39:44.805131 | TASK [Copy inventory file for Zuul]
2026-05-28 21:39:45.829041 | controller | changed
2026-05-28 21:39:45.833755 | 
2026-05-28 21:39:45.833844 | TASK [Switch "ansible_host" to private IP]
2026-05-28 21:39:46.213755 | controller | changed: 1 replacements made
2026-05-28 21:39:46.694992 | 
2026-05-28 21:39:46.695120 | TASK [Run Molecule scenario]
2026-05-28 21:39:47.179156 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-05-28 21:39:47.179269 | controller | Creating virtual environment at: .venv
2026-05-28 21:39:47.478343 | controller | Downloading cryptography (4.3MiB)
2026-05-28 21:39:47.478929 | controller | Downloading ansible-core (2.3MiB)
2026-05-28 21:39:47.487047 | controller | Downloading pygments (1.2MiB)
2026-05-28 21:39:47.639197 | controller |  Downloading cryptography
2026-05-28 21:39:47.694827 | controller |  Downloading pygments
2026-05-28 21:39:47.852383 | controller |  Downloading ansible-core
2026-05-28 21:39:47.901305 | controller | Installed 36 packages in 48ms
2026-05-28 21:39:48.623831 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-05-28 21:39:48.623879 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-28 21:39:49.506935 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-05-28 21:39:49.506998 | controller | INFO     default scenario not found, disabling shared state.
2026-05-28 21:39:49.507085 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-28 21:39:49.507161 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-05-28 21:40:04.564469 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-05-28 21:40:04.564664 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-05-28 21:40:04.564923 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-05-28 21:40:04.565089 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-05-28 21:40:04.571305 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-05-28 21:40:04.571632 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-28 21:40:04.576881 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-05-28 21:40:04.576907 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-05-28 21:40:04.576998 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-05-28 21:40:04.582254 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-05-28 21:40:05.443554 | controller |
2026-05-28 21:40:05.443753 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-05-28 21:40:05.502047 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-05-28 21:40:05.513764 | controller | INFO     [upload-helm-chart > create] Executing
2026-05-28 21:40:05.515285 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-28 21:40:05.520620 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-05-28 21:40:05.520880 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-28 21:40:05.526128 | controller | INFO     [upload-helm-chart > converge] Executing
2026-05-28 21:40:06.398713 | controller |
2026-05-28 21:40:06.398848 | controller | PLAY [Converge] ****************************************************************
2026-05-28 21:40:06.399053 | controller |
2026-05-28 21:40:06.399366 | controller | TASK [Gathering Facts] *********************************************************
2026-05-28 21:40:06.399743 | controller | Thursday 28 May 2026  21:40:06 +0000 (0:00:00.045)       0:00:00.045 **********
2026-05-28 21:40:07.638666 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-05-28 21:40:07.644370 | controller | ok: [controller]
2026-05-28 21:40:07.644487 | controller |
2026-05-28 21:40:07.644623 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:07.644752 | controller | Thursday 28 May 2026  21:40:07 +0000 (0:00:01.246)       0:00:01.292 **********
2026-05-28 21:40:07.735083 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-28 21:40:07.735269 | controller |
2026-05-28 21:40:07.735495 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-28 21:40:07.735711 | controller | Thursday 28 May 2026  21:40:07 +0000 (0:00:00.090)       0:00:01.382 **********
2026-05-28 21:40:08.412316 | controller | changed: [controller]
2026-05-28 21:40:08.412461 | controller |
2026-05-28 21:40:08.412680 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:08.412924 | controller | Thursday 28 May 2026  21:40:08 +0000 (0:00:00.676)       0:00:02.059 **********
2026-05-28 21:40:08.459435 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-28 21:40:08.459626 | controller |
2026-05-28 21:40:08.459888 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-28 21:40:08.460208 | controller | Thursday 28 May 2026  21:40:08 +0000 (0:00:00.047)       0:00:02.106 **********
2026-05-28 21:40:08.920975 | controller | changed: [controller]
2026-05-28 21:40:08.921161 | controller |
2026-05-28 21:40:08.921390 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-28 21:40:08.921590 | controller | Thursday 28 May 2026  21:40:08 +0000 (0:00:00.461)       0:00:02.567 **********
2026-05-28 21:40:10.019077 | controller | changed: [controller]
2026-05-28 21:40:10.019264 | controller |
2026-05-28 21:40:10.019490 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-28 21:40:10.019687 | controller | Thursday 28 May 2026  21:40:10 +0000 (0:00:01.097)       0:00:03.665 **********
2026-05-28 21:40:10.452328 | controller | ok: [controller]
2026-05-28 21:40:10.452474 | controller |
2026-05-28 21:40:10.452699 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-28 21:40:10.452896 | controller | Thursday 28 May 2026  21:40:10 +0000 (0:00:00.431)       0:00:04.096 **********
2026-05-28 21:40:10.502897 | controller | skipping: [controller]
2026-05-28 21:40:10.502998 | controller |
2026-05-28 21:40:10.503232 | controller | PLAY RECAP *********************************************************************
2026-05-28 21:40:10.503463 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-28 21:40:10.503637 | controller |
2026-05-28 21:40:10.503808 | controller |
2026-05-28 21:40:10.504034 | controller | TASKS RECAP ********************************************************************
2026-05-28 21:40:10.504232 | controller | Thursday 28 May 2026  21:40:10 +0000 (0:00:00.054)       0:00:04.151 **********
2026-05-28 21:40:10.504408 | controller | ===============================================================================
2026-05-28 21:40:10.504596 | controller | Gathering Facts --------------------------------------------------------- 1.25s
2026-05-28 21:40:10.504807 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s
2026-05-28 21:40:10.504995 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.68s
2026-05-28 21:40:10.505204 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.46s
2026-05-28 21:40:10.505377 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s
2026-05-28 21:40:10.505576 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s
2026-05-28 21:40:10.505772 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-05-28 21:40:10.506032 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-05-28 21:40:10.598712 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-05-28 21:40:10.606517 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-05-28 21:40:11.406082 | controller |
2026-05-28 21:40:11.406195 | controller | PLAY [Converge] ****************************************************************
2026-05-28 21:40:11.406449 | controller |
2026-05-28 21:40:11.406643 | controller | TASK [Gathering Facts] *********************************************************
2026-05-28 21:40:11.406847 | controller | Thursday 28 May 2026  21:40:11 +0000 (0:00:00.011)       0:00:00.011 **********
2026-05-28 21:40:12.569505 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-05-28 21:40:12.574752 | controller | ok: [controller]
2026-05-28 21:40:12.574868 | controller |
2026-05-28 21:40:12.575048 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:12.575195 | controller | Thursday 28 May 2026  21:40:12 +0000 (0:00:01.168)       0:00:01.180 **********
2026-05-28 21:40:12.654582 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-28 21:40:12.654637 | controller |
2026-05-28 21:40:12.654804 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-28 21:40:12.655002 | controller | Thursday 28 May 2026  21:40:12 +0000 (0:00:00.079)       0:00:01.259 **********
2026-05-28 21:40:13.306312 | controller | ok: [controller]
2026-05-28 21:40:13.306485 | controller |
2026-05-28 21:40:13.306709 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:13.306926 | controller | Thursday 28 May 2026  21:40:13 +0000 (0:00:00.651)       0:00:01.911 **********
2026-05-28 21:40:13.351258 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-28 21:40:13.351469 | controller |
2026-05-28 21:40:13.351709 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-28 21:40:13.351897 | controller | Thursday 28 May 2026  21:40:13 +0000 (0:00:00.045)       0:00:01.956 **********
2026-05-28 21:40:13.756854 | controller | ok: [controller]
2026-05-28 21:40:13.757042 | controller |
2026-05-28 21:40:13.757273 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-28 21:40:13.757668 | controller | Thursday 28 May 2026  21:40:13 +0000 (0:00:00.401)       0:00:02.358 **********
2026-05-28 21:40:14.871071 | controller | ok: [controller]
2026-05-28 21:40:14.871212 | controller |
2026-05-28 21:40:14.871397 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-28 21:40:14.871588 | controller | Thursday 28 May 2026  21:40:14 +0000 (0:00:01.116)       0:00:03.474 **********
2026-05-28 21:40:15.279732 | controller | ok: [controller]
2026-05-28 21:40:15.279793 | controller |
2026-05-28 21:40:15.279919 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-28 21:40:15.280076 | controller | Thursday 28 May 2026  21:40:15 +0000 (0:00:00.410)       0:00:03.884 **********
2026-05-28 21:40:15.326879 | controller | skipping: [controller]
2026-05-28 21:40:15.326980 | controller |
2026-05-28 21:40:15.327165 | controller | PLAY RECAP *********************************************************************
2026-05-28 21:40:15.327371 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-28 21:40:15.327548 | controller |
2026-05-28 21:40:15.327709 | controller |
2026-05-28 21:40:15.327887 | controller | TASKS RECAP ********************************************************************
2026-05-28 21:40:15.328133 | controller | Thursday 28 May 2026  21:40:15 +0000 (0:00:00.048)       0:00:03.932 **********
2026-05-28 21:40:15.328300 | controller | ===============================================================================
2026-05-28 21:40:15.328561 | controller | Gathering Facts --------------------------------------------------------- 1.17s
2026-05-28 21:40:15.328763 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.12s
2026-05-28 21:40:15.328962 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.65s
2026-05-28 21:40:15.329152 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-05-28 21:40:15.329336 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.40s
2026-05-28 21:40:15.329531 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-05-28 21:40:15.329731 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-05-28 21:40:15.330047 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-05-28 21:40:15.461265 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-05-28 21:40:15.472830 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-05-28 21:40:16.282811 | controller |
2026-05-28 21:40:16.282939 | controller | PLAY [Side effect] *************************************************************
2026-05-28 21:40:16.283191 | controller |
2026-05-28 21:40:16.283329 | controller | TASK [Gathering Facts] *********************************************************
2026-05-28 21:40:16.283524 | controller | Thursday 28 May 2026  21:40:16 +0000 (0:00:00.010)       0:00:00.010 **********
2026-05-28 21:40:17.373956 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-05-28 21:40:17.379424 | controller | ok: [controller]
2026-05-28 21:40:17.379635 | controller |
2026-05-28 21:40:17.379854 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:17.380161 | controller | Thursday 28 May 2026  21:40:17 +0000 (0:00:01.096)       0:00:01.107 **********
2026-05-28 21:40:17.458403 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-28 21:40:17.458526 | controller |
2026-05-28 21:40:17.458727 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-28 21:40:17.458969 | controller | Thursday 28 May 2026  21:40:17 +0000 (0:00:00.078)       0:00:01.186 **********
2026-05-28 21:40:18.110079 | controller | changed: [controller]
2026-05-28 21:40:18.110233 | controller |
2026-05-28 21:40:18.110456 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-28 21:40:18.110672 | controller | Thursday 28 May 2026  21:40:18 +0000 (0:00:00.651)       0:00:01.837 **********
2026-05-28 21:40:18.151158 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-28 21:40:18.151304 | controller |
2026-05-28 21:40:18.151500 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-28 21:40:18.151691 | controller | Thursday 28 May 2026  21:40:18 +0000 (0:00:00.041)       0:00:01.879 **********
2026-05-28 21:40:18.560078 | controller | ok: [controller]
2026-05-28 21:40:18.560116 | controller |
2026-05-28 21:40:18.560615 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-28 21:40:18.560666 | controller | Thursday 28 May 2026  21:40:18 +0000 (0:00:00.407)       0:00:02.287 **********
2026-05-28 21:40:20.724539 | controller | ok: [controller]
2026-05-28 21:40:20.724735 | controller |
2026-05-28 21:40:20.724869 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-28 21:40:20.724988 | controller | Thursday 28 May 2026  21:40:20 +0000 (0:00:02.163)       0:00:04.450 **********
2026-05-28 21:40:21.144921 | controller | ok: [controller]
2026-05-28 21:40:21.145254 | controller |
2026-05-28 21:40:21.145558 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-28 21:40:21.145829 | controller | Thursday 28 May 2026  21:40:21 +0000 (0:00:00.419)       0:00:04.870 **********
2026-05-28 21:40:21.491287 | controller | changed: [controller] => (item=/file)
2026-05-28 21:40:21.491729 | controller |
2026-05-28 21:40:21.492142 | controller | PLAY RECAP *********************************************************************
2026-05-28 21:40:21.492444 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-28 21:40:21.492689 | controller |
2026-05-28 21:40:21.492927 | controller |
2026-05-28 21:40:21.493199 | controller | TASKS RECAP ********************************************************************
2026-05-28 21:40:21.493477 | controller | Thursday 28 May 2026  21:40:21 +0000 (0:00:00.349)       0:00:05.219 **********
2026-05-28 21:40:21.493725 | controller | ===============================================================================
2026-05-28 21:40:21.493997 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 2.16s
2026-05-28 21:40:21.494252 | controller | Gathering Facts --------------------------------------------------------- 1.10s
2026-05-28 21:40:21.494516 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.65s
2026-05-28 21:40:21.494782 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s
2026-05-28 21:40:21.495044 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-05-28 21:40:21.495319 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.35s
2026-05-28 21:40:21.495712 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-05-28 21:40:21.496027 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-05-28 21:40:21.633916 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-05-28 21:40:21.643456 | controller | INFO     [upload-helm-chart > verify] Executing
2026-05-28 21:40:22.469899 | controller |
2026-05-28 21:40:22.469920 | controller | PLAY [Verify] ******************************************************************
2026-05-28 21:40:22.469925 | controller |
2026-05-28 21:40:22.469928 | controller | TASK [Gathering Facts] *********************************************************
2026-05-28 21:40:22.469932 | controller | Thursday 28 May 2026  21:40:22 +0000 (0:00:00.015)       0:00:00.015 **********
2026-05-28 21:40:23.502385 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-05-28 21:40:23.512579 | controller | ok: [controller]
2026-05-28 21:40:23.512613 | controller |
2026-05-28 21:40:23.512708 | controller | TASK [Stat file 1] *************************************************************
2026-05-28 21:40:23.512802 | controller | Thursday 28 May 2026  21:40:23 +0000 (0:00:01.038)       0:00:01.053 **********
2026-05-28 21:40:23.914668 | controller | ok: [controller]
2026-05-28 21:40:23.914717 | controller |
2026-05-28 21:40:23.914859 | controller | TASK [Stat file 2] *************************************************************
2026-05-28 21:40:23.915024 | controller | Thursday 28 May 2026  21:40:23 +0000 (0:00:00.408)       0:00:01.461 **********
2026-05-28 21:40:24.225244 | controller | ok: [controller]
2026-05-28 21:40:24.225296 | controller |
2026-05-28 21:40:24.225445 | controller | TASK [Stat removed file 1] *****************************************************
2026-05-28 21:40:24.225601 | controller | Thursday 28 May 2026  21:40:24 +0000 (0:00:00.307)       0:00:01.769 **********
2026-05-28 21:40:24.496064 | controller | ok: [controller]
2026-05-28 21:40:24.496120 | controller |
2026-05-28 21:40:24.496279 | controller | TASK [Stat removed file 2] *****************************************************
2026-05-28 21:40:24.496418 | controller | Thursday 28 May 2026  21:40:24 +0000 (0:00:00.273)       0:00:02.043 **********
2026-05-28 21:40:24.775175 | controller | ok: [controller]
2026-05-28 21:40:24.775228 | controller |
2026-05-28 21:40:24.775360 | controller | TASK [ansible.builtin.assert] **************************************************
2026-05-28 21:40:24.775481 | controller | Thursday 28 May 2026  21:40:24 +0000 (0:00:00.277)       0:00:02.320 **********
2026-05-28 21:40:24.800761 | controller | ok: [controller] => {
2026-05-28 21:40:24.800947 | controller |     "changed": false,
2026-05-28 21:40:24.801134 | controller |     "msg": "All assertions passed"
2026-05-28 21:40:24.803203 | controller | }
2026-05-28 21:40:24.803227 | controller |
2026-05-28 21:40:24.803234 | controller | PLAY RECAP *********************************************************************
2026-05-28 21:40:24.803240 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-28 21:40:24.803245 | controller |
2026-05-28 21:40:24.803260 | controller |
2026-05-28 21:40:24.803265 | controller | TASKS RECAP ********************************************************************
2026-05-28 21:40:24.803270 | controller | Thursday 28 May 2026  21:40:24 +0000 (0:00:00.027)       0:00:02.348 **********
2026-05-28 21:40:24.803275 | controller | ===============================================================================
2026-05-28 21:40:24.803279 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2026-05-28 21:40:24.803284 | controller | Stat file 1 ------------------------------------------------------------- 0.41s
2026-05-28 21:40:24.803289 | controller | Stat file 2 ------------------------------------------------------------- 0.31s
2026-05-28 21:40:24.803294 | controller | Stat removed file 2 ----------------------------------------------------- 0.28s
2026-05-28 21:40:24.803298 | controller | Stat removed file 1 ----------------------------------------------------- 0.27s
2026-05-28 21:40:24.803303 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-05-28 21:40:24.890776 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-05-28 21:40:24.903004 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-05-28 21:40:24.903350 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-28 21:40:24.908653 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-05-28 21:40:24.908770 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-05-28 21:40:24.908856 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-05-28 21:40:24.909131 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-05-28 21:40:25.436215 | controller | ok: Runtime: 0:00:37.886045
2026-05-28 21:40:25.442387 | 
2026-05-28 21:40:25.442439 | PLAY RECAP
2026-05-28 21:40:25.442484 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-28 21:40:25.442507 | 
2026-05-28 21:40:25.615689 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-28 21:40:26.258242 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-28 21:40:26.930001 | 
2026-05-28 21:40:28.777925 | PLAY [all]
2026-05-28 21:40:28.796911 | 
2026-05-28 21:40:28.797159 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-05-28 21:40:29.185664 | controller | changed
2026-05-28 21:40:29.598349 | 
2026-05-28 21:40:29.598553 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-05-28 21:40:29.977078 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-28 21:40:29.977649 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-28 21:40:29.983685 | controller | environment: line 1: kubectl: command not found
2026-05-28 21:40:29.985485 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-28 21:40:29.987126 | controller | environment: line 1: kubectl: command not found
2026-05-28 21:40:29.989045 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-28 21:40:29.992432 | controller | environment: line 1: kubectl: command not found
2026-05-28 21:40:29.994332 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-28 21:40:29.995039 | controller | environment: line 1: kubectl: command not found
2026-05-28 21:40:29.996606 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-28 21:40:29.998214 | controller | environment: line 1: kubectl: command not found
2026-05-28 21:40:30.000245 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-28 21:40:30.508349 | controller | ok: Runtime: 0:00:00.035169
2026-05-28 21:40:30.514503 | 
2026-05-28 21:40:30.514648 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-05-28 21:40:30.746102 | controller | changed
2026-05-28 21:40:32.019242 | 
2026-05-28 21:40:32.019457 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-05-28 21:40:32.255872 | controller | environment: line 5: kubectl: command not found
2026-05-28 21:40:32.257302 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-28 21:40:32.257350 | controller |
2026-05-28 21:40:32.258079 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-28 21:40:32.912273 | controller | ok: Runtime: 0:00:00.012687
2026-05-28 21:40:32.919299 | 
2026-05-28 21:40:32.919397 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-05-28 21:40:34.372204 | controller | changed:
2026-05-28 21:40:34.503928 | controller | created directory /var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/logs/controller
2026-05-28 21:40:34.504497 | controller | cd+++++++++ objects/
2026-05-28 21:40:34.504692 | controller | cd+++++++++ objects/cluster/
2026-05-28 21:40:34.504784 | controller | cd+++++++++ objects/namespaced/
2026-05-28 21:40:34.518752 | 
2026-05-28 21:40:34.518887 | TASK [gather-pod-logs : creating directory for pod logs]
2026-05-28 21:40:34.758899 | controller | changed
2026-05-28 21:40:34.764263 | 
2026-05-28 21:40:34.764336 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-05-28 21:40:35.020176 | controller | changed
2026-05-28 21:40:35.155586 | 
2026-05-28 21:40:35.155788 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-05-28 21:40:35.384510 | controller | environment: line 3: kubectl: command not found
2026-05-28 21:40:35.782099 | controller | ok: Runtime: 0:00:00.012187
2026-05-28 21:40:35.788013 | 
2026-05-28 21:40:35.788149 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-05-28 21:40:36.301716 | controller | changed:
2026-05-28 21:40:36.301934 | controller | cd+++++++++ pod-logs/
2026-05-28 21:40:36.301979 | controller | cd+++++++++ pod-logs/failed-pods/
2026-05-28 21:40:36.312240 | 
2026-05-28 21:40:36.312325 | LOOP [helm-release-status : creating directory for helm release status]
2026-05-28 21:40:36.546523 | controller | changed: "values"
2026-05-28 21:40:36.753106 | controller | changed: "releases"
2026-05-28 21:40:36.853964 | 
2026-05-28 21:40:36.854503 | TASK [helm-release-status : Gather get release status for helm charts]
2026-05-28 21:40:37.079369 | controller | /bin/bash: line 3: kubectl: command not found
2026-05-28 21:40:37.425197 | controller | ok: Runtime: 0:00:00.008141
2026-05-28 21:40:37.433104 | 
2026-05-28 21:40:37.433221 | TASK [helm-release-status : Downloads logs to executor]
2026-05-28 21:40:37.992148 | controller | changed:
2026-05-28 21:40:37.992372 | controller | cd+++++++++ helm/
2026-05-28 21:40:37.992414 | controller | cd+++++++++ helm/releases/
2026-05-28 21:40:37.992449 | controller | cd+++++++++ helm/values/
2026-05-28 21:40:37.999053 | 
2026-05-28 21:40:37.999107 | PLAY RECAP
2026-05-28 21:40:37.999156 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-28 21:40:37.999178 | 
2026-05-28 21:40:38.143895 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-28 21:40:41.823537 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-28 21:40:42.508709 | 
2026-05-28 21:40:42.508859 | PLAY [all]
2026-05-28 21:40:42.519566 | 
2026-05-28 21:40:42.519687 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-28 21:40:42.566018 | controller | skipping: Conditional result was False
2026-05-28 21:40:42.573257 | 
2026-05-28 21:40:42.573374 | TASK [fetch-output : Set log path for single node]
2026-05-28 21:40:42.616566 | controller | ok
2026-05-28 21:40:42.622208 | 
2026-05-28 21:40:42.622345 | LOOP [fetch-output : Ensure local output dirs]
2026-05-28 21:40:43.850030 | controller -> localhost | ok: "/var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/logs"
2026-05-28 21:40:44.274949 | controller -> localhost | changed: "/var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/artifacts"
2026-05-28 21:40:44.475560 | controller -> localhost | changed: "/var/lib/zuul/builds/4d00884feef84c258bd68ecf3b0507ca/work/docs"
2026-05-28 21:40:44.491892 | 
2026-05-28 21:40:44.492024 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-28 21:40:45.437340 | controller | changed: .d..t...... ./
2026-05-28 21:40:45.437591 | controller | changed: All items complete
2026-05-28 21:40:45.437649 | 
2026-05-28 21:40:47.134481 | controller | changed: .d..t...... ./
2026-05-28 21:40:51.700627 | controller | changed: .d..t...... ./
2026-05-28 21:40:51.717191 | 
2026-05-28 21:40:51.718482 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-28 21:40:52.156606 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007383
2026-05-28 21:40:52.402434 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007659
2026-05-28 21:40:52.417986 | 
2026-05-28 21:40:52.418056 | PLAY [all]
2026-05-28 21:40:52.429147 | 
2026-05-28 21:40:52.429259 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-28 21:40:52.903495 | controller | changed
2026-05-28 21:40:54.756684 | 
2026-05-28 21:40:54.756791 | PLAY RECAP
2026-05-28 21:40:54.756853 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-28 21:40:54.756884 | 
2026-05-28 21:40:54.910461 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-28 21:40:55.021891 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-28 21:40:55.678977 | 
2026-05-28 21:40:55.679122 | PLAY [localhost]
2026-05-28 21:40:55.689943 | 
2026-05-28 21:40:55.690079 | TASK [Generate Zuul manifest]
2026-05-28 21:40:55.711819 | localhost | ok
2026-05-28 21:40:55.727518 | 
2026-05-28 21:40:55.727594 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-28 21:40:56.673438 | localhost | changed
2026-05-28 21:40:56.689719 | 
2026-05-28 21:40:56.689846 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-28 21:40:56.721784 | localhost | ok
2026-05-28 21:40:56.732551 | 
2026-05-28 21:40:56.732645 | TASK [Upload logs]
2026-05-28 21:40:56.757207 | localhost | ok
2026-05-28 21:40:56.840638 | 
2026-05-28 21:40:56.840786 | TASK [Set zuul-log-path fact]
2026-05-28 21:40:56.866858 | localhost | ok
2026-05-28 21:40:56.883081 | 
2026-05-28 21:40:56.883191 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-28 21:40:56.912866 | localhost | ok
2026-05-28 21:40:56.920909 | 
2026-05-28 21:40:56.921013 | TASK [upload-logs : Create log directories]
2026-05-28 21:40:57.448697 | localhost | changed
2026-05-28 21:40:57.453994 | 
2026-05-28 21:40:57.454074 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-28 21:40:57.854640 | localhost -> localhost | ok: Runtime: 0:00:00.005601
2026-05-28 21:40:57.861508 | 
2026-05-28 21:40:57.861602 | TASK [upload-logs : Upload logs to log server]
2026-05-28 21:40:59.871968 | localhost | Output suppressed because no_log was given
2026-05-28 21:40:59.882260 | 
2026-05-28 21:40:59.882896 | LOOP [upload-logs : Compress console log and json output]
2026-05-28 21:40:59.936326 | localhost | skipping: Conditional result was False
2026-05-28 21:40:59.994374 | localhost | skipping: Conditional result was False
2026-05-28 21:41:00.012726 | 
2026-05-28 21:41:00.012997 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-28 21:41:00.059391 | localhost | skipping: Conditional result was False
2026-05-28 21:41:00.059936 | 
2026-05-28 21:41:00.065462 | localhost | skipping: Conditional result was False
2026-05-28 21:41:00.090752 | 
2026-05-28 21:41:00.090925 | LOOP [upload-logs : Upload console log and json output]