2026-04-18 17:49:27.523823 | Job console starting
2026-04-18 17:49:27.542720 | Updating git repos
2026-04-18 17:49:27.621149 | Cloning repos into workspace
2026-04-18 17:49:29.619946 | Restoring repo states
2026-04-18 17:49:29.636107 | Merging changes
2026-04-18 17:49:30.307394 | Checking out repos
2026-04-18 17:49:30.546571 | Preparing playbooks
2026-04-18 17:49:36.476084 | Running Ansible setup
2026-04-18 17:49:40.186481 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-18 17:49:40.828158 | 
2026-04-18 17:49:40.828322 | PLAY [localhost]
2026-04-18 17:49:40.838587 | 
2026-04-18 17:49:40.839403 | TASK [Gathering Facts]
2026-04-18 17:49:41.787932 | localhost | ok
2026-04-18 17:49:41.794633 | 
2026-04-18 17:49:41.794769 | TASK [Setup log path fact]
2026-04-18 17:49:41.811715 | localhost | ok
2026-04-18 17:49:41.824195 | 
2026-04-18 17:49:41.824307 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-18 17:49:41.852617 | localhost | ok
2026-04-18 17:49:41.861592 | 
2026-04-18 17:49:41.861693 | TASK [emit-job-header : Print job information]
2026-04-18 17:49:41.896046 | # Job Information
2026-04-18 17:49:41.896244 | Ansible Version: 2.16.16
2026-04-18 17:49:41.896297 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart
2026-04-18 17:49:41.896334 | Pipeline: check
2026-04-18 17:49:41.896367 | Executor: 0a8996d2b663
2026-04-18 17:49:41.896399 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/265
2026-04-18 17:49:41.896434 | Event ID: 56a28200-3b4c-11f1-9b8f-e4ff071b0bf8
2026-04-18 17:49:41.900632 | 
2026-04-18 17:49:41.900722 | LOOP [emit-job-header : Print node information]
2026-04-18 17:49:41.982248 | localhost | ok:
2026-04-18 17:49:41.982400 | localhost | # Node Information
2026-04-18 17:49:41.982431 | localhost | Inventory Hostname: controller
2026-04-18 17:49:41.982454 | localhost | Hostname: np0000167572
2026-04-18 17:49:41.982475 | localhost | Username: zuul
2026-04-18 17:49:41.982500 | localhost | Distro: Debian 13.4
2026-04-18 17:49:41.982520 | localhost | Provider: yul1
2026-04-18 17:49:41.982540 | localhost | Region: ca-ymq-1
2026-04-18 17:49:41.982559 | localhost | Label: debian-trixie
2026-04-18 17:49:41.982580 | localhost | Product Name: OpenStack Nova
2026-04-18 17:49:41.982600 | localhost | Interface IP: 199.19.213.66
2026-04-18 17:49:41.997194 | 
2026-04-18 17:49:41.997485 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-18 17:49:42.407690 | localhost -> localhost | changed
2026-04-18 17:49:42.412991 | 
2026-04-18 17:49:42.413072 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-18 17:49:43.275922 | localhost -> localhost | changed
2026-04-18 17:49:43.282847 | 
2026-04-18 17:49:43.282935 | PLAY [all]
2026-04-18 17:49:43.291199 | 
2026-04-18 17:49:43.291316 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-18 17:49:43.527982 | controller -> localhost | ok
2026-04-18 17:49:43.535345 | 
2026-04-18 17:49:43.535431 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-18 17:49:43.562939 | controller | ok
2026-04-18 17:49:43.575227 | controller | included: /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-18 17:49:43.582285 | 
2026-04-18 17:49:43.582349 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-18 17:49:44.959760 | controller -> localhost | Generating public/private rsa key pair.
2026-04-18 17:49:44.959971 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/d8743d5afca44cd5bccd32e1bc4a6b3d_id_rsa
2026-04-18 17:49:44.960001 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/d8743d5afca44cd5bccd32e1bc4a6b3d_id_rsa.pub
2026-04-18 17:49:44.960024 | controller -> localhost | The key fingerprint is:
2026-04-18 17:49:44.960045 | controller -> localhost | SHA256:4226JOvo7FZMg7piP9hZ61/2Rk4UjdaPOucbQl/bpks zuul-build-sshkey
2026-04-18 17:49:44.960080 | controller -> localhost | The key's randomart image is:
2026-04-18 17:49:44.960102 | controller -> localhost | +---[RSA 3072]----+
2026-04-18 17:49:44.960132 | controller -> localhost | |            +    |
2026-04-18 17:49:44.960154 | controller -> localhost | |           + o   |
2026-04-18 17:49:44.960174 | controller -> localhost | |     .    . . o  |
2026-04-18 17:49:44.960194 | controller -> localhost | |    . o    . . . |
2026-04-18 17:49:44.960214 | controller -> localhost | |   . o .S ...  . |
2026-04-18 17:49:44.960233 | controller -> localhost | |  .  .o. o.=... o|
2026-04-18 17:49:44.960252 | controller -> localhost | |  o.o.o oo*.+oE.o|
2026-04-18 17:49:44.960271 | controller -> localhost | |.o.=.o +oo.o.o.o |
2026-04-18 17:49:44.960294 | controller -> localhost | |...=Bo+.o... .+. |
2026-04-18 17:49:44.960387 | controller -> localhost | +----[SHA256]-----+
2026-04-18 17:49:44.960454 | controller -> localhost | ok: Runtime: 0:00:00.865476
2026-04-18 17:49:44.965166 | 
2026-04-18 17:49:44.965273 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-18 17:49:45.010539 | controller | ok
2026-04-18 17:49:45.024395 | controller | included: /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-18 17:49:45.037741 | 
2026-04-18 17:49:45.037905 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-18 17:49:45.062539 | controller | skipping: Conditional result was False
2026-04-18 17:49:45.070943 | 
2026-04-18 17:49:45.071038 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-18 17:49:45.597834 | controller | changed
2026-04-18 17:49:45.601842 | 
2026-04-18 17:49:45.601909 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-18 17:49:45.823815 | controller | ok
2026-04-18 17:49:45.827721 | 
2026-04-18 17:49:45.827804 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-18 17:49:46.364181 | controller | changed
2026-04-18 17:49:46.369027 | 
2026-04-18 17:49:46.369109 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-18 17:49:46.885805 | controller | changed
2026-04-18 17:49:46.891996 | 
2026-04-18 17:49:46.892067 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-18 17:49:46.919966 | controller | skipping: Conditional result was False
2026-04-18 17:49:46.926296 | 
2026-04-18 17:49:46.926419 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-18 17:49:47.338431 | controller -> localhost | changed
2026-04-18 17:49:47.353390 | 
2026-04-18 17:49:47.353493 | TASK [add-build-sshkey : Add back temp key]
2026-04-18 17:49:47.684924 | controller -> localhost | Identity added: /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/d8743d5afca44cd5bccd32e1bc4a6b3d_id_rsa (zuul-build-sshkey)
2026-04-18 17:49:47.685178 | controller -> localhost | ok: Runtime: 0:00:00.013306
2026-04-18 17:49:47.689631 | 
2026-04-18 17:49:47.689694 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-18 17:49:48.053307 | controller | ok
2026-04-18 17:49:48.058253 | 
2026-04-18 17:49:48.058337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-18 17:49:48.082954 | controller | skipping: Conditional result was False
2026-04-18 17:49:48.097297 | 
2026-04-18 17:49:48.097520 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-18 17:49:48.476910 | controller | ok
2026-04-18 17:49:48.483403 | 
2026-04-18 17:49:48.483474 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-18 17:49:49.485364 | controller | Output suppressed because no_log was given
2026-04-18 17:49:49.583305 | 
2026-04-18 17:49:49.583476 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-18 17:49:49.812700 | controller | ok: "logs"
2026-04-18 17:49:49.813027 | controller | ok: All items complete
2026-04-18 17:49:49.813084 | 
2026-04-18 17:49:49.991675 | controller | ok: "artifacts"
2026-04-18 17:49:50.189818 | controller | ok: "docs"
2026-04-18 17:49:50.229910 | 
2026-04-18 17:49:50.230042 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-18 17:49:50.446819 | controller | changed: "logs"
2026-04-18 17:49:50.627666 | controller | changed: "artifacts"
2026-04-18 17:49:50.808183 | controller | changed: "docs"
2026-04-18 17:49:50.829557 | 
2026-04-18 17:49:50.830256 | PLAY RECAP
2026-04-18 17:49:50.830316 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-18 17:49:50.830346 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-18 17:49:50.830369 | 
2026-04-18 17:49:51.002090 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-18 17:49:51.004922 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-18 17:49:51.638246 | 
2026-04-18 17:49:51.638396 | PLAY [all]
2026-04-18 17:49:51.649693 | 
2026-04-18 17:49:51.649784 | TASK [setup-uv : Extract archive]
2026-04-18 17:49:54.065245 | controller | changed
2026-04-18 17:49:54.072064 | 
2026-04-18 17:49:54.072160 | TASK [setup-uv : Print version]
2026-04-18 17:49:54.511112 | controller | uv 0.8.13
2026-04-18 17:49:54.605595 | controller | ok: Runtime: 0:00:00.013240
2026-04-18 17:49:54.611810 | 
2026-04-18 17:49:54.611860 | PLAY RECAP
2026-04-18 17:49:54.611902 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-18 17:49:54.611926 | 
2026-04-18 17:49:54.742059 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-18 17:49:54.745086 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-18 17:49:55.402591 | 
2026-04-18 17:49:55.402720 | PLAY [all]
2026-04-18 17:49:55.412929 | 
2026-04-18 17:49:55.413097 | TASK [Update apt cache]
2026-04-18 17:50:00.434123 | controller | ok
2026-04-18 17:50:00.439656 | 
2026-04-18 17:50:00.439868 | TASK [Disable firewalld]
2026-04-18 17:50:00.467537 | controller | skipping: Conditional result was False
2026-04-18 17:50:00.483937 | 
2026-04-18 17:50:00.484072 | TASK [Install "jq" for log collection]
2026-04-18 17:50:02.491609 | controller | changed
2026-04-18 17:50:02.493387 | 
2026-04-18 17:50:02.493436 | PLAY RECAP
2026-04-18 17:50:02.493480 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-18 17:50:02.493503 | 
2026-04-18 17:50:02.680223 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-04-18 17:50:02.682918 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-18 17:50:03.329795 | 
2026-04-18 17:50:03.329947 | PLAY [all]
2026-04-18 17:50:03.340367 | 
2026-04-18 17:50:03.340470 | TASK [Copy inventory file for Zuul]
2026-04-18 17:50:05.283348 | controller | changed
2026-04-18 17:50:05.288723 | 
2026-04-18 17:50:05.288812 | TASK [Switch "ansible_host" to private IP]
2026-04-18 17:50:05.618020 | controller | changed: 1 replacements made
2026-04-18 17:50:05.630616 | 
2026-04-18 17:50:05.630782 | TASK [Run Molecule scenario]
2026-04-18 17:50:06.086261 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-04-18 17:50:06.086417 | controller | Creating virtual environment at: .venv
2026-04-18 17:50:06.124048 | controller | Downloading pygments (1.2MiB)
2026-04-18 17:50:06.130089 | controller | Downloading ansible-core (2.3MiB)
2026-04-18 17:50:06.130280 | controller | Downloading cryptography (4.3MiB)
2026-04-18 17:50:06.282770 | controller |  Downloading cryptography
2026-04-18 17:50:06.335342 | controller |  Downloading pygments
2026-04-18 17:50:06.506343 | controller |  Downloading ansible-core
2026-04-18 17:50:06.550623 | controller | Installed 36 packages in 43ms
2026-04-18 17:50:07.224295 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-04-18 17:50:07.224353 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-04-18 17:50:08.051332 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-04-18 17:50:08.051381 | controller | INFO     default scenario not found, disabling shared state.
2026-04-18 17:50:08.051478 | controller | INFO     [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-04-18 17:50:08.051555 | controller | INFO     [upload-helm-chart > prerun] Performing prerun with role_name_check=0...
2026-04-18 17:50:24.652245 | controller | INFO     [upload-helm-chart > dependency] Executing
2026-04-18 17:50:24.652441 | controller | WARNING  [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml
2026-04-18 17:50:24.652779 | controller | WARNING  [upload-helm-chart > dependency] Missing collections requirements file: collections.yml
2026-04-18 17:50:24.652948 | controller | WARNING  [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-04-18 17:50:24.661014 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-04-18 17:50:24.661487 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-18 17:50:24.669468 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-04-18 17:50:24.669564 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-04-18 17:50:24.669666 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-04-18 17:50:24.677396 | controller | INFO     [upload-helm-chart > syntax] Executing
2026-04-18 17:50:25.559470 | controller |
2026-04-18 17:50:25.559575 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml
2026-04-18 17:50:25.619242 | controller | INFO     [upload-helm-chart > syntax] Executed: Successful
2026-04-18 17:50:25.631154 | controller | INFO     [upload-helm-chart > create] Executing
2026-04-18 17:50:25.632538 | controller | WARNING  [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-18 17:50:25.637978 | controller | INFO     [upload-helm-chart > prepare] Executing
2026-04-18 17:50:25.638247 | controller | WARNING  [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-18 17:50:25.643798 | controller | INFO     [upload-helm-chart > converge] Executing
2026-04-18 17:50:26.494850 | controller |
2026-04-18 17:50:26.495018 | controller | PLAY [Converge] ****************************************************************
2026-04-18 17:50:26.495209 | controller |
2026-04-18 17:50:26.495414 | controller | TASK [Gathering Facts] *********************************************************
2026-04-18 17:50:26.495617 | controller | Saturday 18 April 2026  17:50:26 +0000 (0:00:00.031)       0:00:00.031 ********
2026-04-18 17:50:27.807080 | 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-04-18 17:50:27.812261 | controller | ok: [controller]
2026-04-18 17:50:27.812346 | controller |
2026-04-18 17:50:27.812450 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:27.812549 | controller | Saturday 18 April 2026  17:50:27 +0000 (0:00:01.318)       0:00:01.349 ********
2026-04-18 17:50:27.893377 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-18 17:50:27.893463 | controller |
2026-04-18 17:50:27.893475 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-18 17:50:27.893484 | controller | Saturday 18 April 2026  17:50:27 +0000 (0:00:00.078)       0:00:01.428 ********
2026-04-18 17:50:28.645711 | controller | changed: [controller]
2026-04-18 17:50:28.645890 | controller |
2026-04-18 17:50:28.646203 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:28.646609 | controller | Saturday 18 April 2026  17:50:28 +0000 (0:00:00.753)       0:00:02.182 ********
2026-04-18 17:50:28.678790 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-18 17:50:28.678953 | controller |
2026-04-18 17:50:28.679177 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-18 17:50:28.679395 | controller | Saturday 18 April 2026  17:50:28 +0000 (0:00:00.033)       0:00:02.215 ********
2026-04-18 17:50:29.101161 | controller | changed: [controller]
2026-04-18 17:50:29.101308 | controller |
2026-04-18 17:50:29.101544 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-18 17:50:29.101753 | controller | Saturday 18 April 2026  17:50:29 +0000 (0:00:00.421)       0:00:02.637 ********
2026-04-18 17:50:30.216004 | controller | changed: [controller]
2026-04-18 17:50:30.216045 | controller |
2026-04-18 17:50:30.216055 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-18 17:50:30.216064 | controller | Saturday 18 April 2026  17:50:30 +0000 (0:00:01.111)       0:00:03.749 ********
2026-04-18 17:50:30.639728 | controller | ok: [controller]
2026-04-18 17:50:30.639768 | controller |
2026-04-18 17:50:30.639777 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-18 17:50:30.639785 | controller | Saturday 18 April 2026  17:50:30 +0000 (0:00:00.425)       0:00:04.175 ********
2026-04-18 17:50:30.694641 | controller | skipping: [controller]
2026-04-18 17:50:30.694921 | controller |
2026-04-18 17:50:30.695252 | controller | PLAY RECAP *********************************************************************
2026-04-18 17:50:30.695540 | controller | controller                 : ok=7    changed=3    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-04-18 17:50:30.695779 | controller |
2026-04-18 17:50:30.696059 | controller |
2026-04-18 17:50:30.696322 | controller | TASKS RECAP ********************************************************************
2026-04-18 17:50:30.696596 | controller | Saturday 18 April 2026  17:50:30 +0000 (0:00:00.056)       0:00:04.231 ********
2026-04-18 17:50:30.696837 | controller | ===============================================================================
2026-04-18 17:50:30.697082 | controller | Gathering Facts --------------------------------------------------------- 1.32s
2026-04-18 17:50:30.697362 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s
2026-04-18 17:50:30.697625 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.75s
2026-04-18 17:50:30.697903 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s
2026-04-18 17:50:30.698172 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s
2026-04-18 17:50:30.698483 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-04-18 17:50:30.698750 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s
2026-04-18 17:50:30.699033 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.03s
2026-04-18 17:50:30.805073 | controller | INFO     [upload-helm-chart > converge] Executed: Successful
2026-04-18 17:50:30.814312 | controller | INFO     [upload-helm-chart > idempotence] Executing
2026-04-18 17:50:31.669153 | controller |
2026-04-18 17:50:31.669449 | controller | PLAY [Converge] ****************************************************************
2026-04-18 17:50:31.669687 | controller |
2026-04-18 17:50:31.669948 | controller | TASK [Gathering Facts] *********************************************************
2026-04-18 17:50:31.670324 | controller | Saturday 18 April 2026  17:50:31 +0000 (0:00:00.010)       0:00:00.010 ********
2026-04-18 17:50:32.733758 | 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-04-18 17:50:32.739851 | controller | ok: [controller]
2026-04-18 17:50:32.739874 | controller |
2026-04-18 17:50:32.739883 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:32.739891 | controller | Saturday 18 April 2026  17:50:32 +0000 (0:00:01.069)       0:00:01.080 ********
2026-04-18 17:50:32.820061 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-18 17:50:32.820385 | controller |
2026-04-18 17:50:32.820726 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-18 17:50:32.821066 | controller | Saturday 18 April 2026  17:50:32 +0000 (0:00:00.080)       0:00:01.161 ********
2026-04-18 17:50:33.558987 | controller | ok: [controller]
2026-04-18 17:50:33.559008 | controller |
2026-04-18 17:50:33.559013 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:33.559017 | controller | Saturday 18 April 2026  17:50:33 +0000 (0:00:00.737)       0:00:01.899 ********
2026-04-18 17:50:33.598810 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-18 17:50:33.598938 | controller |
2026-04-18 17:50:33.599062 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-18 17:50:33.599183 | controller | Saturday 18 April 2026  17:50:33 +0000 (0:00:00.041)       0:00:01.940 ********
2026-04-18 17:50:34.035147 | controller | ok: [controller]
2026-04-18 17:50:34.035168 | controller |
2026-04-18 17:50:34.035173 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-18 17:50:34.035177 | controller | Saturday 18 April 2026  17:50:34 +0000 (0:00:00.435)       0:00:02.376 ********
2026-04-18 17:50:35.112213 | controller | ok: [controller]
2026-04-18 17:50:35.112421 | controller |
2026-04-18 17:50:35.112603 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-18 17:50:35.112769 | controller | Saturday 18 April 2026  17:50:35 +0000 (0:00:01.076)       0:00:03.453 ********
2026-04-18 17:50:35.516227 | controller | ok: [controller]
2026-04-18 17:50:35.516571 | controller |
2026-04-18 17:50:35.516925 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-18 17:50:35.517226 | controller | Saturday 18 April 2026  17:50:35 +0000 (0:00:00.403)       0:00:03.857 ********
2026-04-18 17:50:35.553214 | controller | skipping: [controller]
2026-04-18 17:50:35.553529 | controller |
2026-04-18 17:50:35.553912 | controller | PLAY RECAP *********************************************************************
2026-04-18 17:50:35.554210 | controller | controller                 : ok=7    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-04-18 17:50:35.554500 | controller |
2026-04-18 17:50:35.554748 | controller |
2026-04-18 17:50:35.554994 | controller | TASKS RECAP ********************************************************************
2026-04-18 17:50:35.555239 | controller | Saturday 18 April 2026  17:50:35 +0000 (0:00:00.037)       0:00:03.895 ********
2026-04-18 17:50:35.555467 | controller | ===============================================================================
2026-04-18 17:50:35.555722 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.08s
2026-04-18 17:50:35.555965 | controller | Gathering Facts --------------------------------------------------------- 1.07s
2026-04-18 17:50:35.556208 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s
2026-04-18 17:50:35.556448 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.44s
2026-04-18 17:50:35.556690 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-04-18 17:50:35.556952 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s
2026-04-18 17:50:35.557198 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-04-18 17:50:35.557446 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s
2026-04-18 17:50:35.651006 | controller | INFO     [upload-helm-chart > idempotence] Executed: Successful
2026-04-18 17:50:35.675856 | controller | INFO     [upload-helm-chart > side_effect] Executing
2026-04-18 17:50:36.540225 | controller |
2026-04-18 17:50:36.540556 | controller | PLAY [Side effect] *************************************************************
2026-04-18 17:50:36.540870 | controller |
2026-04-18 17:50:36.541143 | controller | TASK [Gathering Facts] *********************************************************
2026-04-18 17:50:36.541498 | controller | Saturday 18 April 2026  17:50:36 +0000 (0:00:00.010)       0:00:00.010 ********
2026-04-18 17:50:37.586979 | 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-04-18 17:50:37.591568 | controller | ok: [controller]
2026-04-18 17:50:37.591588 | controller |
2026-04-18 17:50:37.591597 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:37.591605 | controller | Saturday 18 April 2026  17:50:37 +0000 (0:00:01.050)       0:00:01.061 ********
2026-04-18 17:50:37.662968 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller
2026-04-18 17:50:37.663252 | controller |
2026-04-18 17:50:37.663528 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] ***************
2026-04-18 17:50:37.663790 | controller | Saturday 18 April 2026  17:50:37 +0000 (0:00:00.071)       0:00:01.133 ********
2026-04-18 17:50:38.387159 | controller | changed: [controller]
2026-04-18 17:50:38.387462 | controller |
2026-04-18 17:50:38.387895 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] ***
2026-04-18 17:50:38.388174 | controller | Saturday 18 April 2026  17:50:38 +0000 (0:00:00.724)       0:00:01.857 ********
2026-04-18 17:50:38.427927 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller
2026-04-18 17:50:38.428242 | controller |
2026-04-18 17:50:38.428618 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] **********
2026-04-18 17:50:38.428909 | controller | Saturday 18 April 2026  17:50:38 +0000 (0:00:00.040)       0:00:01.898 ********
2026-04-18 17:50:38.834734 | controller | ok: [controller]
2026-04-18 17:50:38.834867 | controller |
2026-04-18 17:50:38.835022 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] ***
2026-04-18 17:50:38.835159 | controller | Saturday 18 April 2026  17:50:38 +0000 (0:00:00.404)       0:00:02.303 ********
2026-04-18 17:50:39.902146 | controller | ok: [controller]
2026-04-18 17:50:39.902219 | controller |
2026-04-18 17:50:39.902363 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] **********
2026-04-18 17:50:39.902538 | controller | Saturday 18 April 2026  17:50:39 +0000 (0:00:01.066)       0:00:03.369 ********
2026-04-18 17:50:40.302398 | controller | ok: [controller]
2026-04-18 17:50:40.302456 | controller |
2026-04-18 17:50:40.305466 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] ***
2026-04-18 17:50:40.305558 | controller | Saturday 18 April 2026  17:50:40 +0000 (0:00:00.403)       0:00:03.772 ********
2026-04-18 17:50:40.608343 | controller | changed: [controller] => (item=/file)
2026-04-18 17:50:40.608493 | controller |
2026-04-18 17:50:40.608696 | controller | PLAY RECAP *********************************************************************
2026-04-18 17:50:40.608918 | controller | controller                 : ok=8    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-18 17:50:40.609094 | controller |
2026-04-18 17:50:40.609265 | controller |
2026-04-18 17:50:40.609447 | controller | TASKS RECAP ********************************************************************
2026-04-18 17:50:40.609641 | controller | Saturday 18 April 2026  17:50:40 +0000 (0:00:00.306)       0:00:04.079 ********
2026-04-18 17:50:40.609819 | controller | ===============================================================================
2026-04-18 17:50:40.610023 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.07s
2026-04-18 17:50:40.610203 | controller | Gathering Facts --------------------------------------------------------- 1.05s
2026-04-18 17:50:40.610446 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.72s
2026-04-18 17:50:40.610656 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.40s
2026-04-18 17:50:40.610830 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s
2026-04-18 17:50:40.611036 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.31s
2026-04-18 17:50:40.611223 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s
2026-04-18 17:50:40.611414 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s
2026-04-18 17:50:40.685631 | controller | INFO     [upload-helm-chart > side_effect] Executed: Successful
2026-04-18 17:50:40.694984 | controller | INFO     [upload-helm-chart > verify] Executing
2026-04-18 17:50:41.522090 | controller |
2026-04-18 17:50:41.522510 | controller | PLAY [Verify] ******************************************************************
2026-04-18 17:50:41.522724 | controller |
2026-04-18 17:50:41.522937 | controller | TASK [Gathering Facts] *********************************************************
2026-04-18 17:50:41.523211 | controller | Saturday 18 April 2026  17:50:41 +0000 (0:00:00.009)       0:00:00.009 ********
2026-04-18 17:50:43.580311 | 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-04-18 17:50:43.585126 | controller | ok: [controller]
2026-04-18 17:50:43.585312 | controller |
2026-04-18 17:50:43.585517 | controller | TASK [Stat file 1] *************************************************************
2026-04-18 17:50:43.585735 | controller | Saturday 18 April 2026  17:50:43 +0000 (0:00:02.063)       0:00:02.073 ********
2026-04-18 17:50:43.994057 | controller | ok: [controller]
2026-04-18 17:50:43.994265 | controller |
2026-04-18 17:50:43.994561 | controller | TASK [Stat file 2] *************************************************************
2026-04-18 17:50:43.994793 | controller | Saturday 18 April 2026  17:50:43 +0000 (0:00:00.408)       0:00:02.481 ********
2026-04-18 17:50:44.285901 | controller | ok: [controller]
2026-04-18 17:50:44.286110 | controller |
2026-04-18 17:50:44.286367 | controller | TASK [Stat removed file 1] *****************************************************
2026-04-18 17:50:44.286652 | controller | Saturday 18 April 2026  17:50:44 +0000 (0:00:00.291)       0:00:02.773 ********
2026-04-18 17:50:44.577414 | controller | ok: [controller]
2026-04-18 17:50:44.577451 | controller |
2026-04-18 17:50:44.577461 | controller | TASK [Stat removed file 2] *****************************************************
2026-04-18 17:50:44.577481 | controller | Saturday 18 April 2026  17:50:44 +0000 (0:00:00.288)       0:00:03.062 ********
2026-04-18 17:50:44.867497 | controller | ok: [controller]
2026-04-18 17:50:44.867778 | controller |
2026-04-18 17:50:44.868047 | controller | TASK [ansible.builtin.assert] **************************************************
2026-04-18 17:50:44.868308 | controller | Saturday 18 April 2026  17:50:44 +0000 (0:00:00.293)       0:00:03.355 ********
2026-04-18 17:50:44.899109 | controller | ok: [controller] => {
2026-04-18 17:50:44.899461 | controller |     "changed": false,
2026-04-18 17:50:44.899742 | controller |     "msg": "All assertions passed"
2026-04-18 17:50:44.900004 | controller | }
2026-04-18 17:50:44.900321 | controller |
2026-04-18 17:50:44.900700 | controller | PLAY RECAP *********************************************************************
2026-04-18 17:50:44.900999 | controller | controller                 : ok=6    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-18 17:50:44.901251 | controller |
2026-04-18 17:50:44.901507 | controller |
2026-04-18 17:50:44.901771 | controller | TASKS RECAP ********************************************************************
2026-04-18 17:50:44.902042 | controller | Saturday 18 April 2026  17:50:44 +0000 (0:00:00.031)       0:00:03.386 ********
2026-04-18 17:50:44.902294 | controller | ===============================================================================
2026-04-18 17:50:44.902775 | controller | Gathering Facts --------------------------------------------------------- 2.06s
2026-04-18 17:50:44.903115 | controller | Stat file 1 ------------------------------------------------------------- 0.41s
2026-04-18 17:50:44.903429 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s
2026-04-18 17:50:44.903785 | controller | Stat file 2 ------------------------------------------------------------- 0.29s
2026-04-18 17:50:44.904141 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s
2026-04-18 17:50:44.904480 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s
2026-04-18 17:50:44.980657 | controller | INFO     [upload-helm-chart > verify] Executed: Successful
2026-04-18 17:50:44.990039 | controller | INFO     [upload-helm-chart > cleanup] Executing
2026-04-18 17:50:44.990567 | controller | WARNING  [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-18 17:50:44.996118 | controller | INFO     [upload-helm-chart > destroy] Executing
2026-04-18 17:50:44.996236 | controller | WARNING  [upload-helm-chart > destroy] Skipping, '--destroy=never' requested.
2026-04-18 17:50:44.996321 | controller | INFO     [upload-helm-chart > destroy] Executed: Successful
2026-04-18 17:50:44.996592 | controller | WARNING  Molecule executed 1 scenario (1 missing files)
2026-04-18 17:50:45.203677 | controller | ok: Runtime: 0:00:39.052372
2026-04-18 17:50:45.210129 | 
2026-04-18 17:50:45.210219 | PLAY RECAP
2026-04-18 17:50:45.210283 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-18 17:50:45.210316 | 
2026-04-18 17:50:45.358552 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-18 17:50:45.359856 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-18 17:50:45.959981 | 
2026-04-18 17:50:46.068531 | PLAY [all]
2026-04-18 17:50:46.089079 | 
2026-04-18 17:50:46.123141 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-18 17:50:46.561586 | controller | changed
2026-04-18 17:50:46.568022 | 
2026-04-18 17:50:46.568330 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-18 17:50:46.963874 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-18 17:50:46.963965 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-18 17:50:46.969748 | controller | environment: line 1: kubectl: command not found
2026-04-18 17:50:46.971861 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-18 17:50:46.972282 | controller | environment: line 1: kubectl: command not found
2026-04-18 17:50:46.973490 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-18 17:50:46.978264 | controller | environment: line 1: kubectl: command not found
2026-04-18 17:50:46.978462 | controller | environment: line 1: kubectl: command not found
2026-04-18 17:50:46.979296 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-18 17:50:46.979673 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-18 17:50:46.982561 | controller | environment: line 1: kubectl: command not found
2026-04-18 17:50:46.984855 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-18 17:50:47.104605 | controller | ok: Runtime: 0:00:00.035018
2026-04-18 17:50:47.110248 | 
2026-04-18 17:50:47.120997 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-18 17:50:47.342818 | controller | changed
2026-04-18 17:50:47.364641 | 
2026-04-18 17:50:47.364851 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-18 17:50:47.606206 | controller | environment: line 5: kubectl: command not found
2026-04-18 17:50:47.606441 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-18 17:50:47.606804 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-18 17:50:47.607355 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-18 17:50:47.903795 | controller | ok: Runtime: 0:00:00.011414
2026-04-18 17:50:47.910875 | 
2026-04-18 17:50:47.910973 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-18 17:50:48.642316 | controller | changed:
2026-04-18 17:50:48.642468 | controller | created directory /var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/logs/controller
2026-04-18 17:50:48.642500 | controller | cd+++++++++ objects/
2026-04-18 17:50:48.642523 | controller | cd+++++++++ objects/cluster/
2026-04-18 17:50:48.642546 | controller | cd+++++++++ objects/namespaced/
2026-04-18 17:50:48.649933 | 
2026-04-18 17:50:48.650005 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-18 17:50:48.907438 | controller | changed
2026-04-18 17:50:48.912768 | 
2026-04-18 17:50:48.912870 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-18 17:50:49.140481 | controller | changed
2026-04-18 17:50:49.151865 | 
2026-04-18 17:50:49.152000 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-18 17:50:49.405680 | controller | environment: line 3: kubectl: command not found
2026-04-18 17:50:49.833666 | controller | ok: Runtime: 0:00:00.013211
2026-04-18 17:50:49.840018 | 
2026-04-18 17:50:49.840140 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-18 17:50:50.394988 | controller | changed:
2026-04-18 17:50:50.395140 | controller | cd+++++++++ pod-logs/
2026-04-18 17:50:50.395170 | controller | cd+++++++++ pod-logs/failed-pods/
2026-04-18 17:50:50.404432 | 
2026-04-18 17:50:50.404509 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-18 17:50:50.636276 | controller | changed: "values"
2026-04-18 17:50:50.894228 | controller | changed: "releases"
2026-04-18 17:50:50.906754 | 
2026-04-18 17:50:50.906940 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-18 17:50:51.192146 | controller | /bin/bash: line 3: kubectl: command not found
2026-04-18 17:50:51.447131 | controller | ok: Runtime: 0:00:00.009154
2026-04-18 17:50:51.495454 | 
2026-04-18 17:50:51.495605 | TASK [helm-release-status : Downloads logs to executor]
2026-04-18 17:50:52.081369 | controller | changed:
2026-04-18 17:50:52.081572 | controller | cd+++++++++ helm/
2026-04-18 17:50:52.081602 | controller | cd+++++++++ helm/releases/
2026-04-18 17:50:52.081626 | controller | cd+++++++++ helm/values/
2026-04-18 17:50:52.086450 | 
2026-04-18 17:50:52.144727 | PLAY RECAP
2026-04-18 17:50:52.145015 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-18 17:50:52.145094 | 
2026-04-18 17:50:52.268226 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-04-18 17:50:52.325169 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-18 17:50:52.924510 | 
2026-04-18 17:50:52.924644 | PLAY [all]
2026-04-18 17:50:52.936372 | 
2026-04-18 17:50:52.957399 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-18 17:50:53.004198 | controller | skipping: Conditional result was False
2026-04-18 17:50:53.012265 | 
2026-04-18 17:50:53.012403 | TASK [fetch-output : Set log path for single node]
2026-04-18 17:50:53.053542 | controller | ok
2026-04-18 17:50:53.067577 | 
2026-04-18 17:50:53.067883 | LOOP [fetch-output : Ensure local output dirs]
2026-04-18 17:50:53.553574 | controller -> localhost | ok: "/var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/logs"
2026-04-18 17:50:53.769574 | controller -> localhost | changed: "/var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/artifacts"
2026-04-18 17:50:53.994023 | controller -> localhost | changed: "/var/lib/zuul/builds/d8743d5afca44cd5bccd32e1bc4a6b3d/work/docs"
2026-04-18 17:50:54.004882 | 
2026-04-18 17:50:54.007107 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-18 17:50:54.663111 | controller | changed: .d..t...... ./
2026-04-18 17:50:54.663311 | controller | changed: All items complete
2026-04-18 17:50:54.663338 | 
2026-04-18 17:50:55.142719 | controller | changed: .d..t...... ./
2026-04-18 17:50:55.685529 | controller | changed: .d..t...... ./
2026-04-18 17:50:55.710571 | 
2026-04-18 17:50:55.710711 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-18 17:50:56.255437 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.044924
2026-04-18 17:50:56.480322 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.003991
2026-04-18 17:50:56.490180 | 
2026-04-18 17:50:56.490793 | PLAY [all]
2026-04-18 17:50:56.496828 | 
2026-04-18 17:50:56.496909 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-18 17:50:56.955836 | controller | changed
2026-04-18 17:50:56.963852 | 
2026-04-18 17:50:56.963918 | PLAY RECAP
2026-04-18 17:50:56.963965 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-18 17:50:56.963989 | 
2026-04-18 17:50:57.198433 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-18 17:50:57.204481 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-18 17:50:57.828199 | 
2026-04-18 17:50:57.828371 | PLAY [localhost]
2026-04-18 17:50:57.839705 | 
2026-04-18 17:50:57.840646 | TASK [Generate Zuul manifest]
2026-04-18 17:50:57.862439 | localhost | ok
2026-04-18 17:50:57.878934 | 
2026-04-18 17:50:57.887715 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-18 17:50:58.496291 | localhost | changed
2026-04-18 17:50:58.510652 | 
2026-04-18 17:50:58.510794 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-18 17:50:58.554695 | localhost | ok
2026-04-18 17:50:58.565305 | 
2026-04-18 17:50:58.565386 | TASK [Upload logs]
2026-04-18 17:50:58.589785 | localhost | ok
2026-04-18 17:50:58.694488 | 
2026-04-18 17:50:58.703668 | TASK [Set zuul-log-path fact]
2026-04-18 17:50:58.726320 | localhost | ok
2026-04-18 17:50:58.744540 | 
2026-04-18 17:50:59.019867 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-18 17:50:59.055146 | localhost | ok
2026-04-18 17:50:59.062441 | 
2026-04-18 17:50:59.068212 | TASK [upload-logs : Create log directories]
2026-04-18 17:50:59.503089 | localhost | changed
2026-04-18 17:50:59.509429 | 
2026-04-18 17:50:59.515972 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-18 17:50:59.979447 | localhost -> localhost | ok: Runtime: 0:00:00.043720
2026-04-18 17:50:59.989749 | 
2026-04-18 17:50:59.989864 | TASK [upload-logs : Upload logs to log server]
2026-04-18 17:51:00.553684 | localhost | Output suppressed because no_log was given
2026-04-18 17:51:00.557852 | 
2026-04-18 17:51:00.557928 | LOOP [upload-logs : Compress console log and json output]
2026-04-18 17:51:00.608260 | localhost | skipping: Conditional result was False
2026-04-18 17:51:00.667475 | localhost | skipping: Conditional result was False
2026-04-18 17:51:00.691198 | 
2026-04-18 17:51:00.691386 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-18 17:51:00.748810 | localhost | skipping: Conditional result was False
2026-04-18 17:51:00.749419 | 
2026-04-18 17:51:00.753439 | localhost | skipping: Conditional result was False
2026-04-18 17:51:00.780389 | 
2026-04-18 17:51:00.781067 | LOOP [upload-logs : Upload console log and json output]