2026-08-13 00:36:24.559833 | Job console starting
2026-08-13 00:36:24.570969 | Updating git repos
2026-08-13 00:36:24.626744 | Cloning repos into workspace
2026-08-13 00:36:24.668091 | Restoring repo states
2026-08-13 00:36:24.682915 | Merging changes
2026-08-13 00:36:25.303461 | Checking out repos
2026-08-13 00:36:25.342702 | Preparing playbooks
2026-08-13 00:36:29.316567 | Running Ansible setup
2026-08-13 00:36:32.817143 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-13 00:36:33.478425 | 
2026-08-13 00:36:33.478616 | PLAY [localhost]
2026-08-13 00:36:33.488219 | 
2026-08-13 00:36:33.488391 | TASK [Gathering Facts]
2026-08-13 00:36:34.386710 | localhost | ok
2026-08-13 00:36:34.396298 | 
2026-08-13 00:36:34.396453 | TASK [Setup log path fact]
2026-08-13 00:36:34.426808 | localhost | ok
2026-08-13 00:36:34.441793 | 
2026-08-13 00:36:34.441862 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-13 00:36:34.471489 | localhost | ok
2026-08-13 00:36:34.479694 | 
2026-08-13 00:36:34.479758 | TASK [emit-job-header : Print job information]
2026-08-13 00:36:34.520166 | # Job Information
2026-08-13 00:36:34.520311 | Ansible Version: 2.16.18
2026-08-13 00:36:34.520355 | Job: ansible-collection-kubernetes-molecule-aio-ubuntu-jammy
2026-08-13 00:36:34.520386 | Pipeline: check
2026-08-13 00:36:34.520415 | Executor: 2d72f0692154
2026-08-13 00:36:34.520442 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/293
2026-08-13 00:36:34.520474 | Event ID: a45de990-96ae-11f1-8f62-7ff15b8208de
2026-08-13 00:36:34.524196 | 
2026-08-13 00:36:34.524281 | LOOP [emit-job-header : Print node information]
2026-08-13 00:36:34.617389 | localhost | ok:
2026-08-13 00:36:34.617609 | localhost | # Node Information
2026-08-13 00:36:34.617667 | localhost | Inventory Hostname: controller
2026-08-13 00:36:34.617699 | localhost | Hostname: np0000189095
2026-08-13 00:36:34.617727 | localhost | Username: zuul
2026-08-13 00:36:34.617759 | localhost | Distro: Ubuntu 22.04
2026-08-13 00:36:34.617787 | localhost | Provider: yul1
2026-08-13 00:36:34.617814 | localhost | Region: ca-ymq-1
2026-08-13 00:36:34.617840 | localhost | Label: ubuntu-jammy
2026-08-13 00:36:34.617867 | localhost | Product Name: OpenStack Nova
2026-08-13 00:36:34.617893 | localhost | Interface IP: 199.204.45.240
2026-08-13 00:36:34.638555 | 
2026-08-13 00:36:34.638715 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-13 00:36:35.050667 | localhost -> localhost | changed
2026-08-13 00:36:35.059860 | 
2026-08-13 00:36:35.060157 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-13 00:36:35.966415 | localhost -> localhost | changed
2026-08-13 00:36:35.979478 | 
2026-08-13 00:36:35.979560 | PLAY [all]
2026-08-13 00:36:35.989432 | 
2026-08-13 00:36:35.989521 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-13 00:36:36.213054 | controller -> localhost | ok
2026-08-13 00:36:36.222571 | 
2026-08-13 00:36:36.222667 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-13 00:36:36.258866 | controller | ok
2026-08-13 00:36:36.280010 | controller | included: /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-13 00:36:36.286070 | 
2026-08-13 00:36:36.286137 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-13 00:36:37.013359 | controller -> localhost | Generating public/private rsa key pair.
2026-08-13 00:36:37.013561 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/2ea4c33eb5e94737b4a742547c294dd3_id_rsa
2026-08-13 00:36:37.013594 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/2ea4c33eb5e94737b4a742547c294dd3_id_rsa.pub
2026-08-13 00:36:37.013618 | controller -> localhost | The key fingerprint is:
2026-08-13 00:36:37.013642 | controller -> localhost | SHA256:xzBkMwAQKhrA6udmJVZIiD84dO3TQAnbdo6VK3j9bJg zuul-build-sshkey
2026-08-13 00:36:37.013679 | controller -> localhost | The key's randomart image is:
2026-08-13 00:36:37.013702 | controller -> localhost | +---[RSA 3072]----+
2026-08-13 00:36:37.013732 | controller -> localhost | |+ ++=oo.=        |
2026-08-13 00:36:37.013756 | controller -> localhost | |o= oo+ o.o       |
2026-08-13 00:36:37.013779 | controller -> localhost | |*oo.ooo+o        |
2026-08-13 00:36:37.013800 | controller -> localhost | |*.o.o+*..+       |
2026-08-13 00:36:37.013821 | controller -> localhost | |o. o.+.+S o      |
2026-08-13 00:36:37.013842 | controller -> localhost | | . +... =.       |
2026-08-13 00:36:37.013862 | controller -> localhost | |  + o  E +       |
2026-08-13 00:36:37.013883 | controller -> localhost | |   +    .        |
2026-08-13 00:36:37.013907 | controller -> localhost | |  o              |
2026-08-13 00:36:37.013928 | controller -> localhost | +----[SHA256]-----+
2026-08-13 00:36:37.013983 | controller -> localhost | ok: Runtime: 0:00:00.265034
2026-08-13 00:36:37.019634 | 
2026-08-13 00:36:37.019722 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-13 00:36:37.052564 | controller | ok
2026-08-13 00:36:37.064782 | controller | included: /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-13 00:36:37.073168 | 
2026-08-13 00:36:37.073238 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-13 00:36:37.098644 | controller | skipping: Conditional result was False
2026-08-13 00:36:37.109874 | 
2026-08-13 00:36:37.109983 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-13 00:36:37.551222 | controller | changed
2026-08-13 00:36:37.558772 | 
2026-08-13 00:36:37.558879 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-13 00:36:37.733813 | controller | ok
2026-08-13 00:36:37.740516 | 
2026-08-13 00:36:37.740605 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-13 00:36:38.205707 | controller | changed
2026-08-13 00:36:38.216352 | 
2026-08-13 00:36:38.216453 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-13 00:36:38.689809 | controller | changed
2026-08-13 00:36:38.697581 | 
2026-08-13 00:36:38.697699 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-13 00:36:38.722947 | controller | skipping: Conditional result was False
2026-08-13 00:36:38.731420 | 
2026-08-13 00:36:38.731516 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-13 00:36:39.132193 | controller -> localhost | changed
2026-08-13 00:36:39.149909 | 
2026-08-13 00:36:39.150091 | TASK [add-build-sshkey : Add back temp key]
2026-08-13 00:36:39.446004 | controller -> localhost | Identity added: /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/2ea4c33eb5e94737b4a742547c294dd3_id_rsa (zuul-build-sshkey)
2026-08-13 00:36:39.446335 | controller -> localhost | ok: Runtime: 0:00:00.016541
2026-08-13 00:36:39.454594 | 
2026-08-13 00:36:39.454794 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-13 00:36:39.813053 | controller | ok
2026-08-13 00:36:39.819880 | 
2026-08-13 00:36:39.819984 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-13 00:36:39.844793 | controller | skipping: Conditional result was False
2026-08-13 00:36:39.865563 | 
2026-08-13 00:36:39.865690 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-13 00:36:40.246717 | controller | ok
2026-08-13 00:36:40.253187 | 
2026-08-13 00:36:40.253276 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-13 00:36:41.177067 | controller | Output suppressed because no_log was given
2026-08-13 00:36:41.256453 | 
2026-08-13 00:36:41.256633 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-13 00:36:41.458671 | controller | ok: "logs"
2026-08-13 00:36:41.459014 | controller | ok: All items complete
2026-08-13 00:36:41.459072 | 
2026-08-13 00:36:41.633745 | controller | ok: "artifacts"
2026-08-13 00:36:41.796813 | controller | ok: "docs"
2026-08-13 00:36:41.821953 | 
2026-08-13 00:36:41.822204 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-13 00:36:42.020592 | controller | changed: "logs"
2026-08-13 00:36:42.183711 | controller | changed: "artifacts"
2026-08-13 00:36:42.344082 | controller | changed: "docs"
2026-08-13 00:36:42.362820 | 
2026-08-13 00:36:42.362985 | PLAY RECAP
2026-08-13 00:36:42.363056 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-13 00:36:42.363113 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 00:36:42.363151 | 
2026-08-13 00:36:42.568524 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-13 00:36:42.570861 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-13 00:36:43.201337 | 
2026-08-13 00:36:43.201518 | PLAY [all]
2026-08-13 00:36:43.213184 | 
2026-08-13 00:36:43.213281 | TASK [setup-uv : Extract archive]
2026-08-13 00:36:45.429448 | controller | changed
2026-08-13 00:36:45.437322 | 
2026-08-13 00:36:45.437430 | TASK [setup-uv : Print version]
2026-08-13 00:36:45.774007 | controller | uv 0.8.13
2026-08-13 00:36:45.974531 | controller | ok: Runtime: 0:00:00.013373
2026-08-13 00:36:45.985709 | 
2026-08-13 00:36:45.985773 | TASK [Install Ansible collection siblings]
2026-08-13 00:36:46.370289 | controller | ok:
2026-08-13 00:36:46.370574 | controller | Skipping ansible.posix: no checked-out sibling
2026-08-13 00:36:46.370639 | controller | Skipping community.crypto: no checked-out sibling
2026-08-13 00:36:46.370688 | controller | Skipping community.general: no checked-out sibling
2026-08-13 00:36:46.370733 | controller | Skipping kubernetes.core: no checked-out sibling
2026-08-13 00:36:46.370778 | controller | Skipping vexxhost.containers: no checked-out sibling
2026-08-13 00:36:46.374171 | 
2026-08-13 00:36:46.374220 | PLAY RECAP
2026-08-13 00:36:46.374273 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 00:36:46.374295 | 
2026-08-13 00:36:46.504123 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-13 00:36:46.506598 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-13 00:36:47.130907 | 
2026-08-13 00:36:47.131078 | PLAY [all]
2026-08-13 00:36:47.142506 | 
2026-08-13 00:36:47.142619 | TASK [Update apt cache]
2026-08-13 00:37:11.865266 | controller | changed
2026-08-13 00:37:11.872661 | 
2026-08-13 00:37:11.872783 | TASK [Disable firewalld]
2026-08-13 00:37:11.898979 | controller | skipping: Conditional result was False
2026-08-13 00:37:11.908089 | 
2026-08-13 00:37:11.908200 | TASK [Install "jq" for log collection]
2026-08-13 00:37:15.457506 | controller | changed
2026-08-13 00:37:15.459305 | 
2026-08-13 00:37:15.459354 | PLAY RECAP
2026-08-13 00:37:15.459400 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-13 00:37:15.459422 | 
2026-08-13 00:37:15.635784 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-08-13 00:37:15.638550 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-13 00:37:16.225064 | 
2026-08-13 00:37:16.225532 | PLAY [all]
2026-08-13 00:37:16.236255 | 
2026-08-13 00:37:16.236336 | LOOP [Check inventory directories]
2026-08-13 00:37:16.590548 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-13 00:37:16.738871 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/molecule/aio/inventory"
2026-08-13 00:37:16.895211 | controller | ok: "src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/aio/inventory"
2026-08-13 00:37:17.001624 | 
2026-08-13 00:37:17.001916 | LOOP [Copy inventory file for Zuul]
2026-08-13 00:37:17.806660 | controller | changed:
2026-08-13 00:37:17.806874 | controller | {
2026-08-13 00:37:17.806903 | controller |   "ansible_loop_var": "item",
2026-08-13 00:37:17.806926 | controller |   "changed": false,
2026-08-13 00:37:17.806947 | controller |   "failed": false,
2026-08-13 00:37:17.806972 | controller |   "invocation": {
2026-08-13 00:37:17.806992 | controller |     "module_args": {
2026-08-13 00:37:17.807011 | controller |       "checksum_algorithm": "sha1",
2026-08-13 00:37:17.807030 | controller |       "follow": true,
2026-08-13 00:37:17.807048 | controller |       "get_attributes": true,
2026-08-13 00:37:17.807068 | controller |       "get_checksum": true,
2026-08-13 00:37:17.807086 | controller |       "get_mime": true,
2026-08-13 00:37:17.807104 | controller |       "path": "src/github.com/vexxhost/ansible-collection-kubernetes"
2026-08-13 00:37:17.807121 | controller |     }
2026-08-13 00:37:17.807139 | controller |   },
2026-08-13 00:37:17.807156 | controller |   "item": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-13 00:37:17.807174 | controller |   "stat": {
2026-08-13 00:37:17.807192 | controller |     "atime": 1786581401.0575652,
2026-08-13 00:37:17.807209 | controller |     "attr_flags": "e",
2026-08-13 00:37:17.807227 | controller |     "attributes": [
2026-08-13 00:37:17.807245 | controller |       "extents"
2026-08-13 00:37:17.807263 | controller |     ],
2026-08-13 00:37:17.807280 | controller |     "block_size": 4096,
2026-08-13 00:37:17.807298 | controller |     "blocks": 8,
2026-08-13 00:37:17.807315 | controller |     "charset": "unknown",
2026-08-13 00:37:17.807334 | controller |     "ctime": 1786581401.0735652,
2026-08-13 00:37:17.807352 | controller |     "dev": 64513,
2026-08-13 00:37:17.807370 | controller |     "device_type": 0,
2026-08-13 00:37:17.807389 | controller |     "executable": true,
2026-08-13 00:37:17.807406 | controller |     "exists": true,
2026-08-13 00:37:17.807424 | controller |     "gid": 1000,
2026-08-13 00:37:17.807443 | controller |     "gr_name": "zuul",
2026-08-13 00:37:17.807460 | controller |     "inode": 1042461,
2026-08-13 00:37:17.807478 | controller |     "isblk": false,
2026-08-13 00:37:17.807496 | controller |     "ischr": false,
2026-08-13 00:37:17.807514 | controller |     "isdir": true,
2026-08-13 00:37:17.807531 | controller |     "isfifo": false,
2026-08-13 00:37:17.807548 | controller |     "isgid": false,
2026-08-13 00:37:17.807566 | controller |     "islnk": false,
2026-08-13 00:37:17.807583 | controller |     "isreg": false,
2026-08-13 00:37:17.807600 | controller |     "issock": false,
2026-08-13 00:37:17.807619 | controller |     "isuid": false,
2026-08-13 00:37:17.807638 | controller |     "mimetype": "unknown",
2026-08-13 00:37:17.807656 | controller |     "mode": "0755",
2026-08-13 00:37:17.807673 | controller |     "mtime": 1786581384.7785418,
2026-08-13 00:37:17.807689 | controller |     "nlink": 14,
2026-08-13 00:37:17.807706 | controller |     "path": "src/github.com/vexxhost/ansible-collection-kubernetes",
2026-08-13 00:37:17.807723 | controller |     "pw_name": "zuul",
2026-08-13 00:37:17.807743 | controller |     "readable": true,
2026-08-13 00:37:17.807760 | controller |     "rgrp": true,
2026-08-13 00:37:17.807778 | controller |     "roth": true,
2026-08-13 00:37:17.807817 | controller |     "rusr": true,
2026-08-13 00:37:17.807845 | controller |     "size": 4096,
2026-08-13 00:37:17.807862 | controller |     "uid": 1000,
2026-08-13 00:37:17.807879 | controller |     "version": "1521084030",
2026-08-13 00:37:17.807897 | controller |     "wgrp": false,
2026-08-13 00:37:17.807916 | controller |     "woth": false,
2026-08-13 00:37:17.807933 | controller |     "writeable": true,
2026-08-13 00:37:17.807951 | controller |     "wusr": true,
2026-08-13 00:37:17.807967 | controller |     "xgrp": true,
2026-08-13 00:37:17.807985 | controller |     "xoth": true,
2026-08-13 00:37:17.808002 | controller |     "xusr": true
2026-08-13 00:37:17.808033 | controller |   }
2026-08-13 00:37:17.808050 | controller | }
2026-08-13 00:37:17.808088 | controller | ok: All items complete
2026-08-13 00:37:17.808109 | 
2026-08-13 00:37:17.809565 | controller | skipping: Conditional result was False
2026-08-13 00:37:17.810158 | controller | skipping: Conditional result was False
2026-08-13 00:37:17.828665 | 
2026-08-13 00:37:17.828903 | LOOP [Switch "ansible_host" to private IP]
2026-08-13 00:37:18.181003 | controller | changed: 1 replacements made
2026-08-13 00:37:18.182783 | controller | skipping: Conditional result was False
2026-08-13 00:37:18.183380 | controller | skipping: Conditional result was False
2026-08-13 00:37:18.196824 | 
2026-08-13 00:37:18.197175 | TASK [Run Molecule scenario]
2026-08-13 00:37:18.591505 | controller | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-13 00:37:18.591710 | controller | Creating virtual environment at: .venv
2026-08-13 00:37:18.888456 | controller | Downloading pygments (1.2MiB)
2026-08-13 00:37:18.888826 | controller | Downloading ansible-core (2.1MiB)
2026-08-13 00:37:18.901776 | controller | Downloading cryptography (4.3MiB)
2026-08-13 00:37:19.057695 | controller |  Downloading cryptography
2026-08-13 00:37:19.091123 | controller |  Downloading pygments
2026-08-13 00:37:19.215649 | controller |  Downloading ansible-core
2026-08-13 00:37:19.255033 | controller | Installed 39 packages in 37ms
2026-08-13 00:37:19.891620 | controller | INFO     Collection 'vexxhost.kubernetes' detected.
2026-08-13 00:37:19.892272 | controller | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-13 00:37:20.466506 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-08-13 00:37:20.466561 | controller | INFO     default scenario not found, disabling shared state.
2026-08-13 00:37:20.466653 | controller | INFO     [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-13 00:37:20.466730 | controller | INFO     [aio > prerun] Performing prerun with role_name_check=0...
2026-08-13 00:38:42.021441 | controller | WARNING  Retrying execution failure 250 of: ansible-galaxy collection install -vvv vexxhost.containers:>=1.6.0
2026-08-13 00:38:42.021531 | controller | ERROR    Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.6.0, returned 250 code:
2026-08-13 00:38:42.021562 | controller | Starting galaxy collection install process
2026-08-13 00:38:42.021573 | controller | Process install dependency map
2026-08-13 00:38:42.021583 | controller | the full traceback was:
2026-08-13 00:38:42.021593 | controller |
2026-08-13 00:38:42.021602 | controller | Traceback (most recent call last):
2026-08-13 00:38:42.021612 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/__init__.py", line 658, in cli_executor
2026-08-13 00:38:42.021622 | controller |     exit_code = cli.run()
2026-08-13 00:38:42.021632 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 773, in run
2026-08-13 00:38:42.021641 | controller |     return context.CLIARGS()
2026-08-13 00:38:42.021650 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 120, in method_wrapper
2026-08-13 00:38:42.021659 | controller |     return wrapped_method(*args, **kwargs)
2026-08-13 00:38:42.021668 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 1438, in execute_install
2026-08-13 00:38:42.021677 | controller |     self._execute_install_collection(
2026-08-13 00:38:42.021687 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 1487, in _execute_install_collection
2026-08-13 00:38:42.021698 | controller |     install_collections(
2026-08-13 00:38:42.021708 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/__init__.py", line 735, in install_collections
2026-08-13 00:38:42.021719 | controller |     dependency_map = _resolve_depenency_map(
2026-08-13 00:38:42.021728 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/__init__.py", line 1852, in _resolve_depenency_map
2026-08-13 00:38:42.021778 | controller |     return collection_dep_resolver.resolve(
2026-08-13 00:38:42.021791 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 546, in resolve
2026-08-13 00:38:42.021800 | controller |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-08-13 00:38:42.021810 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 427, in resolve
2026-08-13 00:38:42.021819 | controller |     failure_causes = self._attempt_to_pin_criterion(name)
2026-08-13 00:38:42.021847 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 239, in _attempt_to_pin_criterion
2026-08-13 00:38:42.021856 | controller |     criteria = self._get_updated_criteria(candidate)
2026-08-13 00:38:42.021865 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 229, in _get_updated_criteria
2026-08-13 00:38:42.021874 | controller |     for requirement in self._p.get_dependencies(candidate=candidate):
2026-08-13 00:38:42.021884 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 441, in get_dependencies
2026-08-13 00:38:42.021893 | controller |     req_map = self._api_proxy.get_collection_dependencies(candidate)
2026-08-13 00:38:42.021902 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 176, in get_collection_dependencies
2026-08-13 00:38:42.021917 | controller |     get_collection_version_metadata(collection_candidate).
2026-08-13 00:38:42.021926 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 161, in get_collection_version_metadata
2026-08-13 00:38:42.021935 | controller |     raise last_err
2026-08-13 00:38:42.021944 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 128, in get_collection_version_metadata
2026-08-13 00:38:42.021953 | controller |     version_metadata = api.get_collection_version_metadata(
2026-08-13 00:38:42.021962 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 145, in wrapped
2026-08-13 00:38:42.021971 | controller |     return method(self, *args, **kwargs)
2026-08-13 00:38:42.021983 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 816, in get_collection_version_metadata
2026-08-13 00:38:42.022007 | controller |     data = self._call_galaxy(n_collection_url, error_context_msg=error_context_msg, cache=True)
2026-08-13 00:38:42.022017 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/module_utils/api.py", line 169, in run_function
2026-08-13 00:38:42.022026 | controller |     return call_retryable_function()
2026-08-13 00:38:42.022035 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 390, in _call_galaxy
2026-08-13 00:38:42.022044 | controller |     res = path_cache
2026-08-13 00:38:42.022053 | controller | KeyError: 'results'
2026-08-13 00:38:42.022062 | controller |
2026-08-13 00:38:42.022071 | controller | ansible-galaxy
2026-08-13 00:38:42.022079 | controller |   config file = None
2026-08-13 00:38:42.022088 | controller |   configured module search path =
2026-08-13 00:38:42.022097 | controller |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible
2026-08-13 00:38:42.022108 | controller |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/local/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages
2026-08-13 00:38:42.022119 | controller |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/ansible-galaxy
2026-08-13 00:38:42.022134 | controller |   python version = 3.10.12 (main, Jun 22 2026, 18:55:27)  (/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/python)
2026-08-13 00:38:42.022151 | controller |   jinja version = 3.1.6
2026-08-13 00:38:42.022160 | controller |   libyaml = True
2026-08-13 00:38:42.022169 | controller | No config file found; using defaults
2026-08-13 00:38:42.022178 | controller | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-13 00:38:42.022187 | controller | : Collection community.general does not support Ansible version
2026-08-13 00:38:42.022196 | controller | 2.17.14
2026-08-13 00:38:42.022205 | controller | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-13 00:38:42.022214 | controller | Found installed collection kubernetes.core:6.5.0 at '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-13 00:38:42.022223 | controller | Found installed collection community.library_inventory_filtering_v1:1.1.5 at '/home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1'
2026-08-13 00:38:42.022233 | controller | Found installed collection community.crypto:3.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-13 00:38:42.022242 | controller | Opened /home/zuul/.ansible/galaxy_token
2026-08-13 00:38:42.022251 | controller | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-13 00:38:42.022260 | controller | unexpected error when getting available versions of collection
2026-08-13 00:38:42.022269 | controller | vexxhost.containers: 'results'
2026-08-13 00:38:42.022278 | controller | ERROR! Unexpected Exception, this is probably a bug: 'results'
2026-08-13 00:38:42.022287 | controller |
2026-08-13 00:38:42.022295 | controller | Traceback (most recent call last):
2026-08-13 00:38:42.022304 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/molecule", line 10, in <module>
2026-08-13 00:38:42.022317 | controller |     sys.exit(main())
2026-08-13 00:38:42.022326 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/core.py", line 1485, in __call__
2026-08-13 00:38:42.022521 | controller |     return self.main(*args, **kwargs)
2026-08-13 00:38:42.022701 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/core.py", line 1406, in main
2026-08-13 00:38:42.022988 | controller |     rv = self.invoke(ctx)
2026-08-13 00:38:42.023051 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/core.py", line 1873, in invoke
2026-08-13 00:38:42.023431 | controller |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-13 00:38:42.023469 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/core.py", line 1269, in invoke
2026-08-13 00:38:42.023800 | controller |     return ctx.invoke(self.callback, **ctx.params)
2026-08-13 00:38:42.023838 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/core.py", line 824, in invoke
2026-08-13 00:38:42.024122 | controller |     return callback(*args, **kwargs)
2026-08-13 00:38:42.024161 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/molecule/click_cfg.py", line 583, in wrapper
2026-08-13 00:38:42.024379 | controller |     return func(*args, **kwargs)
2026-08-13 00:38:42.024486 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/click/decorators.py", line 34, in new_func
2026-08-13 00:38:42.024627 | controller |     return f(get_current_context(), *args, **kwargs)
2026-08-13 00:38:42.024734 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/molecule/click_cfg.py", line 418, in wrapper
2026-08-13 00:38:42.024914 | controller |     return func(ctx)
2026-08-13 00:38:42.025018 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/molecule/command/test.py", line 81, in test
2026-08-13 00:38:42.025167 | controller |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-13 00:38:42.025278 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios
2026-08-13 00:38:42.025439 | controller |     _run_scenarios(scenarios, command_args, default_config)
2026-08-13 00:38:42.025549 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/molecule/command/base.py", line 240, in _run_scenarios
2026-08-13 00:38:42.025718 | controller |     scenario.config.runtime.prepare_environment(
2026-08-13 00:38:42.025855 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible_compat/runtime.py", line 752, in prepare_environment
2026-08-13 00:38:42.026082 | controller |     self.install_collection(
2026-08-13 00:38:42.026181 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible_compat/runtime.py", line 609, in install_collection
2026-08-13 00:38:42.026379 | controller |     raise InvalidPrerequisiteError(msg)
2026-08-13 00:38:42.028201 | controller | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv vexxhost.containers:>=1.6.0, returned 250 code:
2026-08-13 00:38:42.028213 | controller | Starting galaxy collection install process
2026-08-13 00:38:42.028223 | controller | Process install dependency map
2026-08-13 00:38:42.028233 | controller | the full traceback was:
2026-08-13 00:38:42.028242 | controller |
2026-08-13 00:38:42.028251 | controller | Traceback (most recent call last):
2026-08-13 00:38:42.028260 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/__init__.py", line 658, in cli_executor
2026-08-13 00:38:42.028269 | controller |     exit_code = cli.run()
2026-08-13 00:38:42.028278 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 773, in run
2026-08-13 00:38:42.028288 | controller |     return context.CLIARGS['func']()
2026-08-13 00:38:42.028297 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 120, in method_wrapper
2026-08-13 00:38:42.028306 | controller |     return wrapped_method(*args, **kwargs)
2026-08-13 00:38:42.028314 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 1438, in execute_install
2026-08-13 00:38:42.028323 | controller |     self._execute_install_collection(
2026-08-13 00:38:42.028332 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/cli/galaxy.py", line 1487, in _execute_install_collection
2026-08-13 00:38:42.028341 | controller |     install_collections(
2026-08-13 00:38:42.028351 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/__init__.py", line 735, in install_collections
2026-08-13 00:38:42.028361 | controller |     dependency_map = _resolve_depenency_map(
2026-08-13 00:38:42.028370 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/__init__.py", line 1852, in _resolve_depenency_map
2026-08-13 00:38:42.028380 | controller |     return collection_dep_resolver.resolve(
2026-08-13 00:38:42.028389 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 546, in resolve
2026-08-13 00:38:42.028399 | controller |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-08-13 00:38:42.028409 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 427, in resolve
2026-08-13 00:38:42.028418 | controller |     failure_causes = self._attempt_to_pin_criterion(name)
2026-08-13 00:38:42.028427 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 239, in _attempt_to_pin_criterion
2026-08-13 00:38:42.028445 | controller |     criteria = self._get_updated_criteria(candidate)
2026-08-13 00:38:42.028454 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/resolvelib/resolvers.py", line 229, in _get_updated_criteria
2026-08-13 00:38:42.028463 | controller |     for requirement in self._p.get_dependencies(candidate=candidate):
2026-08-13 00:38:42.028472 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 441, in get_dependencies
2026-08-13 00:38:42.028482 | controller |     req_map = self._api_proxy.get_collection_dependencies(candidate)
2026-08-13 00:38:42.028491 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 176, in get_collection_dependencies
2026-08-13 00:38:42.028500 | controller |     get_collection_version_metadata(collection_candidate).
2026-08-13 00:38:42.028513 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 161, in get_collection_version_metadata
2026-08-13 00:38:42.028522 | controller |     raise last_err
2026-08-13 00:38:42.028531 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 128, in get_collection_version_metadata
2026-08-13 00:38:42.028540 | controller |     version_metadata = api.get_collection_version_metadata(
2026-08-13 00:38:42.028549 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 145, in wrapped
2026-08-13 00:38:42.028558 | controller |     return method(self, *args, **kwargs)
2026-08-13 00:38:42.028567 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 816, in get_collection_version_metadata
2026-08-13 00:38:42.028577 | controller |     data = self._call_galaxy(n_collection_url, error_context_msg=error_context_msg, cache=True)
2026-08-13 00:38:42.028593 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/module_utils/api.py", line 169, in run_function
2026-08-13 00:38:42.028602 | controller |     return call_retryable_function()
2026-08-13 00:38:42.028611 | controller |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible/galaxy/api.py", line 390, in _call_galaxy
2026-08-13 00:38:42.028621 | controller |     res = path_cache['results']
2026-08-13 00:38:42.028630 | controller | KeyError: 'results'
2026-08-13 00:38:42.028639 | controller |
2026-08-13 00:38:42.028648 | controller | ansible-galaxy [core 2.17.14]
2026-08-13 00:38:42.028657 | controller |   config file = None
2026-08-13 00:38:42.028665 | controller |   configured module search path = ['/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/plugins/modules', '/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
2026-08-13 00:38:42.028672 | controller |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages/ansible
2026-08-13 00:38:42.028679 | controller |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/local/lib/python3.10/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.10/site-packages
2026-08-13 00:38:42.028688 | controller |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/ansible-galaxy
2026-08-13 00:38:42.028694 | controller |   python version = 3.10.12 (main, Jun 22 2026, 18:55:27) [GCC 11.4.0] (/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/python)
2026-08-13 00:38:42.028703 | controller |   jinja version = 3.1.6
2026-08-13 00:38:42.028709 | controller |   libyaml = True
2026-08-13 00:38:42.028715 | controller | No config file found; using defaults
2026-08-13 00:38:42.028720 | controller | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-13 00:38:42.028726 | controller | [WARNING]: Collection community.general does not support Ansible version
2026-08-13 00:38:42.028732 | controller | 2.17.14
2026-08-13 00:38:42.028737 | controller | Found installed collection community.general:13.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-13 00:38:42.028743 | controller | Found installed collection kubernetes.core:6.5.0 at '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-13 00:38:42.028749 | controller | Found installed collection community.library_inventory_filtering_v1:1.1.5 at '/home/zuul/.ansible/collections/ansible_collections/community/library_inventory_filtering_v1'
2026-08-13 00:38:42.028754 | controller | Found installed collection community.crypto:3.3.0 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-13 00:38:42.028760 | controller | Opened /home/zuul/.ansible/galaxy_token
2026-08-13 00:38:42.028766 | controller | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an
2026-08-13 00:38:42.028771 | controller | unexpected error when getting available versions of collection
2026-08-13 00:38:42.028777 | controller | vexxhost.containers: 'results'
2026-08-13 00:38:42.028783 | controller | ERROR! Unexpected Exception, this is probably a bug: 'results'
2026-08-13 00:38:42.028788 | controller |
2026-08-13 00:38:42.381902 | controller | ERROR
2026-08-13 00:38:42.382164 | controller | {
2026-08-13 00:38:42.382210 | controller |   "delta": "0:01:23.561913",
2026-08-13 00:38:42.382241 | controller |   "end": "2026-08-13 00:38:42.085919",
2026-08-13 00:38:42.382268 | controller |   "msg": "non-zero return code",
2026-08-13 00:38:42.382294 | controller |   "rc": 1,
2026-08-13 00:38:42.382320 | controller |   "start": "2026-08-13 00:37:18.524006"
2026-08-13 00:38:42.382346 | controller | }
failure
2026-08-13 00:38:42.386135 | 
2026-08-13 00:38:42.386202 | PLAY RECAP
2026-08-13 00:38:42.386258 | controller | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-13 00:38:42.386289 | 
2026-08-13 00:38:42.525607 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-13 00:38:42.528559 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-13 00:38:43.111812 | 
2026-08-13 00:38:43.111939 | PLAY [all]
2026-08-13 00:38:43.123663 | 
2026-08-13 00:38:43.123748 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-13 00:38:43.481082 | controller | changed
2026-08-13 00:38:43.496974 | 
2026-08-13 00:38:43.497076 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-13 00:38:43.858150 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-13 00:38:43.858464 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-13 00:38:43.863678 | controller | environment: line 1: kubectl: command not found
2026-08-13 00:38:43.865196 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-13 00:38:43.866811 | controller | environment: line 1: kubectl: command not found
2026-08-13 00:38:43.867949 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-13 00:38:43.868974 | controller | environment: line 1: kubectl: command not found
2026-08-13 00:38:43.870029 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-13 00:38:43.870673 | controller | environment: line 1: kubectl: command not found
2026-08-13 00:38:43.872063 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-13 00:38:43.872781 | controller | environment: line 1: kubectl: command not found
2026-08-13 00:38:43.874219 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-13 00:38:44.030885 | controller | ok: Runtime: 0:00:00.026819
2026-08-13 00:38:44.038690 | 
2026-08-13 00:38:44.038803 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-13 00:38:44.231919 | controller | changed
2026-08-13 00:38:44.239087 | 
2026-08-13 00:38:44.239190 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-13 00:38:44.442721 | controller | environment: line 5: kubectl: command not found
2026-08-13 00:38:44.443607 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-13 00:38:44.443648 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-13 00:38:44.444126 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-13 00:38:44.774630 | controller | ok: Runtime: 0:00:00.010232
2026-08-13 00:38:44.783197 | 
2026-08-13 00:38:44.783302 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-13 00:38:45.435287 | controller | changed:
2026-08-13 00:38:45.435462 | controller | created directory /var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/logs/controller
2026-08-13 00:38:45.435495 | controller | cd+++++++++ objects/
2026-08-13 00:38:45.435518 | controller | cd+++++++++ objects/cluster/
2026-08-13 00:38:45.435544 | controller | cd+++++++++ objects/namespaced/
2026-08-13 00:38:45.444559 | 
2026-08-13 00:38:45.444626 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-13 00:38:45.673454 | controller | changed
2026-08-13 00:38:45.678694 | 
2026-08-13 00:38:45.678763 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-13 00:38:45.885012 | controller | changed
2026-08-13 00:38:45.891476 | 
2026-08-13 00:38:45.891573 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-13 00:38:46.107686 | controller | environment: line 3: kubectl: command not found
2026-08-13 00:38:46.428226 | controller | ok: Runtime: 0:00:00.010454
2026-08-13 00:38:46.435557 | 
2026-08-13 00:38:46.435657 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-13 00:38:46.998612 | controller | changed:
2026-08-13 00:38:46.998849 | controller | cd+++++++++ pod-logs/
2026-08-13 00:38:46.998890 | controller | cd+++++++++ pod-logs/failed-pods/
2026-08-13 00:38:47.011054 | 
2026-08-13 00:38:47.011123 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-13 00:38:47.275881 | controller | changed: "values"
2026-08-13 00:38:47.431025 | controller | changed: "releases"
2026-08-13 00:38:47.445629 | 
2026-08-13 00:38:47.445769 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-13 00:38:47.652790 | controller | /bin/bash: line 3: kubectl: command not found
2026-08-13 00:38:47.987624 | controller | ok: Runtime: 0:00:00.005404
2026-08-13 00:38:47.994863 | 
2026-08-13 00:38:47.994967 | TASK [helm-release-status : Downloads logs to executor]
2026-08-13 00:38:48.526210 | controller | changed:
2026-08-13 00:38:48.526420 | controller | cd+++++++++ helm/
2026-08-13 00:38:48.526449 | controller | cd+++++++++ helm/releases/
2026-08-13 00:38:48.526473 | controller | cd+++++++++ helm/values/
2026-08-13 00:38:48.533029 | 
2026-08-13 00:38:48.533083 | PLAY RECAP
2026-08-13 00:38:48.533132 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-13 00:38:48.533155 | 
2026-08-13 00:38:48.674519 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-08-13 00:38:48.676766 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-13 00:38:49.355054 | 
2026-08-13 00:38:49.355271 | PLAY [all]
2026-08-13 00:38:49.367577 | 
2026-08-13 00:38:49.367657 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-13 00:38:49.433716 | controller | skipping: Conditional result was False
2026-08-13 00:38:49.443586 | 
2026-08-13 00:38:49.443670 | TASK [fetch-output : Set log path for single node]
2026-08-13 00:38:49.491076 | controller | ok
2026-08-13 00:38:49.495786 | 
2026-08-13 00:38:49.495861 | LOOP [fetch-output : Ensure local output dirs]
2026-08-13 00:38:49.975501 | controller -> localhost | ok: "/var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/logs"
2026-08-13 00:38:50.199270 | controller -> localhost | changed: "/var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/artifacts"
2026-08-13 00:38:50.464419 | controller -> localhost | changed: "/var/lib/zuul/builds/2ea4c33eb5e94737b4a742547c294dd3/work/docs"
2026-08-13 00:38:50.483468 | 
2026-08-13 00:38:50.483623 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-13 00:38:51.185144 | controller | changed: .d..t...... ./
2026-08-13 00:38:51.185388 | controller | changed: All items complete
2026-08-13 00:38:51.185419 | 
2026-08-13 00:38:51.935019 | controller | changed: .d..t...... ./
2026-08-13 00:38:52.716926 | controller | changed: .d..t...... ./
2026-08-13 00:38:52.743039 | 
2026-08-13 00:38:52.743539 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-13 00:38:53.247671 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008769
2026-08-13 00:38:53.858969 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006859
2026-08-13 00:38:53.878825 | 
2026-08-13 00:38:53.879014 | PLAY [all]
2026-08-13 00:38:53.888196 | 
2026-08-13 00:38:53.888290 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-13 00:38:54.385397 | controller | changed
2026-08-13 00:38:54.393541 | 
2026-08-13 00:38:54.393627 | PLAY RECAP
2026-08-13 00:38:54.393683 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-13 00:38:54.393710 | 
2026-08-13 00:38:54.552226 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-13 00:38:54.554542 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-13 00:38:55.209248 | 
2026-08-13 00:38:55.209394 | PLAY [localhost]
2026-08-13 00:38:55.222624 | 
2026-08-13 00:38:55.222736 | TASK [Generate Zuul manifest]
2026-08-13 00:38:55.242094 | localhost | ok
2026-08-13 00:38:55.260061 | 
2026-08-13 00:38:55.260198 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-13 00:38:55.731049 | localhost | changed
2026-08-13 00:38:55.744817 | 
2026-08-13 00:38:55.744946 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-13 00:38:55.908845 | localhost | ok
2026-08-13 00:38:55.939399 | 
2026-08-13 00:38:55.939777 | TASK [Upload logs]
2026-08-13 00:38:55.965556 | localhost | ok
2026-08-13 00:38:56.028848 | 
2026-08-13 00:38:56.029029 | TASK [Set zuul-log-path fact]
2026-08-13 00:38:56.047515 | localhost | ok
2026-08-13 00:38:56.058987 | 
2026-08-13 00:38:56.059132 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-13 00:38:56.097796 | localhost | ok
2026-08-13 00:38:56.105160 | 
2026-08-13 00:38:56.105231 | TASK [upload-logs : Create log directories]
2026-08-13 00:38:56.553941 | localhost | changed
2026-08-13 00:38:56.561367 | 
2026-08-13 00:38:56.561518 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-13 00:38:56.993157 | localhost -> localhost | ok: Runtime: 0:00:00.005900
2026-08-13 00:38:57.001674 | 
2026-08-13 00:38:57.001762 | TASK [upload-logs : Upload logs to log server]
2026-08-13 00:38:57.440616 | localhost | Output suppressed because no_log was given
2026-08-13 00:38:57.447021 | 
2026-08-13 00:38:57.447294 | LOOP [upload-logs : Compress console log and json output]
2026-08-13 00:38:57.498944 | localhost | skipping: Conditional result was False
2026-08-13 00:38:57.542941 | localhost | skipping: Conditional result was False
2026-08-13 00:38:57.553945 | 
2026-08-13 00:38:57.554130 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-13 00:38:57.602454 | localhost | skipping: Conditional result was False
2026-08-13 00:38:57.662601 | 
2026-08-13 00:38:57.665268 | localhost | skipping: Conditional result was False
2026-08-13 00:38:57.681167 | 
2026-08-13 00:38:57.681403 | LOOP [upload-logs : Upload console log and json output]