2026-03-18 09:58:55.784848 | Job console starting 2026-03-18 09:58:55.793545 | Updating git repos 2026-03-18 09:58:55.837151 | Cloning repos into workspace 2026-03-18 09:58:55.903243 | Restoring repo states 2026-03-18 09:58:55.917762 | Merging changes 2026-03-18 09:58:56.462440 | Checking out repos 2026-03-18 09:58:56.686440 | Preparing playbooks 2026-03-18 09:59:04.681955 | Running Ansible setup 2026-03-18 09:59:09.138823 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 09:59:09.693953 | 2026-03-18 09:59:09.737842 | PLAY [localhost] 2026-03-18 09:59:09.750124 | 2026-03-18 09:59:09.750192 | TASK [Gathering Facts] 2026-03-18 09:59:10.781161 | localhost | ok 2026-03-18 09:59:10.791917 | 2026-03-18 09:59:10.792030 | TASK [Setup log path fact] 2026-03-18 09:59:10.814126 | localhost | ok 2026-03-18 09:59:10.827934 | 2026-03-18 09:59:10.828027 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 09:59:10.866852 | localhost | ok 2026-03-18 09:59:10.875068 | 2026-03-18 09:59:10.888025 | TASK [emit-job-header : Print job information] 2026-03-18 09:59:10.929803 | # Job Information 2026-03-18 09:59:11.062823 | Ansible Version: 2.16.16 2026-03-18 09:59:11.063017 | Job: ansible-collection-kubernetes-molecule-bgp 2026-03-18 09:59:11.063090 | Pipeline: check 2026-03-18 09:59:11.063138 | Executor: 0a8996d2b663 2026-03-18 09:59:11.063183 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-18 09:59:11.063233 | Event ID: f222a020-22b0-11f1-88ac-026452cbc036 2026-03-18 09:59:11.069856 | 2026-03-18 09:59:11.070010 | LOOP [emit-job-header : Print node information] 2026-03-18 09:59:11.178143 | localhost | ok: 2026-03-18 09:59:11.179849 | localhost | # Node Information 2026-03-18 09:59:11.179930 | localhost | Inventory Hostname: controller 2026-03-18 09:59:11.179981 | localhost | Hostname: np0000159785 2026-03-18 09:59:11.180025 | localhost | Username: zuul 2026-03-18 09:59:11.180077 | localhost | Distro: Debian 13.3 2026-03-18 09:59:11.180121 | localhost | Provider: yul1 2026-03-18 09:59:11.180163 | localhost | Region: ca-ymq-1 2026-03-18 09:59:11.180204 | localhost | Label: debian-trixie 2026-03-18 09:59:11.180294 | localhost | Product Name: OpenStack Nova 2026-03-18 09:59:11.180338 | localhost | Interface IP: 199.204.45.248 2026-03-18 09:59:11.199114 | 2026-03-18 09:59:11.199268 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-18 09:59:11.588717 | localhost -> localhost | changed 2026-03-18 09:59:11.596483 | 2026-03-18 09:59:11.596586 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-18 09:59:12.512884 | localhost -> localhost | changed 2026-03-18 09:59:12.519792 | 2026-03-18 09:59:12.519859 | PLAY [all] 2026-03-18 09:59:12.526646 | 2026-03-18 09:59:12.526715 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-18 09:59:12.754706 | controller -> localhost | ok 2026-03-18 09:59:12.762415 | 2026-03-18 09:59:12.762535 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-18 09:59:12.796093 | controller | ok 2026-03-18 09:59:12.814845 | controller | included: /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-18 09:59:12.821404 | 2026-03-18 09:59:12.821521 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-18 09:59:14.316442 | controller -> localhost | Generating public/private rsa key pair. 2026-03-18 09:59:14.316760 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/53aa25a02916464bbee7dad71a4b9b04_id_rsa 2026-03-18 09:59:14.316808 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/53aa25a02916464bbee7dad71a4b9b04_id_rsa.pub 2026-03-18 09:59:14.316843 | controller -> localhost | The key fingerprint is: 2026-03-18 09:59:14.316875 | controller -> localhost | SHA256:QK1WOaPwr/rH7EoVOXCyah8RIE8fi99XvZxuAlUk3XE zuul-build-sshkey 2026-03-18 09:59:14.316925 | controller -> localhost | The key's randomart image is: 2026-03-18 09:59:14.316972 | controller -> localhost | +---[RSA 3072]----+ 2026-03-18 09:59:14.317020 | controller -> localhost | | . o.*... .oooE| 2026-03-18 09:59:14.317055 | controller -> localhost | | +.+ O*. +. o| 2026-03-18 09:59:14.317085 | controller -> localhost | | oo*++o o . | 2026-03-18 09:59:14.317113 | controller -> localhost | | o=+ o o . o | 2026-03-18 09:59:14.317146 | controller -> localhost | | o.o.S o + | 2026-03-18 09:59:14.317174 | controller -> localhost | | . . o.. . . | 2026-03-18 09:59:14.317200 | controller -> localhost | | o+ . o | 2026-03-18 09:59:14.317232 | controller -> localhost | | .. + o | 2026-03-18 09:59:14.317268 | controller -> localhost | | .oo+. | 2026-03-18 09:59:14.317298 | controller -> localhost | +----[SHA256]-----+ 2026-03-18 09:59:14.317367 | controller -> localhost | ok: Runtime: 0:00:00.977983 2026-03-18 09:59:14.329055 | 2026-03-18 09:59:14.341992 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-18 09:59:14.375939 | controller | ok 2026-03-18 09:59:14.386475 | controller | included: /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-18 09:59:14.395658 | 2026-03-18 09:59:14.395789 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-18 09:59:14.422819 | controller | skipping: Conditional result was False 2026-03-18 09:59:14.431477 | 2026-03-18 09:59:14.431643 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-18 09:59:14.959491 | controller | changed 2026-03-18 09:59:14.964241 | 2026-03-18 09:59:14.964332 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-18 09:59:15.180832 | controller | ok 2026-03-18 09:59:15.185109 | 2026-03-18 09:59:15.185177 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-18 09:59:15.744273 | controller | changed 2026-03-18 09:59:15.749932 | 2026-03-18 09:59:15.750000 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-18 09:59:16.313883 | controller | changed 2026-03-18 09:59:16.320076 | 2026-03-18 09:59:16.320154 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-18 09:59:16.344766 | controller | skipping: Conditional result was False 2026-03-18 09:59:16.353208 | 2026-03-18 09:59:16.353307 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-18 09:59:16.724826 | controller -> localhost | changed 2026-03-18 09:59:16.738431 | 2026-03-18 09:59:16.738511 | TASK [add-build-sshkey : Add back temp key] 2026-03-18 09:59:17.046452 | controller -> localhost | Identity added: /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/53aa25a02916464bbee7dad71a4b9b04_id_rsa (zuul-build-sshkey) 2026-03-18 09:59:17.046789 | controller -> localhost | ok: Runtime: 0:00:00.012472 2026-03-18 09:59:17.051415 | 2026-03-18 09:59:17.051479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-18 09:59:17.398088 | controller | ok 2026-03-18 09:59:17.402647 | 2026-03-18 09:59:17.402717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-18 09:59:17.427438 | controller | skipping: Conditional result was False 2026-03-18 09:59:17.441447 | 2026-03-18 09:59:17.441517 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-18 09:59:17.797287 | controller | ok 2026-03-18 09:59:17.812646 | 2026-03-18 09:59:17.812801 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-18 09:59:18.892930 | controller | Output suppressed because no_log was given 2026-03-18 09:59:18.902202 | 2026-03-18 09:59:18.902264 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-18 09:59:19.121405 | controller | ok: "logs" 2026-03-18 09:59:19.121824 | controller | ok: All items complete 2026-03-18 09:59:19.121898 | 2026-03-18 09:59:19.315191 | controller | ok: "artifacts" 2026-03-18 09:59:19.498890 | controller | ok: "docs" 2026-03-18 09:59:19.507748 | 2026-03-18 09:59:19.507894 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-18 09:59:19.729300 | controller | changed: "logs" 2026-03-18 09:59:19.916795 | controller | changed: "artifacts" 2026-03-18 09:59:20.098069 | controller | changed: "docs" 2026-03-18 09:59:20.113209 | 2026-03-18 09:59:20.113296 | PLAY RECAP 2026-03-18 09:59:20.113341 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-18 09:59:20.113371 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 09:59:20.113392 | 2026-03-18 09:59:20.329644 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 09:59:20.331493 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 09:59:20.936164 | 2026-03-18 09:59:20.936277 | PLAY [all] 2026-03-18 09:59:20.948404 | 2026-03-18 09:59:20.948510 | TASK [setup-uv : Extract archive] 2026-03-18 09:59:23.392106 | controller | changed 2026-03-18 09:59:23.399699 | 2026-03-18 09:59:23.399840 | TASK [setup-uv : Print version] 2026-03-18 09:59:23.887949 | controller | uv 0.8.13 2026-03-18 09:59:23.932098 | controller | ok: Runtime: 0:00:00.014396 2026-03-18 09:59:23.938952 | 2026-03-18 09:59:23.939000 | PLAY RECAP 2026-03-18 09:59:23.939044 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 09:59:23.939068 | 2026-03-18 09:59:24.034203 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 09:59:24.036352 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 09:59:24.656120 | 2026-03-18 09:59:24.656241 | PLAY [all] 2026-03-18 09:59:24.666147 | 2026-03-18 09:59:24.666249 | TASK [Update apt cache] 2026-03-18 09:59:29.685837 | controller | ok 2026-03-18 09:59:29.692229 | 2026-03-18 09:59:29.692302 | TASK [Install "jq" for log collection] 2026-03-18 09:59:32.190601 | controller | changed 2026-03-18 09:59:32.205761 | 2026-03-18 09:59:32.205859 | PLAY RECAP 2026-03-18 09:59:32.205975 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 09:59:32.206014 | 2026-03-18 09:59:32.397696 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 09:59:32.449232 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 09:59:33.068553 | 2026-03-18 09:59:33.068656 | PLAY [all] 2026-03-18 09:59:33.078139 | 2026-03-18 09:59:33.078208 | TASK [Copy inventory file for Zuul] 2026-03-18 09:59:34.013595 | controller | changed 2026-03-18 09:59:34.091319 | 2026-03-18 09:59:34.091517 | TASK [Switch "ansible_host" to private IP] 2026-03-18 09:59:34.378025 | controller | changed: 1 replacements made 2026-03-18 09:59:34.383193 | 2026-03-18 09:59:34.383258 | TASK [Run Molecule scenario] 2026-03-18 09:59:34.788163 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-18 09:59:34.788263 | controller | Creating virtual environment at: .venv 2026-03-18 09:59:35.032653 | controller | Downloading pygments (1.2MiB) 2026-03-18 09:59:35.044037 | controller | Downloading ansible-core (2.3MiB) 2026-03-18 09:59:35.044917 | controller | Downloading cryptography (4.3MiB) 2026-03-18 09:59:35.230687 | controller | Downloading pygments 2026-03-18 09:59:35.400243 | controller | Downloading ansible-core 2026-03-18 09:59:35.521259 | controller | Downloading cryptography 2026-03-18 09:59:35.567174 | controller | Installed 36 packages in 45ms 2026-03-18 09:59:36.296411 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-18 09:59:36.296517 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-18 09:59:37.205734 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-18 09:59:37.205813 | controller | INFO default scenario not found, disabling shared state. 2026-03-18 09:59:37.205886 | controller | INFO [bgp > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-18 09:59:37.205965 | controller | INFO [bgp > prerun] Performing prerun with role_name_check=0... 2026-03-18 10:00:42.975231 | controller | WARNING Retrying execution failure 250 of: ansible-galaxy collection install -vvv community.general:>=4.5.0 2026-03-18 10:00:42.975296 | controller | ERROR Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 250 code: 2026-03-18 10:00:42.975341 | controller | Starting galaxy collection install process 2026-03-18 10:00:42.975349 | controller | Process install dependency map 2026-03-18 10:00:42.975358 | controller | 2026-03-18 10:00:42.975366 | controller | ansible-galaxy 2026-03-18 10:00:42.975374 | controller | config file = None 2026-03-18 10:00:42.975381 | controller | configured module search path = 2026-03-18 10:00:42.975389 | controller | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible 2026-03-18 10:00:42.975401 | controller | ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/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.13/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages 2026-03-18 10:00:42.975411 | controller | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/ansible-galaxy 2026-03-18 10:00:42.975421 | controller | python version = 3.13.5 (main, Jun 25 2025, 18:55:22) (/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/python) 2026-03-18 10:00:42.975429 | controller | jinja version = 3.1.6 2026-03-18 10:00:42.975436 | controller | pyyaml version = 6.0.3 (with libyaml v0.2.5) 2026-03-18 10:00:42.975444 | controller | No config file found; using defaults 2026-03-18 10:00:42.975451 | controller | Found installed collection community.crypto:3.1.1 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-03-18 10:00:42.975458 | controller | Found installed collection ansible.posix:2.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-03-18 10:00:42.975466 | controller | Opened /home/zuul/.ansible/galaxy_token 2026-03-18 10:00:42.975474 | controller | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection community.general: 'results' 2026-03-18 10:00:42.975482 | controller | : Unexpected Exception, this is probably a bug: 'results' 2026-03-18 10:00:42.975490 | controller | 2026-03-18 10:00:42.975497 | controller | Traceback (most recent call last): 2026-03-18 10:00:42.975504 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 661, in cli_executor 2026-03-18 10:00:42.975511 | controller | exit_code = cli.run() 2026-03-18 10:00:42.975518 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 723, in run 2026-03-18 10:00:42.975540 | controller | return context.CLIARGS() 2026-03-18 10:00:42.975549 | controller | ~~~~~~~~~~~~~~~~~~~~~~~^^ 2026-03-18 10:00:42.975565 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 98, in method_wrapper 2026-03-18 10:00:42.975575 | controller | return wrapped_method(*args, **kwargs) 2026-03-18 10:00:42.975585 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1388, in execute_install 2026-03-18 10:00:42.975595 | controller | self._execute_install_collection( 2026-03-18 10:00:42.975605 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.975613 | controller | collection_requirements, collection_path, 2026-03-18 10:00:42.975620 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975627 | controller | artifacts_manager=artifacts_manager, 2026-03-18 10:00:42.975634 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975641 | controller | ) 2026-03-18 10:00:42.975648 | controller | ^ 2026-03-18 10:00:42.975656 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1437, in _execute_install_collection 2026-03-18 10:00:42.975663 | controller | install_collections( 2026-03-18 10:00:42.975670 | controller | ~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.975678 | controller | requirements, output_path, self.api_servers, ignore_errors, 2026-03-18 10:00:42.975688 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975696 | controller | ...<5 lines>... 2026-03-18 10:00:42.975704 | controller | read_requirement_paths=read_req_paths, 2026-03-18 10:00:42.975711 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975717 | controller | ) 2026-03-18 10:00:42.975725 | controller | ^ 2026-03-18 10:00:42.975732 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 722, in install_collections 2026-03-18 10:00:42.975748 | controller | dependency_map = _resolve_depenency_map( 2026-03-18 10:00:42.975755 | controller | collections, 2026-03-18 10:00:42.975762 | controller | ...<7 lines>... 2026-03-18 10:00:42.975769 | controller | offline=offline, 2026-03-18 10:00:42.975776 | controller | ) 2026-03-18 10:00:42.975783 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1844, in _resolve_depenency_map 2026-03-18 10:00:42.975790 | controller | collection_dep_resolver.resolve( 2026-03-18 10:00:42.975797 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.975804 | controller | requested_requirements, 2026-03-18 10:00:42.975811 | controller | ^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975819 | controller | max_rounds=2000000, # NOTE: same constant pip uses 2026-03-18 10:00:42.975828 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975835 | controller | ).mapping, 2026-03-18 10:00:42.975842 | controller | ^ 2026-03-18 10:00:42.975858 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 601, in resolve 2026-03-18 10:00:42.975866 | controller | state = resolution.resolve(requirements, max_rounds=max_rounds) 2026-03-18 10:00:42.975873 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 434, in resolve 2026-03-18 10:00:42.975880 | controller | self._add_to_criteria(self.state.criteria, r, parent=None) 2026-03-18 10:00:42.975888 | controller | ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975895 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 125, in _add_to_criteria 2026-03-18 10:00:42.975902 | controller | matches = self._p.find_matches( 2026-03-18 10:00:42.975909 | controller | identifier=identifier, 2026-03-18 10:00:42.975922 | controller | ...<9 lines>... 2026-03-18 10:00:42.975929 | controller | ), 2026-03-18 10:00:42.975936 | controller | ) 2026-03-18 10:00:42.975943 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 192, in find_matches 2026-03-18 10:00:42.975950 | controller | match for match in self._find_matches(list(requirements)) 2026-03-18 10:00:42.975959 | controller | ~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.975967 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 219, in _find_matches 2026-03-18 10:00:42.975975 | controller | else self._api_proxy.get_collection_versions(first_req) 2026-03-18 10:00:42.975981 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^ 2026-03-18 10:00:42.975989 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 103, in get_collection_versions 2026-03-18 10:00:42.975996 | controller | return set( 2026-03-18 10:00:42.976003 | controller | (version, api) 2026-03-18 10:00:42.976010 | controller | ...<2 lines>... 2026-03-18 10:00:42.976017 | controller | ) 2026-03-18 10:00:42.976024 | controller | ) 2026-03-18 10:00:42.976031 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 105, in 2026-03-18 10:00:42.976044 | controller | for api, version in self._get_collection_versions( 2026-03-18 10:00:42.976051 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.976058 | controller | requirement, 2026-03-18 10:00:42.976065 | controller | ^^^^^^^^^^^^ 2026-03-18 10:00:42.976072 | controller | ) 2026-03-18 10:00:42.976079 | controller | ^ 2026-03-18 10:00:42.976086 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 85, in _get_collection_versions 2026-03-18 10:00:42.976093 | controller | raise last_error 2026-03-18 10:00:42.976100 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 64, in _get_collection_versions 2026-03-18 10:00:42.976107 | controller | versions = api.get_collection_versions(requirement.namespace, requirement.name) 2026-03-18 10:00:42.976114 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 128, in wrapped 2026-03-18 10:00:42.976121 | controller | return method(self, *args, **kwargs) 2026-03-18 10:00:42.976128 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 830, in get_collection_versions 2026-03-18 10:00:42.976135 | controller | data = self._call_galaxy(versions_url, error_context_msg=error_context_msg, cache=True, cache_key=cache_key) 2026-03-18 10:00:42.976142 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 168, in run_function 2026-03-18 10:00:42.976149 | controller | return call_retryable_function() 2026-03-18 10:00:42.976156 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 366, in _call_galaxy 2026-03-18 10:00:42.976163 | controller | res = path_cache 2026-03-18 10:00:42.976170 | controller | ~~~~~~~~~~^^^^^^^^^^^ 2026-03-18 10:00:42.976177 | controller | KeyError: 'results' 2026-03-18 10:00:42.976184 | controller | 2026-03-18 10:00:42.976192 | controller | The above exception was the direct cause of the following exception: 2026-03-18 10:00:42.976199 | controller | 2026-03-18 10:00:42.976206 | controller | Traceback (most recent call last): 2026-03-18 10:00:42.976213 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 670, in cli_executor 2026-03-18 10:00:42.976225 | controller | raise AnsibleError("Unexpected Exception, this is probably a bug.") from ex 2026-03-18 10:00:42.976233 | controller | ansible.errors.AnsibleError: Unexpected Exception, this is probably a bug: 'results' 2026-03-18 10:00:42.976239 | controller | 2026-03-18 10:00:42.976247 | controller | 2026-03-18 10:00:42.978786 | controller | Traceback (most recent call last): 2026-03-18 10:00:42.982450 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/molecule", line 10, in 2026-03-18 10:00:42.982474 | controller | sys.exit(main()) 2026-03-18 10:00:42.982483 | controller | ~~~~^^ 2026-03-18 10:00:42.982802 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/core.py", line 1485, in __call__ 2026-03-18 10:00:42.982824 | controller | return self.main(*args, **kwargs) 2026-03-18 10:00:42.982834 | controller | ~~~~~~~~~^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.983043 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/core.py", line 1406, in main 2026-03-18 10:00:42.983054 | controller | rv = self.invoke(ctx) 2026-03-18 10:00:42.983261 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/core.py", line 1873, in invoke 2026-03-18 10:00:42.983269 | controller | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-03-18 10:00:42.983277 | controller | ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 2026-03-18 10:00:42.983469 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/core.py", line 1269, in invoke 2026-03-18 10:00:42.983478 | controller | return ctx.invoke(self.callback, **ctx.params) 2026-03-18 10:00:42.983485 | controller | ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.983652 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/core.py", line 824, in invoke 2026-03-18 10:00:42.983661 | controller | return callback(*args, **kwargs) 2026-03-18 10:00:42.983852 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 583, in wrapper 2026-03-18 10:00:42.983874 | controller | return func(*args, **kwargs) 2026-03-18 10:00:42.984020 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/click/decorators.py", line 34, in new_func 2026-03-18 10:00:42.984090 | controller | return f(get_current_context(), *args, **kwargs) 2026-03-18 10:00:42.984287 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 418, in wrapper 2026-03-18 10:00:42.984303 | controller | return func(ctx) 2026-03-18 10:00:42.984595 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/molecule/command/test.py", line 81, in test 2026-03-18 10:00:42.984622 | controller | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-03-18 10:00:42.984633 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.984870 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios 2026-03-18 10:00:42.984927 | controller | _run_scenarios(scenarios, command_args, default_config) 2026-03-18 10:00:42.984938 | controller | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.985250 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 240, in _run_scenarios 2026-03-18 10:00:42.985265 | controller | scenario.config.runtime.prepare_environment( 2026-03-18 10:00:42.985288 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.985298 | controller | install_local=True, 2026-03-18 10:00:42.985305 | controller | ^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.985333 | controller | role_name_check=role_name_check, 2026-03-18 10:00:42.985343 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.985351 | controller | ) 2026-03-18 10:00:42.985372 | controller | ^ 2026-03-18 10:00:42.985579 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 752, in prepare_environment 2026-03-18 10:00:42.985599 | controller | self.install_collection( 2026-03-18 10:00:42.985607 | controller | ~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.985614 | controller | f"{name}{',' if is_url(name) else ':'}{required_version}", 2026-03-18 10:00:42.985621 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.985628 | controller | destination=destination, 2026-03-18 10:00:42.985636 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.985643 | controller | ) 2026-03-18 10:00:42.985650 | controller | ^ 2026-03-18 10:00:42.985831 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 609, in install_collection 2026-03-18 10:00:42.985855 | controller | raise InvalidPrerequisiteError(msg) 2026-03-18 10:00:42.989032 | controller | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 250 code: 2026-03-18 10:00:42.989053 | controller | Starting galaxy collection install process 2026-03-18 10:00:42.989061 | controller | Process install dependency map 2026-03-18 10:00:42.989070 | controller | 2026-03-18 10:00:42.989078 | controller | ansible-galaxy [core 2.20.1] 2026-03-18 10:00:42.989085 | controller | config file = None 2026-03-18 10:00:42.989092 | 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-03-18 10:00:42.989107 | controller | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible 2026-03-18 10:00:42.989115 | controller | ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/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.13/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages 2026-03-18 10:00:42.989124 | controller | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/ansible-galaxy 2026-03-18 10:00:42.989132 | controller | python version = 3.13.5 (main, Jun 25 2025, 18:55:22) [GCC 14.2.0] (/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/bin/python) 2026-03-18 10:00:42.989139 | controller | jinja version = 3.1.6 2026-03-18 10:00:42.989146 | controller | pyyaml version = 6.0.3 (with libyaml v0.2.5) 2026-03-18 10:00:42.989153 | controller | No config file found; using defaults 2026-03-18 10:00:42.989160 | controller | Found installed collection community.crypto:3.1.1 at '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-03-18 10:00:42.989168 | controller | Found installed collection ansible.posix:2.1.0 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-03-18 10:00:42.989174 | controller | Opened /home/zuul/.ansible/galaxy_token 2026-03-18 10:00:42.989181 | controller | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection community.general: 'results' 2026-03-18 10:00:42.989188 | controller | [ERROR]: Unexpected Exception, this is probably a bug: 'results' 2026-03-18 10:00:42.989195 | controller | 2026-03-18 10:00:42.989202 | controller | Traceback (most recent call last): 2026-03-18 10:00:42.989211 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 661, in cli_executor 2026-03-18 10:00:42.989220 | controller | exit_code = cli.run() 2026-03-18 10:00:42.989237 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 723, in run 2026-03-18 10:00:42.989251 | controller | return context.CLIARGS['func']() 2026-03-18 10:00:42.989258 | controller | ~~~~~~~~~~~~~~~~~~~~~~~^^ 2026-03-18 10:00:42.989265 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 98, in method_wrapper 2026-03-18 10:00:42.989272 | controller | return wrapped_method(*args, **kwargs) 2026-03-18 10:00:42.989278 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1388, in execute_install 2026-03-18 10:00:42.989286 | controller | self._execute_install_collection( 2026-03-18 10:00:42.989295 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.989302 | controller | collection_requirements, collection_path, 2026-03-18 10:00:42.989309 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989315 | controller | artifacts_manager=artifacts_manager, 2026-03-18 10:00:42.989322 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989329 | controller | ) 2026-03-18 10:00:42.989336 | controller | ^ 2026-03-18 10:00:42.989343 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1437, in _execute_install_collection 2026-03-18 10:00:42.989350 | controller | install_collections( 2026-03-18 10:00:42.989357 | controller | ~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.989364 | controller | requirements, output_path, self.api_servers, ignore_errors, 2026-03-18 10:00:42.989371 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989378 | controller | ...<5 lines>... 2026-03-18 10:00:42.989384 | controller | read_requirement_paths=read_req_paths, 2026-03-18 10:00:42.989391 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989398 | controller | ) 2026-03-18 10:00:42.989405 | controller | ^ 2026-03-18 10:00:42.989412 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 722, in install_collections 2026-03-18 10:00:42.989419 | controller | dependency_map = _resolve_depenency_map( 2026-03-18 10:00:42.989426 | controller | collections, 2026-03-18 10:00:42.989433 | controller | ...<7 lines>... 2026-03-18 10:00:42.989439 | controller | offline=offline, 2026-03-18 10:00:42.989446 | controller | ) 2026-03-18 10:00:42.989453 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1844, in _resolve_depenency_map 2026-03-18 10:00:42.989460 | controller | collection_dep_resolver.resolve( 2026-03-18 10:00:42.989477 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.989485 | controller | requested_requirements, 2026-03-18 10:00:42.989495 | controller | ^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989504 | controller | max_rounds=2000000, # NOTE: same constant pip uses 2026-03-18 10:00:42.989521 | controller | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989541 | controller | ).mapping, 2026-03-18 10:00:42.989551 | controller | ^ 2026-03-18 10:00:42.989560 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 601, in resolve 2026-03-18 10:00:42.989568 | controller | state = resolution.resolve(requirements, max_rounds=max_rounds) 2026-03-18 10:00:42.989574 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 434, in resolve 2026-03-18 10:00:42.989581 | controller | self._add_to_criteria(self.state.criteria, r, parent=None) 2026-03-18 10:00:42.989588 | controller | ~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989598 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 125, in _add_to_criteria 2026-03-18 10:00:42.989613 | controller | matches = self._p.find_matches( 2026-03-18 10:00:42.989620 | controller | identifier=identifier, 2026-03-18 10:00:42.989627 | controller | ...<9 lines>... 2026-03-18 10:00:42.989634 | controller | ), 2026-03-18 10:00:42.989641 | controller | ) 2026-03-18 10:00:42.989648 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 192, in find_matches 2026-03-18 10:00:42.989655 | controller | match for match in self._find_matches(list(requirements[identifier])) 2026-03-18 10:00:42.989662 | controller | ~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-03-18 10:00:42.989669 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 219, in _find_matches 2026-03-18 10:00:42.989676 | controller | else self._api_proxy.get_collection_versions(first_req) 2026-03-18 10:00:42.989682 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^ 2026-03-18 10:00:42.989689 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 103, in get_collection_versions 2026-03-18 10:00:42.989696 | controller | return set( 2026-03-18 10:00:42.989704 | controller | (version, api) 2026-03-18 10:00:42.989710 | controller | ...<2 lines>... 2026-03-18 10:00:42.989717 | controller | ) 2026-03-18 10:00:42.989724 | controller | ) 2026-03-18 10:00:42.989731 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 105, in 2026-03-18 10:00:42.989738 | controller | for api, version in self._get_collection_versions( 2026-03-18 10:00:42.989754 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-03-18 10:00:42.989763 | controller | requirement, 2026-03-18 10:00:42.989771 | controller | ^^^^^^^^^^^^ 2026-03-18 10:00:42.989778 | controller | ) 2026-03-18 10:00:42.989785 | controller | ^ 2026-03-18 10:00:42.989791 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 85, in _get_collection_versions 2026-03-18 10:00:42.989798 | controller | raise last_error 2026-03-18 10:00:42.989805 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 64, in _get_collection_versions 2026-03-18 10:00:42.989812 | controller | versions = api.get_collection_versions(requirement.namespace, requirement.name) 2026-03-18 10:00:42.989819 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 128, in wrapped 2026-03-18 10:00:42.989826 | controller | return method(self, *args, **kwargs) 2026-03-18 10:00:42.989835 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 830, in get_collection_versions 2026-03-18 10:00:42.989880 | controller | data = self._call_galaxy(versions_url, error_context_msg=error_context_msg, cache=True, cache_key=cache_key) 2026-03-18 10:00:42.989902 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 168, in run_function 2026-03-18 10:00:42.989912 | controller | return call_retryable_function() 2026-03-18 10:00:42.989921 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 366, in _call_galaxy 2026-03-18 10:00:42.989928 | controller | res = path_cache['results'] 2026-03-18 10:00:42.989936 | controller | ~~~~~~~~~~^^^^^^^^^^^ 2026-03-18 10:00:42.989943 | controller | KeyError: 'results' 2026-03-18 10:00:42.989950 | controller | 2026-03-18 10:00:42.989957 | controller | The above exception was the direct cause of the following exception: 2026-03-18 10:00:42.989965 | controller | 2026-03-18 10:00:42.989971 | controller | Traceback (most recent call last): 2026-03-18 10:00:42.989986 | controller | File "/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 670, in cli_executor 2026-03-18 10:00:42.989993 | controller | raise AnsibleError("Unexpected Exception, this is probably a bug.") from ex 2026-03-18 10:00:42.990011 | controller | ansible.errors.AnsibleError: Unexpected Exception, this is probably a bug: 'results' 2026-03-18 10:00:42.990020 | controller | 2026-03-18 10:00:42.990029 | controller | 2026-03-18 10:00:43.179125 | controller | ERROR 2026-03-18 10:00:43.179788 | controller | { 2026-03-18 10:00:43.179835 | controller | "delta": "0:01:08.377710", 2026-03-18 10:00:43.179868 | controller | "end": "2026-03-18 10:00:43.096556", 2026-03-18 10:00:43.179897 | controller | "msg": "non-zero return code", 2026-03-18 10:00:43.179935 | controller | "rc": 1, 2026-03-18 10:00:43.179967 | controller | "start": "2026-03-18 09:59:34.718846" 2026-03-18 10:00:43.179995 | controller | } failure 2026-03-18 10:00:43.186244 | 2026-03-18 10:00:43.186303 | PLAY RECAP 2026-03-18 10:00:43.186366 | controller | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:00:43.186412 | 2026-03-18 10:00:43.294694 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 10:00:43.298184 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:00:43.894210 | 2026-03-18 10:00:43.894366 | PLAY [all] 2026-03-18 10:00:43.905791 | 2026-03-18 10:00:43.905870 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-18 10:00:44.312030 | controller | changed 2026-03-18 10:00:44.318482 | 2026-03-18 10:00:44.318590 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-18 10:00:44.716641 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:00:44.716775 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:00:44.721399 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:00:44.721482 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:00:44.722521 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:00:44.723958 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:00:44.726544 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:00:44.727683 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:00:44.729223 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:00:44.731141 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:00:44.731349 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:00:44.732637 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:00:44.848882 | controller | ok: Runtime: 0:00:00.032171 2026-03-18 10:00:44.855338 | 2026-03-18 10:00:44.855435 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-18 10:00:45.091430 | controller | changed 2026-03-18 10:00:45.096572 | 2026-03-18 10:00:45.096656 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-18 10:00:45.339464 | controller | environment: line 5: kubectl: command not found 2026-03-18 10:00:45.340113 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:00:45.340764 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:00:45.341989 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:00:45.630135 | controller | ok: Runtime: 0:00:00.011285 2026-03-18 10:00:45.636347 | 2026-03-18 10:00:45.636445 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-18 10:00:46.267723 | controller | changed: 2026-03-18 10:00:46.267984 | controller | created directory /var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/logs/controller 2026-03-18 10:00:46.268030 | controller | cd+++++++++ objects/ 2026-03-18 10:00:46.268062 | controller | cd+++++++++ objects/cluster/ 2026-03-18 10:00:46.268096 | controller | cd+++++++++ objects/namespaced/ 2026-03-18 10:00:46.278878 | 2026-03-18 10:00:46.278995 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-18 10:00:46.545440 | controller | changed 2026-03-18 10:00:46.550633 | 2026-03-18 10:00:46.550702 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-18 10:00:46.827274 | controller | changed 2026-03-18 10:00:46.833706 | 2026-03-18 10:00:46.833888 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-18 10:00:47.072631 | controller | environment: line 3: kubectl: command not found 2026-03-18 10:00:47.365318 | controller | ok: Runtime: 0:00:00.012852 2026-03-18 10:00:47.370064 | 2026-03-18 10:00:47.370133 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-18 10:00:48.076873 | controller | changed: 2026-03-18 10:00:48.077119 | controller | cd+++++++++ pod-logs/ 2026-03-18 10:00:48.077151 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-18 10:00:48.084853 | 2026-03-18 10:00:48.084926 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-18 10:00:48.350388 | controller | changed: "values" 2026-03-18 10:00:48.585061 | controller | changed: "releases" 2026-03-18 10:00:48.597032 | 2026-03-18 10:00:48.597234 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-18 10:00:48.853873 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-18 10:00:49.130908 | controller | ok: Runtime: 0:00:00.009512 2026-03-18 10:00:49.136291 | 2026-03-18 10:00:49.136374 | TASK [helm-release-status : Downloads logs to executor] 2026-03-18 10:00:49.757672 | controller | changed: 2026-03-18 10:00:49.757933 | controller | cd+++++++++ helm/ 2026-03-18 10:00:49.757997 | controller | cd+++++++++ helm/releases/ 2026-03-18 10:00:49.758050 | controller | cd+++++++++ helm/values/ 2026-03-18 10:00:49.763390 | 2026-03-18 10:00:49.763437 | PLAY RECAP 2026-03-18 10:00:49.763480 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:00:49.763502 | 2026-03-18 10:00:49.860604 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:00:49.862530 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:00:50.415707 | 2026-03-18 10:00:50.415828 | PLAY [all] 2026-03-18 10:00:50.430619 | 2026-03-18 10:00:50.430796 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-18 10:00:50.475807 | controller | skipping: Conditional result was False 2026-03-18 10:00:50.483728 | 2026-03-18 10:00:50.483845 | TASK [fetch-output : Set log path for single node] 2026-03-18 10:00:50.525823 | controller | ok 2026-03-18 10:00:50.531612 | 2026-03-18 10:00:50.531705 | LOOP [fetch-output : Ensure local output dirs] 2026-03-18 10:00:50.885497 | controller -> localhost | ok: "/var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/logs" 2026-03-18 10:00:51.084852 | controller -> localhost | changed: "/var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/artifacts" 2026-03-18 10:00:51.312158 | controller -> localhost | changed: "/var/lib/zuul/builds/53aa25a02916464bbee7dad71a4b9b04/work/docs" 2026-03-18 10:00:51.323423 | 2026-03-18 10:00:51.323588 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-18 10:00:52.002520 | controller | changed: .d..t...... ./ 2026-03-18 10:00:52.002817 | controller | changed: All items complete 2026-03-18 10:00:52.002856 | 2026-03-18 10:00:52.471334 | controller | changed: .d..t...... ./ 2026-03-18 10:00:52.970302 | controller | changed: .d..t...... ./ 2026-03-18 10:00:52.989999 | 2026-03-18 10:00:52.990228 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-18 10:00:53.409810 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006551 2026-03-18 10:00:53.640120 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007988 2026-03-18 10:00:53.657853 | 2026-03-18 10:00:53.657982 | PLAY [all] 2026-03-18 10:00:53.664734 | 2026-03-18 10:00:53.664822 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-18 10:00:54.177961 | controller | changed 2026-03-18 10:00:54.182336 | 2026-03-18 10:00:54.182383 | PLAY RECAP 2026-03-18 10:00:54.182441 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 10:00:54.182464 | 2026-03-18 10:00:54.273243 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:00:54.274631 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-18 10:00:54.856583 | 2026-03-18 10:00:54.856701 | PLAY [localhost] 2026-03-18 10:00:54.866694 | 2026-03-18 10:00:54.866788 | TASK [Generate Zuul manifest] 2026-03-18 10:00:54.887603 | localhost | ok 2026-03-18 10:00:54.903589 | 2026-03-18 10:00:54.903671 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-18 10:00:55.207752 | localhost | changed 2026-03-18 10:00:55.220357 | 2026-03-18 10:00:55.220448 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-18 10:00:55.250545 | localhost | ok 2026-03-18 10:00:55.260941 | 2026-03-18 10:00:55.261033 | TASK [Upload logs] 2026-03-18 10:00:55.280080 | localhost | ok 2026-03-18 10:00:55.340707 | 2026-03-18 10:00:55.340834 | TASK [Set zuul-log-path fact] 2026-03-18 10:00:55.361778 | localhost | ok 2026-03-18 10:00:55.377132 | 2026-03-18 10:00:55.377255 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 10:00:55.418688 | localhost | ok 2026-03-18 10:00:55.426883 | 2026-03-18 10:00:55.426969 | TASK [upload-logs : Create log directories] 2026-03-18 10:00:55.812102 | localhost | changed 2026-03-18 10:00:55.818643 | 2026-03-18 10:00:55.818781 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-18 10:00:56.311978 | localhost -> localhost | ok: Runtime: 0:00:00.094505 2026-03-18 10:00:56.320721 | 2026-03-18 10:00:56.320838 | TASK [upload-logs : Upload logs to log server] 2026-03-18 10:00:56.972081 | localhost | Output suppressed because no_log was given 2026-03-18 10:00:56.977266 | 2026-03-18 10:00:56.977380 | LOOP [upload-logs : Compress console log and json output] 2026-03-18 10:00:57.030538 | localhost | skipping: Conditional result was False 2026-03-18 10:00:57.038175 | localhost | skipping: Conditional result was False 2026-03-18 10:00:57.054450 | 2026-03-18 10:00:57.055035 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-18 10:00:57.101408 | localhost | skipping: Conditional result was False 2026-03-18 10:00:57.101865 | 2026-03-18 10:00:57.105504 | localhost | skipping: Conditional result was False 2026-03-18 10:00:57.121863 | 2026-03-18 10:00:57.122008 | LOOP [upload-logs : Upload console log and json output]