2026-05-21 01:05:18.705724 | Job console starting
2026-05-21 01:05:18.718932 | Updating git repos
2026-05-21 01:05:18.765082 | Cloning repos into workspace
2026-05-21 01:05:18.970635 | Restoring repo states
2026-05-21 01:05:19.006444 | Merging changes
2026-05-21 01:05:19.989237 | Checking out repos
2026-05-21 01:05:20.465710 | Preparing playbooks
2026-05-21 01:05:23.195730 | Running Ansible setup
2026-05-21 01:05:26.894590 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-21 01:05:27.540259 | 
2026-05-21 01:05:27.540382 | PLAY [localhost]
2026-05-21 01:05:27.547649 | 
2026-05-21 01:05:27.547742 | TASK [Gathering Facts]
2026-05-21 01:05:28.503748 | localhost | ok
2026-05-21 01:05:28.510458 | 
2026-05-21 01:05:28.510534 | TASK [Setup log path fact]
2026-05-21 01:05:28.526751 | localhost | ok
2026-05-21 01:05:28.537073 | 
2026-05-21 01:05:28.537180 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-21 01:05:28.566991 | localhost | ok
2026-05-21 01:05:28.575378 | 
2026-05-21 01:05:28.575470 | TASK [emit-job-header : Print job information]
2026-05-21 01:05:28.616853 | # Job Information
2026-05-21 01:05:28.617034 | Ansible Version: 2.16.18
2026-05-21 01:05:28.617081 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-05-21 01:05:28.617114 | Pipeline: check
2026-05-21 01:05:28.617143 | Executor: 2d72f0692154
2026-05-21 01:05:28.617172 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/274
2026-05-21 01:05:28.617203 | Event ID: 0044a7c0-54b1-11f1-854f-8380327a6ab3
2026-05-21 01:05:28.621065 | 
2026-05-21 01:05:28.621153 | LOOP [emit-job-header : Print node information]
2026-05-21 01:05:28.716990 | localhost | ok:
2026-05-21 01:05:28.717171 | localhost | # Node Information
2026-05-21 01:05:28.717217 | localhost | Inventory Hostname: controller
2026-05-21 01:05:28.717256 | localhost | Hostname: np0000175606
2026-05-21 01:05:28.717291 | localhost | Username: zuul
2026-05-21 01:05:28.717410 | localhost | Distro: Debian 13.5
2026-05-21 01:05:28.717474 | localhost | Provider: yul1
2026-05-21 01:05:28.717507 | localhost | Region: ca-ymq-1
2026-05-21 01:05:28.717536 | localhost | Label: debian-trixie
2026-05-21 01:05:28.717564 | localhost | Product Name: OpenStack Nova
2026-05-21 01:05:28.717592 | localhost | Interface IP: 199.204.45.246
2026-05-21 01:05:28.727950 | 
2026-05-21 01:05:28.728075 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-21 01:05:29.106150 | localhost -> localhost | changed
2026-05-21 01:05:29.114365 | 
2026-05-21 01:05:29.114439 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-21 01:05:29.927053 | localhost -> localhost | changed
2026-05-21 01:05:29.932791 | 
2026-05-21 01:05:29.932852 | PLAY [all]
2026-05-21 01:05:29.939308 | 
2026-05-21 01:05:29.939378 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-21 01:05:30.176484 | controller -> localhost | ok
2026-05-21 01:05:30.184998 | 
2026-05-21 01:05:30.185093 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-21 01:05:30.217279 | controller | ok
2026-05-21 01:05:30.238247 | controller | included: /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-21 01:05:30.245846 | 
2026-05-21 01:05:30.245973 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-21 01:05:31.282483 | controller -> localhost | Generating public/private rsa key pair.
2026-05-21 01:05:31.282714 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/6ba0ede781eb45d7bf7814009f423d11_id_rsa
2026-05-21 01:05:31.282762 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/6ba0ede781eb45d7bf7814009f423d11_id_rsa.pub
2026-05-21 01:05:31.282800 | controller -> localhost | The key fingerprint is:
2026-05-21 01:05:31.282838 | controller -> localhost | SHA256:+12xwyVDA70AyUAfFKYsO8U+TLQ3PWOMJT/zW/tEkoI zuul-build-sshkey
2026-05-21 01:05:31.282889 | controller -> localhost | The key's randomart image is:
2026-05-21 01:05:31.282928 | controller -> localhost | +---[RSA 3072]----+
2026-05-21 01:05:31.282973 | controller -> localhost | |       .++B+o.   |
2026-05-21 01:05:31.283010 | controller -> localhost | |       + =oO...  |
2026-05-21 01:05:31.283046 | controller -> localhost | |      . B = X.o. |
2026-05-21 01:05:31.283080 | controller -> localhost | |       B . + B.o |
2026-05-21 01:05:31.283115 | controller -> localhost | |      o S E . B +|
2026-05-21 01:05:31.283152 | controller -> localhost | |       . o   o @.|
2026-05-21 01:05:31.283188 | controller -> localhost | |        .     *..|
2026-05-21 01:05:31.283223 | controller -> localhost | |         . . . o.|
2026-05-21 01:05:31.283261 | controller -> localhost | |          . .   .|
2026-05-21 01:05:31.283296 | controller -> localhost | +----[SHA256]-----+
2026-05-21 01:05:31.283365 | controller -> localhost | ok: Runtime: 0:00:00.518387
2026-05-21 01:05:31.288921 | 
2026-05-21 01:05:31.289023 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-21 01:05:31.329889 | controller | ok
2026-05-21 01:05:31.338454 | controller | included: /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-21 01:05:31.362035 | 
2026-05-21 01:05:31.362161 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-21 01:05:31.387004 | controller | skipping: Conditional result was False
2026-05-21 01:05:31.393102 | 
2026-05-21 01:05:31.393173 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-21 01:05:31.983599 | controller | changed
2026-05-21 01:05:31.988523 | 
2026-05-21 01:05:31.988585 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-21 01:05:32.201364 | controller | ok
2026-05-21 01:05:32.213126 | 
2026-05-21 01:05:32.213212 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-21 01:05:32.778413 | controller | changed
2026-05-21 01:05:32.782265 | 
2026-05-21 01:05:32.782328 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-21 01:05:33.339534 | controller | changed
2026-05-21 01:05:33.343386 | 
2026-05-21 01:05:33.343450 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-21 01:05:33.366372 | controller | skipping: Conditional result was False
2026-05-21 01:05:33.370769 | 
2026-05-21 01:05:33.370836 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-21 01:05:33.777482 | controller -> localhost | changed
2026-05-21 01:05:33.786051 | 
2026-05-21 01:05:33.786120 | TASK [add-build-sshkey : Add back temp key]
2026-05-21 01:05:34.074458 | controller -> localhost | Identity added: /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/6ba0ede781eb45d7bf7814009f423d11_id_rsa (zuul-build-sshkey)
2026-05-21 01:05:34.074755 | controller -> localhost | ok: Runtime: 0:00:00.014101
2026-05-21 01:05:34.078766 | 
2026-05-21 01:05:34.078828 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-21 01:05:34.393913 | controller | ok
2026-05-21 01:05:34.398121 | 
2026-05-21 01:05:34.398187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-21 01:05:34.422337 | controller | skipping: Conditional result was False
2026-05-21 01:05:34.434527 | 
2026-05-21 01:05:34.434614 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-21 01:05:34.836387 | controller | ok
2026-05-21 01:05:34.844243 | 
2026-05-21 01:05:34.852758 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-21 01:05:35.818704 | controller | Output suppressed because no_log was given
2026-05-21 01:05:35.825433 | 
2026-05-21 01:05:35.825502 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-21 01:05:36.029832 | controller | ok: "logs"
2026-05-21 01:05:36.030108 | controller | ok: All items complete
2026-05-21 01:05:36.030193 | 
2026-05-21 01:05:36.218440 | controller | ok: "artifacts"
2026-05-21 01:05:36.400692 | controller | ok: "docs"
2026-05-21 01:05:36.415491 | 
2026-05-21 01:05:36.415604 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-21 01:05:36.631333 | controller | changed: "logs"
2026-05-21 01:05:36.808220 | controller | changed: "artifacts"
2026-05-21 01:05:36.988290 | controller | changed: "docs"
2026-05-21 01:05:37.004137 | 
2026-05-21 01:05:37.004234 | PLAY RECAP
2026-05-21 01:05:37.004283 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-21 01:05:37.004314 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-21 01:05:37.004337 | 
2026-05-21 01:05:37.121165 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-21 01:05:37.124774 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-21 01:05:37.717326 | 
2026-05-21 01:05:37.786468 | PLAY [all]
2026-05-21 01:05:37.806081 | 
2026-05-21 01:05:37.806205 | TASK [setup-uv : Extract archive]
2026-05-21 01:05:40.078923 | controller | changed
2026-05-21 01:05:40.089634 | 
2026-05-21 01:05:40.089730 | TASK [setup-uv : Print version]
2026-05-21 01:05:40.350191 | controller | uv 0.8.13
2026-05-21 01:05:40.610781 | controller | ok: Runtime: 0:00:00.014535
2026-05-21 01:05:40.621069 | 
2026-05-21 01:05:40.621175 | TASK [Install Ansible collection siblings]
2026-05-21 01:05:40.997791 | controller | ok:
2026-05-21 01:05:40.998036 | controller | Skipping ansible.posix: no checked-out sibling
2026-05-21 01:05:40.998078 | controller | Skipping community.crypto: no checked-out sibling
2026-05-21 01:05:40.998167 | controller | Skipping community.general: no checked-out sibling
2026-05-21 01:05:40.998257 | controller | Skipping kubernetes.core: no checked-out sibling
2026-05-21 01:05:40.998291 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-05-21 01:05:41.000642 | 
2026-05-21 01:05:41.000727 | PLAY RECAP
2026-05-21 01:05:41.000803 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-21 01:05:41.000835 | 
2026-05-21 01:05:41.173514 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-21 01:05:41.175300 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-21 01:05:41.791578 | 
2026-05-21 01:05:41.791681 | PLAY [all]
2026-05-21 01:05:41.802121 | 
2026-05-21 01:05:41.802192 | TASK [Update apt cache]
2026-05-21 01:05:46.808052 | controller | ok
2026-05-21 01:05:47.363674 | 
2026-05-21 01:05:47.363788 | TASK [Disable firewalld]
2026-05-21 01:05:47.388032 | controller | skipping: Conditional result was False
2026-05-21 01:05:47.398217 | 
2026-05-21 01:05:47.398428 | TASK [Install "jq" for log collection]
2026-05-21 01:05:49.832776 | controller | changed
2026-05-21 01:05:49.835205 | 
2026-05-21 01:05:49.835270 | PLAY RECAP
2026-05-21 01:05:49.835333 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-21 01:05:49.835364 | 
2026-05-21 01:05:49.974663 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-05-21 01:05:49.977407 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-21 01:05:50.542851 | 
2026-05-21 01:05:50.542979 | PLAY [all]
2026-05-21 01:05:50.552379 | 
2026-05-21 01:05:50.552451 | TASK [Copy inventory file for Zuul]
2026-05-21 01:05:51.563558 | controller | changed
2026-05-21 01:05:51.571647 | 
2026-05-21 01:05:51.571727 | TASK [Switch "ansible_host" to private IP]
2026-05-21 01:05:51.933146 | controller | changed: 1 replacements made
2026-05-21 01:05:52.713192 | 
2026-05-21 01:05:52.713277 | TASK [Run Molecule scenario]
2026-05-21 01:05:53.104493 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-05-21 01:05:53.104600 | controller | Creating virtual environment at: .venv
2026-05-21 01:05:53.399824 | controller | Downloading cryptography (4.3MiB)
2026-05-21 01:05:53.400333 | controller | Downloading pygments (1.2MiB)
2026-05-21 01:05:53.402233 | controller | Downloading ansible-core (2.3MiB)
2026-05-21 01:05:53.554490 | controller |  Downloading cryptography
2026-05-21 01:05:53.610068 | controller |  Downloading pygments
2026-05-21 01:05:53.758429 | controller |  Downloading ansible-core
2026-05-21 01:05:53.802722 | controller | Installed 36 packages in 43ms
2026-05-21 01:05:54.505857 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-05-21 01:05:54.505910 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-05-21 01:05:55.369569 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-05-21 01:05:55.369616 | controller | INFO     default scenario not found, disabling shared state.
2026-05-21 01:05:55.369701 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-05-21 01:05:55.369777 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-05-21 01:06:19.352647 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-05-21 01:06:19.352785 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-05-21 01:06:19.352992 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-05-21 01:06:19.353111 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-05-21 01:06:19.358818 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-05-21 01:06:19.359127 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-21 01:06:19.364627 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-05-21 01:06:19.364706 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-05-21 01:06:19.364787 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-05-21 01:06:19.370315 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-05-21 01:06:20.226192 | controller |
2026-05-21 01:06:20.226439 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-05-21 01:06:20.291973 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-05-21 01:06:20.303189 | controller | INFO     [upload-helm-chart > create] Executing
2026-05-21 01:06:20.304611 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-21 01:06:20.309941 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-05-21 01:06:20.310191 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-21 01:06:20.315484 | controller | INFO     [upload-helm-chart > converge] Executing
2026-05-21 01:06:21.156979 | controller |
2026-05-21 01:06:21.157181 | controller | PLAY [Converge] ****************************************************************
2026-05-21 01:06:21.157399 | controller |
2026-05-21 01:06:21.157602 | controller | TASK [Gathering Facts] *********************************************************
2026-05-21 01:06:21.157828 | controller | Thursday 21 May 2026  01:06:21 +0000 (0:00:00.031)       0:00:00.031 **********
2026-05-21 01:06:22.354079 | 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-21 01:06:22.361990 | controller | ok: [controller]
2026-05-21 01:06:22.362171 | controller |
2026-05-21 01:06:22.362347 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:22.362582 | controller | Thursday 21 May 2026  01:06:22 +0000 (0:00:01.205)       0:00:01.236 **********
2026-05-21 01:06:22.457227 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-21 01:06:22.457311 | controller |
2026-05-21 01:06:22.457502 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-21 01:06:22.457705 | controller | Thursday 21 May 2026  01:06:22 +0000 (0:00:00.095)       0:00:01.331 **********
2026-05-21 01:06:23.048154 | controller | changed: [controller]
2026-05-21 01:06:23.048207 | controller |
2026-05-21 01:06:23.048360 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:23.048486 | controller | Thursday 21 May 2026  01:06:23 +0000 (0:00:00.590)       0:00:01.922 **********
2026-05-21 01:06:23.101862 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-21 01:06:23.101956 | controller |
2026-05-21 01:06:23.102160 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-21 01:06:23.102350 | controller | Thursday 21 May 2026  01:06:23 +0000 (0:00:00.052)       0:00:01.974 **********
2026-05-21 01:06:23.546209 | controller | changed: [controller]
2026-05-21 01:06:23.546316 | controller |
2026-05-21 01:06:23.546577 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-21 01:06:23.546820 | controller | Thursday 21 May 2026  01:06:23 +0000 (0:00:00.445)       0:00:02.420 **********
2026-05-21 01:06:24.633852 | controller | changed: [controller]
2026-05-21 01:06:24.634004 | controller |
2026-05-21 01:06:24.634219 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-21 01:06:24.634415 | controller | Thursday 21 May 2026  01:06:24 +0000 (0:00:01.087)       0:00:03.507 **********
2026-05-21 01:06:25.033329 | controller | ok: [controller]
2026-05-21 01:06:25.033561 | controller |
2026-05-21 01:06:25.033904 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-21 01:06:25.034174 | controller | Thursday 21 May 2026  01:06:25 +0000 (0:00:00.400)       0:00:03.907 **********
2026-05-21 01:06:25.085334 | controller | skipping: [controller]
2026-05-21 01:06:25.085480 | controller |
2026-05-21 01:06:25.085677 | controller | PLAY RECAP *********************************************************************
2026-05-21 01:06:25.085967 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-21 01:06:25.086171 | controller |
2026-05-21 01:06:25.086352 | controller |
2026-05-21 01:06:25.086578 | controller | TASKS RECAP ********************************************************************
2026-05-21 01:06:25.086854 | controller | Thursday 21 May 2026  01:06:25 +0000 (0:00:00.052)       0:00:03.960 **********
2026-05-21 01:06:25.087042 | controller | ===============================================================================
2026-05-21 01:06:25.087201 | controller | Gathering Facts --------------------------------------------------------- 1.21s
2026-05-21 01:06:25.087411 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.09s
2026-05-21 01:06:25.087614 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.59s
2026-05-21 01:06:25.087829 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.45s
2026-05-21 01:06:25.088008 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-05-21 01:06:25.088264 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.10s
2026-05-21 01:06:25.088514 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s
2026-05-21 01:06:25.088729 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s
2026-05-21 01:06:25.176800 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-05-21 01:06:25.189272 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-05-21 01:06:26.037287 | controller |
2026-05-21 01:06:26.037418 | controller | PLAY [Converge] ****************************************************************
2026-05-21 01:06:26.037595 | controller |
2026-05-21 01:06:26.037815 | controller | TASK [Gathering Facts] *********************************************************
2026-05-21 01:06:26.038004 | controller | Thursday 21 May 2026  01:06:26 +0000 (0:00:00.011)       0:00:00.011 **********
2026-05-21 01:06:27.042055 | 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-21 01:06:27.047280 | controller | ok: [controller]
2026-05-21 01:06:27.047405 | controller |
2026-05-21 01:06:27.047568 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:27.047721 | controller | Thursday 21 May 2026  01:06:27 +0000 (0:00:01.010)       0:00:01.022 **********
2026-05-21 01:06:27.121716 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-21 01:06:27.121774 | controller |
2026-05-21 01:06:27.121876 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-21 01:06:27.122006 | controller | Thursday 21 May 2026  01:06:27 +0000 (0:00:00.074)       0:00:01.096 **********
2026-05-21 01:06:27.777965 | controller | ok: [controller]
2026-05-21 01:06:27.778136 | controller |
2026-05-21 01:06:27.778358 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:27.778602 | controller | Thursday 21 May 2026  01:06:27 +0000 (0:00:00.656)       0:00:01.752 **********
2026-05-21 01:06:27.816654 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-21 01:06:27.816682 | controller |
2026-05-21 01:06:27.816692 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-21 01:06:27.816700 | controller | Thursday 21 May 2026  01:06:27 +0000 (0:00:00.038)       0:00:01.791 **********
2026-05-21 01:06:28.231699 | controller | ok: [controller]
2026-05-21 01:06:28.231733 | controller |
2026-05-21 01:06:28.231743 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-21 01:06:28.231752 | controller | Thursday 21 May 2026  01:06:28 +0000 (0:00:00.414)       0:00:02.205 **********
2026-05-21 01:06:29.285192 | controller | ok: [controller]
2026-05-21 01:06:29.285507 | controller |
2026-05-21 01:06:29.285778 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-21 01:06:29.286030 | controller | Thursday 21 May 2026  01:06:29 +0000 (0:00:01.054)       0:00:03.259 **********
2026-05-21 01:06:29.696042 | controller | ok: [controller]
2026-05-21 01:06:29.696261 | controller |
2026-05-21 01:06:29.696514 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-21 01:06:29.696694 | controller | Thursday 21 May 2026  01:06:29 +0000 (0:00:00.409)       0:00:03.669 **********
2026-05-21 01:06:29.737381 | controller | skipping: [controller]
2026-05-21 01:06:29.737557 | controller |
2026-05-21 01:06:29.737711 | controller | PLAY RECAP *********************************************************************
2026-05-21 01:06:29.737876 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-21 01:06:29.738013 | controller |
2026-05-21 01:06:29.738148 | controller |
2026-05-21 01:06:29.738298 | controller | TASKS RECAP ********************************************************************
2026-05-21 01:06:29.738449 | controller | Thursday 21 May 2026  01:06:29 +0000 (0:00:00.043)       0:00:03.712 **********
2026-05-21 01:06:29.738648 | controller | ===============================================================================
2026-05-21 01:06:29.738812 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.05s
2026-05-21 01:06:29.738960 | controller | Gathering Facts --------------------------------------------------------- 1.01s
2026-05-21 01:06:29.739107 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.66s
2026-05-21 01:06:29.739254 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s
2026-05-21 01:06:29.739405 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-05-21 01:06:29.739575 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-05-21 01:06:29.739726 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-05-21 01:06:29.739881 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-05-21 01:06:29.822452 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-05-21 01:06:29.830625 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-05-21 01:06:30.653604 | controller |
2026-05-21 01:06:30.653634 | controller | PLAY [Side effect] *************************************************************
2026-05-21 01:06:30.653644 | controller |
2026-05-21 01:06:30.653651 | controller | TASK [Gathering Facts] *********************************************************
2026-05-21 01:06:30.653659 | controller | Thursday 21 May 2026  01:06:30 +0000 (0:00:00.010)       0:00:00.010 **********
2026-05-21 01:06:31.676800 | 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-21 01:06:31.681718 | controller | ok: [controller]
2026-05-21 01:06:31.682041 | controller |
2026-05-21 01:06:31.682338 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:31.682679 | controller | Thursday 21 May 2026  01:06:31 +0000 (0:00:01.028)       0:00:01.039 **********
2026-05-21 01:06:31.760950 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-05-21 01:06:31.761372 | controller |
2026-05-21 01:06:31.761799 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-05-21 01:06:31.762256 | controller | Thursday 21 May 2026  01:06:31 +0000 (0:00:00.078)       0:00:01.118 **********
2026-05-21 01:06:32.400424 | controller | changed: [controller]
2026-05-21 01:06:32.400694 | controller |
2026-05-21 01:06:32.400974 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-05-21 01:06:32.401324 | controller | Thursday 21 May 2026  01:06:32 +0000 (0:00:00.639)       0:00:01.758 **********
2026-05-21 01:06:32.443549 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-05-21 01:06:32.443811 | controller |
2026-05-21 01:06:32.444072 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-05-21 01:06:32.444343 | controller | Thursday 21 May 2026  01:06:32 +0000 (0:00:00.043)       0:00:01.801 **********
2026-05-21 01:06:32.859841 | controller | ok: [controller]
2026-05-21 01:06:32.860030 | controller |
2026-05-21 01:06:32.860216 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-05-21 01:06:32.860386 | controller | Thursday 21 May 2026  01:06:32 +0000 (0:00:00.416)       0:00:02.217 **********
2026-05-21 01:06:33.910420 | controller | ok: [controller]
2026-05-21 01:06:33.910454 | controller |
2026-05-21 01:06:33.910464 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-05-21 01:06:33.910472 | controller | Thursday 21 May 2026  01:06:33 +0000 (0:00:01.049)       0:00:03.267 **********
2026-05-21 01:06:34.323433 | controller | ok: [controller]
2026-05-21 01:06:34.323714 | controller |
2026-05-21 01:06:34.323992 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-05-21 01:06:34.324252 | controller | Thursday 21 May 2026  01:06:34 +0000 (0:00:00.411)       0:00:03.679 **********
2026-05-21 01:06:34.630025 | controller | changed: [controller] => (item=/file)
2026-05-21 01:06:34.630307 | controller |
2026-05-21 01:06:34.630578 | controller | PLAY RECAP *********************************************************************
2026-05-21 01:06:34.631015 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-21 01:06:34.631256 | controller |
2026-05-21 01:06:34.631484 | controller |
2026-05-21 01:06:34.631727 | controller | TASKS RECAP ********************************************************************
2026-05-21 01:06:34.631990 | controller | Thursday 21 May 2026  01:06:34 +0000 (0:00:00.309)       0:00:03.988 **********
2026-05-21 01:06:34.632223 | controller | ===============================================================================
2026-05-21 01:06:34.632478 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.05s
2026-05-21 01:06:34.632719 | controller | Gathering Facts --------------------------------------------------------- 1.03s
2026-05-21 01:06:34.632963 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.64s
2026-05-21 01:06:34.633209 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-05-21 01:06:34.633456 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s
2026-05-21 01:06:34.633714 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.31s
2026-05-21 01:06:34.633965 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-05-21 01:06:34.634218 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-05-21 01:06:34.718076 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-05-21 01:06:34.729184 | controller | INFO     [upload-helm-chart > verify] Executing
2026-05-21 01:06:35.554874 | controller |
2026-05-21 01:06:35.554931 | controller | PLAY [Verify] ******************************************************************
2026-05-21 01:06:35.554940 | controller |
2026-05-21 01:06:35.554948 | controller | TASK [Gathering Facts] *********************************************************
2026-05-21 01:06:35.555025 | controller | Thursday 21 May 2026  01:06:35 +0000 (0:00:00.009)       0:00:00.009 **********
2026-05-21 01:06:36.597842 | 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-21 01:06:36.602943 | controller | ok: [controller]
2026-05-21 01:06:36.603251 | controller |
2026-05-21 01:06:36.603529 | controller | TASK [Stat file 1] *************************************************************
2026-05-21 01:06:36.603800 | controller | Thursday 21 May 2026  01:06:36 +0000 (0:00:01.049)       0:00:01.058 **********
2026-05-21 01:06:38.018735 | controller | ok: [controller]
2026-05-21 01:06:38.018871 | controller |
2026-05-21 01:06:38.018992 | controller | TASK [Stat file 2] *************************************************************
2026-05-21 01:06:38.019322 | controller | Thursday 21 May 2026  01:06:38 +0000 (0:00:01.415)       0:00:02.474 **********
2026-05-21 01:06:38.323436 | controller | ok: [controller]
2026-05-21 01:06:38.323476 | controller |
2026-05-21 01:06:38.323482 | controller | TASK [Stat removed file 1] *****************************************************
2026-05-21 01:06:38.323488 | controller | Thursday 21 May 2026  01:06:38 +0000 (0:00:00.303)       0:00:02.777 **********
2026-05-21 01:06:38.608813 | controller | ok: [controller]
2026-05-21 01:06:38.608887 | controller |
2026-05-21 01:06:38.609016 | controller | TASK [Stat removed file 2] *****************************************************
2026-05-21 01:06:38.609151 | controller | Thursday 21 May 2026  01:06:38 +0000 (0:00:00.286)       0:00:03.064 **********
2026-05-21 01:06:38.927050 | controller | ok: [controller]
2026-05-21 01:06:38.927107 | controller |
2026-05-21 01:06:38.927161 | controller | TASK [ansible.builtin.assert] **************************************************
2026-05-21 01:06:38.927247 | controller | Thursday 21 May 2026  01:06:38 +0000 (0:00:00.316)       0:00:03.381 **********
2026-05-21 01:06:38.955999 | controller | ok: [controller] => {
2026-05-21 01:06:38.956171 | controller |     "changed": false,
2026-05-21 01:06:38.956358 | controller |     "msg": "All assertions passed"
2026-05-21 01:06:38.956536 | controller | }
2026-05-21 01:06:38.956705 | controller |
2026-05-21 01:06:38.956890 | controller | PLAY RECAP *********************************************************************
2026-05-21 01:06:38.957094 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-21 01:06:38.957256 | controller |
2026-05-21 01:06:38.957418 | controller |
2026-05-21 01:06:38.957595 | controller | TASKS RECAP ********************************************************************
2026-05-21 01:06:38.957779 | controller | Thursday 21 May 2026  01:06:38 +0000 (0:00:00.030)       0:00:03.412 **********
2026-05-21 01:06:38.957955 | controller | ===============================================================================
2026-05-21 01:06:38.958138 | controller | Stat file 1 ------------------------------------------------------------- 1.42s
2026-05-21 01:06:38.958322 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-05-21 01:06:38.958508 | controller | Stat removed file 2 ----------------------------------------------------- 0.32s
2026-05-21 01:06:38.962739 | controller | Stat file 2 ------------------------------------------------------------- 0.30s
2026-05-21 01:06:38.962838 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s
2026-05-21 01:06:38.962924 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-05-21 01:06:39.046677 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-05-21 01:06:39.049608 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-05-21 01:06:39.049940 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-05-21 01:06:39.055583 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-05-21 01:06:39.055687 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-05-21 01:06:39.055785 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-05-21 01:06:39.056052 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-05-21 01:06:39.291839 | controller | ok: Runtime: 0:00:46.110851
2026-05-21 01:06:39.297449 | 
2026-05-21 01:06:39.297551 | PLAY RECAP
2026-05-21 01:06:39.297635 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-21 01:06:39.297684 | 
2026-05-21 01:06:39.420203 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-05-21 01:06:39.423166 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-21 01:06:40.004213 | 
2026-05-21 01:06:40.004324 | PLAY [all]
2026-05-21 01:06:40.015442 | 
2026-05-21 01:06:40.015547 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-05-21 01:06:40.372681 | controller | changed
2026-05-21 01:06:40.377650 | 
2026-05-21 01:06:40.377741 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-05-21 01:06:40.734691 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-21 01:06:40.734737 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-21 01:06:40.741334 | controller | environment: line 1: kubectl: command not found
2026-05-21 01:06:40.743235 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-21 01:06:40.744154 | controller | environment: line 1: kubectl: command not found
2026-05-21 01:06:40.746389 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-21 01:06:40.747095 | controller | environment: line 1: kubectl: command not found
2026-05-21 01:06:40.749089 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-21 01:06:40.752954 | controller | environment: line 1: kubectl: command not found
2026-05-21 01:06:40.753896 | controller | environment: line 1: kubectl: command not found
2026-05-21 01:06:40.754878 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-21 01:06:40.755179 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-21 01:06:40.909195 | controller | ok: Runtime: 0:00:00.032542
2026-05-21 01:06:40.915606 | 
2026-05-21 01:06:40.915707 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-05-21 01:06:41.166090 | controller | changed
2026-05-21 01:06:41.171757 | 
2026-05-21 01:06:41.171843 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-05-21 01:06:41.418233 | controller | environment: line 5: kubectl: command not found
2026-05-21 01:06:41.418316 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-21 01:06:41.419884 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-21 01:06:41.419919 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-21 01:06:41.709210 | controller | ok: Runtime: 0:00:00.011973
2026-05-21 01:06:41.716329 | 
2026-05-21 01:06:41.716441 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-05-21 01:06:42.371418 | controller | changed:
2026-05-21 01:06:42.371667 | controller | created directory /var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/logs/controller
2026-05-21 01:06:42.371703 | controller | cd+++++++++ objects/
2026-05-21 01:06:42.371728 | controller | cd+++++++++ objects/cluster/
2026-05-21 01:06:42.371751 | controller | cd+++++++++ objects/namespaced/
2026-05-21 01:06:42.379060 | 
2026-05-21 01:06:42.379134 | TASK [gather-pod-logs : creating directory for pod logs]
2026-05-21 01:06:42.617114 | controller | changed
2026-05-21 01:06:42.623006 | 
2026-05-21 01:06:42.623099 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-05-21 01:06:42.869744 | controller | changed
2026-05-21 01:06:42.874276 | 
2026-05-21 01:06:42.874375 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-05-21 01:06:43.102073 | controller | environment: line 3: kubectl: command not found
2026-05-21 01:06:43.406280 | controller | ok: Runtime: 0:00:00.012296
2026-05-21 01:06:43.412780 | 
2026-05-21 01:06:43.412857 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-05-21 01:06:43.902264 | controller | changed:
2026-05-21 01:06:43.902528 | controller | cd+++++++++ pod-logs/
2026-05-21 01:06:43.902590 | controller | cd+++++++++ pod-logs/failed-pods/
2026-05-21 01:06:43.910681 | 
2026-05-21 01:06:43.910739 | LOOP [helm-release-status : creating directory for helm release status]
2026-05-21 01:06:44.132468 | controller | changed: "values"
2026-05-21 01:06:44.337874 | controller | changed: "releases"
2026-05-21 01:06:44.354130 | 
2026-05-21 01:06:44.354282 | TASK [helm-release-status : Gather get release status for helm charts]
2026-05-21 01:06:44.608086 | controller | /bin/bash: line 3: kubectl: command not found
2026-05-21 01:06:44.887733 | controller | ok: Runtime: 0:00:00.008978
2026-05-21 01:06:44.892620 | 
2026-05-21 01:06:44.892686 | TASK [helm-release-status : Downloads logs to executor]
2026-05-21 01:06:45.400052 | controller | changed:
2026-05-21 01:06:45.400207 | controller | cd+++++++++ helm/
2026-05-21 01:06:45.400235 | controller | cd+++++++++ helm/releases/
2026-05-21 01:06:45.400258 | controller | cd+++++++++ helm/values/
2026-05-21 01:06:45.405126 | 
2026-05-21 01:06:45.405177 | PLAY RECAP
2026-05-21 01:06:45.405218 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-21 01:06:45.405240 | 
2026-05-21 01:06:45.519731 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-05-21 01:06:45.521126 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-21 01:06:46.088439 | 
2026-05-21 01:06:46.088552 | PLAY [all]
2026-05-21 01:06:46.098467 | 
2026-05-21 01:06:46.098614 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-21 01:06:46.132629 | controller | skipping: Conditional result was False
2026-05-21 01:06:46.140166 | 
2026-05-21 01:06:46.140271 | TASK [fetch-output : Set log path for single node]
2026-05-21 01:06:46.171519 | controller | ok
2026-05-21 01:06:46.176339 | 
2026-05-21 01:06:46.176430 | LOOP [fetch-output : Ensure local output dirs]
2026-05-21 01:06:46.547830 | controller -> localhost | ok: "/var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/logs"
2026-05-21 01:06:46.759257 | controller -> localhost | changed: "/var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/artifacts"
2026-05-21 01:06:46.965149 | controller -> localhost | changed: "/var/lib/zuul/builds/6ba0ede781eb45d7bf7814009f423d11/work/docs"
2026-05-21 01:06:46.978515 | 
2026-05-21 01:06:46.978676 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-21 01:06:47.631683 | controller | changed: .d..t...... ./
2026-05-21 01:06:47.631868 | controller | changed: All items complete
2026-05-21 01:06:47.631906 | 
2026-05-21 01:06:48.098938 | controller | changed: .d..t...... ./
2026-05-21 01:06:48.541331 | controller | changed: .d..t...... ./
2026-05-21 01:06:48.567818 | 
2026-05-21 01:06:48.567955 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-21 01:06:48.977921 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.020483
2026-05-21 01:06:49.212250 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007578
2026-05-21 01:06:49.228291 | 
2026-05-21 01:06:49.228423 | PLAY [all]
2026-05-21 01:06:49.234899 | 
2026-05-21 01:06:49.235013 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-21 01:06:49.682354 | controller | changed
2026-05-21 01:06:49.688507 | 
2026-05-21 01:06:49.688555 | PLAY RECAP
2026-05-21 01:06:49.688600 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-21 01:06:49.688622 | 
2026-05-21 01:06:49.791928 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-21 01:06:49.793733 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-21 01:06:50.339309 | 
2026-05-21 01:06:50.339412 | PLAY [localhost]
2026-05-21 01:06:50.348774 | 
2026-05-21 01:06:50.348846 | TASK [Generate Zuul manifest]
2026-05-21 01:06:50.369411 | localhost | ok
2026-05-21 01:06:50.382979 | 
2026-05-21 01:06:50.383078 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-21 01:06:50.801463 | localhost | changed
2026-05-21 01:06:50.812701 | 
2026-05-21 01:06:50.812789 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-21 01:06:50.844150 | localhost | ok
2026-05-21 01:06:50.852719 | 
2026-05-21 01:06:50.852786 | TASK [Upload logs]
2026-05-21 01:06:50.874034 | localhost | ok
2026-05-21 01:06:50.934190 | 
2026-05-21 01:06:50.934321 | TASK [Set zuul-log-path fact]
2026-05-21 01:06:50.955950 | localhost | ok
2026-05-21 01:06:50.969950 | 
2026-05-21 01:06:50.970026 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-21 01:06:51.001872 | localhost | ok
2026-05-21 01:06:51.011261 | 
2026-05-21 01:06:51.011331 | TASK [upload-logs : Create log directories]
2026-05-21 01:06:51.407917 | localhost | changed
2026-05-21 01:06:51.414119 | 
2026-05-21 01:06:51.414207 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-21 01:06:51.781329 | localhost -> localhost | ok: Runtime: 0:00:00.005477
2026-05-21 01:06:51.788806 | 
2026-05-21 01:06:51.788885 | TASK [upload-logs : Upload logs to log server]
2026-05-21 01:06:52.224055 | localhost | Output suppressed because no_log was given
2026-05-21 01:06:52.227816 | 
2026-05-21 01:06:52.227887 | LOOP [upload-logs : Compress console log and json output]
2026-05-21 01:06:52.280534 | localhost | skipping: Conditional result was False
2026-05-21 01:06:52.319906 | localhost | skipping: Conditional result was False
2026-05-21 01:06:52.326853 | 
2026-05-21 01:06:52.327009 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-21 01:06:52.369397 | localhost | skipping: Conditional result was False
2026-05-21 01:06:52.369868 | 
2026-05-21 01:06:52.372774 | localhost | skipping: Conditional result was False
2026-05-21 01:06:52.389280 | 
2026-05-21 01:06:52.389421 | LOOP [upload-logs : Upload console log and json output]