2026-09-25 00:58:59.063594 | Job console starting
2026-09-25 00:58:59.078980 | Updating git repos
2026-09-25 00:58:59.114788 | Cloning repos into workspace
2026-09-25 00:58:59.181543 | Restoring repo states
2026-09-25 00:58:59.201750 | Merging changes
2026-09-25 00:58:59.605971 | Checking out repos
2026-09-25 00:58:59.650687 | Preparing playbooks
2026-09-25 00:59:01.180319 | Running Ansible setup
2026-09-25 00:59:04.572079 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-25 00:59:05.121155 | 
2026-09-25 00:59:05.177263 | PLAY [localhost]
2026-09-25 00:59:05.193970 | 
2026-09-25 00:59:05.194118 | TASK [Gathering Facts]
2026-09-25 00:59:05.989784 | localhost | ok
2026-09-25 00:59:06.005932 | 
2026-09-25 00:59:06.006094 | TASK [Setup log path fact]
2026-09-25 00:59:06.026765 | localhost | ok
2026-09-25 00:59:06.046935 | 
2026-09-25 00:59:06.047056 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-25 00:59:06.088655 | localhost | ok
2026-09-25 00:59:06.102111 | 
2026-09-25 00:59:06.102264 | TASK [emit-job-header : Print job information]
2026-09-25 00:59:06.153813 | # Job Information
2026-09-25 00:59:06.154044 | Ansible Version: 2.16.18
2026-09-25 00:59:06.154113 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal
2026-09-25 00:59:06.154163 | Pipeline: check
2026-09-25 00:59:06.154206 | Executor: 2d72f0692154
2026-09-25 00:59:06.154246 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149
2026-09-25 00:59:06.154293 | Event ID: 370be290-b87b-11f1-8216-00cbc496f9a1
2026-09-25 00:59:06.159747 | 
2026-09-25 00:59:06.159895 | LOOP [emit-job-header : Print node information]
2026-09-25 00:59:06.258463 | localhost | ok:
2026-09-25 00:59:06.258645 | localhost | # Node Information
2026-09-25 00:59:06.258685 | localhost | Inventory Hostname: ubuntu-focal
2026-09-25 00:59:06.258714 | localhost | Hostname: np0000193914
2026-09-25 00:59:06.258739 | localhost | Username: zuul
2026-09-25 00:59:06.258772 | localhost | Distro: Ubuntu 20.04
2026-09-25 00:59:06.258798 | localhost | Provider: yul1
2026-09-25 00:59:06.258823 | localhost | Region: ca-ymq-1
2026-09-25 00:59:06.258847 | localhost | Label: ubuntu-focal
2026-09-25 00:59:06.258871 | localhost | Product Name: OpenStack Nova
2026-09-25 00:59:06.258895 | localhost | Interface IP: 199.19.213.192
2026-09-25 00:59:06.271722 | 
2026-09-25 00:59:06.271916 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-25 00:59:06.674031 | localhost -> localhost | changed
2026-09-25 00:59:06.680297 | 
2026-09-25 00:59:06.680459 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-25 00:59:07.487226 | localhost -> localhost | changed
2026-09-25 00:59:07.492292 | 
2026-09-25 00:59:07.492340 | PLAY [all]
2026-09-25 00:59:07.498506 | 
2026-09-25 00:59:07.498577 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-25 00:59:07.723130 | ubuntu-focal -> localhost | ok
2026-09-25 00:59:07.727977 | 
2026-09-25 00:59:07.728038 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-25 00:59:07.754051 | ubuntu-focal | ok
2026-09-25 00:59:07.766098 | ubuntu-focal | included: /var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-25 00:59:07.770774 | 
2026-09-25 00:59:07.770833 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-25 00:59:08.633892 | ubuntu-focal -> localhost | Generating public/private rsa key pair.
2026-09-25 00:59:08.634065 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/8f13064b94d745eab746961f57299ba4_id_rsa
2026-09-25 00:59:08.634106 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/8f13064b94d745eab746961f57299ba4_id_rsa.pub
2026-09-25 00:59:08.634137 | ubuntu-focal -> localhost | The key fingerprint is:
2026-09-25 00:59:08.634165 | ubuntu-focal -> localhost | SHA256:Qi2oJRAWx/Qwr3KjqmmeGU+FJPpGfBxqZ85VEPhxX5s zuul-build-sshkey
2026-09-25 00:59:08.634207 | ubuntu-focal -> localhost | The key's randomart image is:
2026-09-25 00:59:08.634236 | ubuntu-focal -> localhost | +---[RSA 3072]----+
2026-09-25 00:59:08.634270 | ubuntu-focal -> localhost | |o++= .o.         |
2026-09-25 00:59:08.634299 | ubuntu-focal -> localhost | |....*..o.   .    |
2026-09-25 00:59:08.634327 | ubuntu-focal -> localhost | | ...++ooo. . o   |
2026-09-25 00:59:08.634354 | ubuntu-focal -> localhost | |..o*oo.o  . E    |
2026-09-25 00:59:08.634380 | ubuntu-focal -> localhost | |..*==.o S        |
2026-09-25 00:59:08.634406 | ubuntu-focal -> localhost | | ++*o. .         |
2026-09-25 00:59:08.634432 | ubuntu-focal -> localhost | | oo.o            |
2026-09-25 00:59:08.634457 | ubuntu-focal -> localhost | |.+*              |
2026-09-25 00:59:08.634487 | ubuntu-focal -> localhost | |B+ .             |
2026-09-25 00:59:08.634525 | ubuntu-focal -> localhost | +----[SHA256]-----+
2026-09-25 00:59:08.634584 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.447535
2026-09-25 00:59:08.640653 | 
2026-09-25 00:59:08.640736 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-25 00:59:08.660091 | ubuntu-focal | ok
2026-09-25 00:59:08.670825 | ubuntu-focal | included: /var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-25 00:59:08.686592 | 
2026-09-25 00:59:08.686663 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-25 00:59:08.699436 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:08.704435 | 
2026-09-25 00:59:08.704510 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-25 00:59:09.161115 | ubuntu-focal | changed
2026-09-25 00:59:09.165849 | 
2026-09-25 00:59:09.165912 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-25 00:59:09.334465 | ubuntu-focal | ok
2026-09-25 00:59:09.338708 | 
2026-09-25 00:59:09.338773 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-25 00:59:09.803289 | ubuntu-focal | changed
2026-09-25 00:59:09.816630 | 
2026-09-25 00:59:09.816782 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-25 00:59:10.210032 | ubuntu-focal | changed
2026-09-25 00:59:10.219184 | 
2026-09-25 00:59:10.219327 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-25 00:59:10.233963 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:10.244204 | 
2026-09-25 00:59:10.244360 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-25 00:59:10.663916 | ubuntu-focal -> localhost | changed
2026-09-25 00:59:10.673506 | 
2026-09-25 00:59:10.673582 | TASK [add-build-sshkey : Add back temp key]
2026-09-25 00:59:10.938752 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/8f13064b94d745eab746961f57299ba4_id_rsa (zuul-build-sshkey)
2026-09-25 00:59:10.939241 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.016492
2026-09-25 00:59:10.951362 | 
2026-09-25 00:59:10.951497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-25 00:59:11.273183 | ubuntu-focal | ok
2026-09-25 00:59:11.277113 | 
2026-09-25 00:59:11.277177 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-25 00:59:11.300338 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:11.309477 | 
2026-09-25 00:59:11.309589 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-25 00:59:11.622102 | ubuntu-focal | ok
2026-09-25 00:59:11.629360 | 
2026-09-25 00:59:11.629468 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-25 00:59:12.370864 | ubuntu-focal | Output suppressed because no_log was given
2026-09-25 00:59:12.386660 | 
2026-09-25 00:59:12.386782 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-25 00:59:12.638429 | ubuntu-focal | ok: "logs"
2026-09-25 00:59:12.638689 | ubuntu-focal | ok: All items complete
2026-09-25 00:59:12.638722 | 
2026-09-25 00:59:12.749463 | ubuntu-focal | ok: "artifacts"
2026-09-25 00:59:12.913932 | ubuntu-focal | ok: "docs"
2026-09-25 00:59:12.924981 | 
2026-09-25 00:59:12.925192 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-25 00:59:13.152151 | ubuntu-focal | changed: "logs"
2026-09-25 00:59:13.298277 | ubuntu-focal | changed: "artifacts"
2026-09-25 00:59:13.444312 | ubuntu-focal | changed: "docs"
2026-09-25 00:59:13.467280 | 
2026-09-25 00:59:13.467436 | PLAY RECAP
2026-09-25 00:59:13.467502 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-25 00:59:13.467564 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-25 00:59:13.467595 | 
2026-09-25 00:59:13.636881 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-25 00:59:13.639042 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-25 00:59:14.227732 | 
2026-09-25 00:59:14.227867 | PLAY [all]
2026-09-25 00:59:14.238568 | 
2026-09-25 00:59:14.238707 | TASK [setup-uv : Extract archive]
2026-09-25 00:59:19.127721 | ubuntu-focal | changed
2026-09-25 00:59:19.141403 | 
2026-09-25 00:59:19.141631 | TASK [setup-uv : Print version]
2026-09-25 00:59:19.478535 | ubuntu-focal | uv 0.8.13
2026-09-25 00:59:19.692300 | ubuntu-focal | ok: Runtime: 0:00:00.010116
2026-09-25 00:59:19.703830 | 
2026-09-25 00:59:19.703948 | TASK [Install Ansible collection siblings]
2026-09-25 00:59:20.066812 | ubuntu-focal | ok:
2026-09-25 00:59:20.067055 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling
2026-09-25 00:59:20.067113 | ubuntu-focal | Skipping community.general: no checked-out sibling
2026-09-25 00:59:20.069710 | 
2026-09-25 00:59:20.069796 | PLAY RECAP
2026-09-25 00:59:20.069874 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-25 00:59:20.069917 | 
2026-09-25 00:59:20.183086 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-25 00:59:20.185248 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-25 00:59:20.836994 | 
2026-09-25 00:59:20.837190 | PLAY [all]
2026-09-25 00:59:20.850266 | 
2026-09-25 00:59:20.850404 | LOOP [Check inventory directories]
2026-09-25 00:59:21.141457 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers"
2026-09-25 00:59:21.297509 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/forget-package/inventory"
2026-09-25 00:59:21.464842 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/inventory"
2026-09-25 00:59:21.477056 | 
2026-09-25 00:59:21.477242 | LOOP [Copy inventory file for Zuul]
2026-09-25 00:59:22.342063 | ubuntu-focal | changed:
2026-09-25 00:59:22.342340 | ubuntu-focal | {
2026-09-25 00:59:22.342393 | ubuntu-focal |   "ansible_loop_var": "item",
2026-09-25 00:59:22.342438 | ubuntu-focal |   "changed": false,
2026-09-25 00:59:22.342476 | ubuntu-focal |   "failed": false,
2026-09-25 00:59:22.342519 | ubuntu-focal |   "invocation": {
2026-09-25 00:59:22.342575 | ubuntu-focal |     "module_args": {
2026-09-25 00:59:22.342612 | ubuntu-focal |       "checksum_algorithm": "sha1",
2026-09-25 00:59:22.342647 | ubuntu-focal |       "follow": true,
2026-09-25 00:59:22.342682 | ubuntu-focal |       "get_attributes": true,
2026-09-25 00:59:22.342719 | ubuntu-focal |       "get_checksum": true,
2026-09-25 00:59:22.342754 | ubuntu-focal |       "get_mime": true,
2026-09-25 00:59:22.342787 | ubuntu-focal |       "path": "src/github.com/vexxhost/ansible-collection-containers"
2026-09-25 00:59:22.342826 | ubuntu-focal |     }
2026-09-25 00:59:22.342860 | ubuntu-focal |   },
2026-09-25 00:59:22.342893 | ubuntu-focal |   "item": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-25 00:59:22.342942 | ubuntu-focal |   "stat": {
2026-09-25 00:59:22.342977 | ubuntu-focal |     "atime": 1790297952.2425418,
2026-09-25 00:59:22.343011 | ubuntu-focal |     "attr_flags": "e",
2026-09-25 00:59:22.343044 | ubuntu-focal |     "attributes": [
2026-09-25 00:59:22.343077 | ubuntu-focal |       "extents"
2026-09-25 00:59:22.343109 | ubuntu-focal |     ],
2026-09-25 00:59:22.343142 | ubuntu-focal |     "block_size": 4096,
2026-09-25 00:59:22.343173 | ubuntu-focal |     "blocks": 8,
2026-09-25 00:59:22.343205 | ubuntu-focal |     "charset": "binary",
2026-09-25 00:59:22.343240 | ubuntu-focal |     "ctime": 1790297952.2425418,
2026-09-25 00:59:22.343272 | ubuntu-focal |     "dev": 64513,
2026-09-25 00:59:22.343305 | ubuntu-focal |     "device_type": 0,
2026-09-25 00:59:22.343336 | ubuntu-focal |     "executable": true,
2026-09-25 00:59:22.343368 | ubuntu-focal |     "exists": true,
2026-09-25 00:59:22.343399 | ubuntu-focal |     "gid": 1000,
2026-09-25 00:59:22.343430 | ubuntu-focal |     "gr_name": "zuul",
2026-09-25 00:59:22.343462 | ubuntu-focal |     "inode": 1035293,
2026-09-25 00:59:22.343492 | ubuntu-focal |     "isblk": false,
2026-09-25 00:59:22.343525 | ubuntu-focal |     "ischr": false,
2026-09-25 00:59:22.343580 | ubuntu-focal |     "isdir": true,
2026-09-25 00:59:22.343613 | ubuntu-focal |     "isfifo": false,
2026-09-25 00:59:22.343646 | ubuntu-focal |     "isgid": false,
2026-09-25 00:59:22.343678 | ubuntu-focal |     "islnk": false,
2026-09-25 00:59:22.343710 | ubuntu-focal |     "isreg": false,
2026-09-25 00:59:22.343742 | ubuntu-focal |     "issock": false,
2026-09-25 00:59:22.343774 | ubuntu-focal |     "isuid": false,
2026-09-25 00:59:22.343806 | ubuntu-focal |     "mimetype": "inode/directory",
2026-09-25 00:59:22.343837 | ubuntu-focal |     "mode": "0755",
2026-09-25 00:59:22.343869 | ubuntu-focal |     "mtime": 1790297939.2249413,
2026-09-25 00:59:22.343900 | ubuntu-focal |     "nlink": 11,
2026-09-25 00:59:22.343932 | ubuntu-focal |     "path": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-25 00:59:22.343964 | ubuntu-focal |     "pw_name": "zuul",
2026-09-25 00:59:22.343997 | ubuntu-focal |     "readable": true,
2026-09-25 00:59:22.344030 | ubuntu-focal |     "rgrp": true,
2026-09-25 00:59:22.344063 | ubuntu-focal |     "roth": true,
2026-09-25 00:59:22.344096 | ubuntu-focal |     "rusr": true,
2026-09-25 00:59:22.344129 | ubuntu-focal |     "size": 4096,
2026-09-25 00:59:22.344162 | ubuntu-focal |     "uid": 1000,
2026-09-25 00:59:22.344194 | ubuntu-focal |     "version": "870009495",
2026-09-25 00:59:22.344227 | ubuntu-focal |     "wgrp": false,
2026-09-25 00:59:22.344263 | ubuntu-focal |     "woth": false,
2026-09-25 00:59:22.344297 | ubuntu-focal |     "writeable": true,
2026-09-25 00:59:22.344329 | ubuntu-focal |     "wusr": true,
2026-09-25 00:59:22.344362 | ubuntu-focal |     "xgrp": true,
2026-09-25 00:59:22.344394 | ubuntu-focal |     "xoth": true,
2026-09-25 00:59:22.344427 | ubuntu-focal |     "xusr": true
2026-09-25 00:59:22.344459 | ubuntu-focal |   }
2026-09-25 00:59:22.344628 | ubuntu-focal | }
2026-09-25 00:59:22.344721 | ubuntu-focal | ok: All items complete
2026-09-25 00:59:22.344765 | 
2026-09-25 00:59:22.347246 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:22.348428 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:22.362623 | 
2026-09-25 00:59:22.362798 | LOOP [Switch "ansible_host" to private IP]
2026-09-25 00:59:22.741018 | ubuntu-focal | changed: 1 replacements made
2026-09-25 00:59:22.742837 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:22.744938 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 00:59:22.760354 | 
2026-09-25 00:59:22.760599 | TASK [Run Molecule scenario]
2026-09-25 00:59:23.745306 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB)
2026-09-25 00:59:31.476892 | ubuntu-focal |  Downloading cpython-3.13.7-linux-x86_64-gnu (download)
2026-09-25 00:59:31.673023 | ubuntu-focal | Using CPython 3.13.7
2026-09-25 00:59:31.673097 | ubuntu-focal | Creating virtual environment at: .venv
2026-09-25 00:59:33.679945 | ubuntu-focal | Downloading pygments (1.2MiB)
2026-09-25 00:59:33.680179 | ubuntu-focal | Downloading ansible-core (2.3MiB)
2026-09-25 00:59:33.682763 | ubuntu-focal | Downloading cryptography (4.3MiB)
2026-09-25 00:59:33.826198 | ubuntu-focal | Downloading pygments (1.2MiB)
2026-09-25 00:59:33.837087 | ubuntu-focal | Downloading ansible-core (2.3MiB)
2026-09-25 00:59:33.837352 | ubuntu-focal | Downloading cryptography (4.3MiB)
2026-09-25 00:59:34.066736 | ubuntu-focal |  Downloading cryptography
2026-09-25 00:59:34.070994 | ubuntu-focal |  Downloading pygments
2026-09-25 00:59:34.247728 | ubuntu-focal |  Downloading ansible-core
2026-09-25 00:59:34.275731 | ubuntu-focal | Installed 36 packages in 27ms
2026-09-25 00:59:35.321922 | ubuntu-focal | INFO     Collection 'vexxhost.containers' detected.
2026-09-25 00:59:35.321991 | ubuntu-focal | INFO     Scenarios will be used from 'extensions/molecule'
2026-09-25 00:59:36.118330 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-09-25 00:59:36.118388 | ubuntu-focal | INFO     default scenario not found, disabling shared state.
2026-09-25 00:59:36.118495 | ubuntu-focal | INFO     [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-25 00:59:36.118572 | ubuntu-focal | INFO     [forget-package > prerun] Performing prerun with role_name_check=0...
2026-09-25 01:03:28.172887 | ubuntu-focal | WARNING  Retrying execution failure 250 of: ansible-galaxy collection install -vvv community.general:>=4.5.0
2026-09-25 01:03:28.173080 | ubuntu-focal | ERROR    Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 250 code:
2026-09-25 01:03:28.173094 | ubuntu-focal | Starting galaxy collection install process
2026-09-25 01:03:28.173106 | ubuntu-focal | Process install dependency map
2026-09-25 01:03:28.173117 | ubuntu-focal |
2026-09-25 01:03:28.173126 | ubuntu-focal | ansible-galaxy
2026-09-25 01:03:28.173135 | ubuntu-focal |   config file = None
2026-09-25 01:03:28.173145 | ubuntu-focal |   configured module search path =
2026-09-25 01:03:28.173155 | ubuntu-focal |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible
2026-09-25 01:03:28.173176 | ubuntu-focal |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages
2026-09-25 01:03:28.173188 | ubuntu-focal |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-09-25 01:03:28.173198 | ubuntu-focal |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03)  (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-09-25 01:03:28.173207 | ubuntu-focal |   jinja version = 3.1.6
2026-09-25 01:03:28.173216 | ubuntu-focal |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-09-25 01:03:28.173226 | ubuntu-focal | No config file found; using defaults
2026-09-25 01:03:28.173235 | ubuntu-focal | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-25 01:03:28.173245 | ubuntu-focal | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-09-25 01:03:28.173255 | ubuntu-focal | Opened /home/zuul/.ansible/galaxy_token
2026-09-25 01:03:28.173265 | ubuntu-focal | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection community.general: 'results'
2026-09-25 01:03:28.173275 | ubuntu-focal | : Unexpected Exception, this is probably a bug: 'results'
2026-09-25 01:03:28.173284 | ubuntu-focal |
2026-09-25 01:03:28.173293 | ubuntu-focal | Traceback (most recent call last):
2026-09-25 01:03:28.173302 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 660, in cli_executor
2026-09-25 01:03:28.173312 | ubuntu-focal |     exit_code = cli.run()
2026-09-25 01:03:28.173352 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 732, in run
2026-09-25 01:03:28.173361 | ubuntu-focal |     return context.CLIARGS()
2026-09-25 01:03:28.173369 | ubuntu-focal |            ~~~~~~~~~~~~~~~~~~~~~~~^^
2026-09-25 01:03:28.173378 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 100, in method_wrapper
2026-09-25 01:03:28.173386 | ubuntu-focal |     return wrapped_method(*args, **kwargs)
2026-09-25 01:03:28.173395 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1397, in execute_install
2026-09-25 01:03:28.173404 | ubuntu-focal |     self._execute_install_collection(
2026-09-25 01:03:28.173415 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.173425 | ubuntu-focal |         collection_requirements, collection_path,
2026-09-25 01:03:28.173434 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173442 | ubuntu-focal |         artifacts_manager=artifacts_manager,
2026-09-25 01:03:28.173451 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173459 | ubuntu-focal |     )
2026-09-25 01:03:28.173468 | ubuntu-focal |     ^
2026-09-25 01:03:28.173477 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1446, in _execute_install_collection
2026-09-25 01:03:28.173485 | ubuntu-focal |     install_collections(
2026-09-25 01:03:28.173493 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.173501 | ubuntu-focal |         requirements, output_path, self.api_servers, ignore_errors,
2026-09-25 01:03:28.173510 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173518 | ubuntu-focal |     ...<5 lines>...
2026-09-25 01:03:28.173536 | ubuntu-focal |         read_requirement_paths=read_req_paths,
2026-09-25 01:03:28.173545 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173553 | ubuntu-focal |     )
2026-09-25 01:03:28.173561 | ubuntu-focal |     ^
2026-09-25 01:03:28.173570 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 735, in install_collections
2026-09-25 01:03:28.173578 | ubuntu-focal |     dependency_map = _resolve_depenency_map(
2026-09-25 01:03:28.173587 | ubuntu-focal |         collections,
2026-09-25 01:03:28.173599 | ubuntu-focal |     ...<7 lines>...
2026-09-25 01:03:28.173608 | ubuntu-focal |         offline=offline,
2026-09-25 01:03:28.173616 | ubuntu-focal |     )
2026-09-25 01:03:28.173624 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1855, in _resolve_depenency_map
2026-09-25 01:03:28.173632 | ubuntu-focal |     return collection_dep_resolver.resolve(
2026-09-25 01:03:28.173641 | ubuntu-focal |            ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.173649 | ubuntu-focal |         requested_requirements,
2026-09-25 01:03:28.173657 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173665 | ubuntu-focal |         max_rounds=2000000,  # NOTE: same constant pip uses
2026-09-25 01:03:28.173673 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173681 | ubuntu-focal |     ).mapping
2026-09-25 01:03:28.173690 | ubuntu-focal |     ^
2026-09-25 01:03:28.173698 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 596, in resolve
2026-09-25 01:03:28.173716 | ubuntu-focal |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-09-25 01:03:28.173725 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 508, in resolve
2026-09-25 01:03:28.173733 | ubuntu-focal |     failure_criterion = self._attempt_to_pin_criterion(name)
2026-09-25 01:03:28.173741 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 220, in _attempt_to_pin_criterion
2026-09-25 01:03:28.173750 | ubuntu-focal |     criteria = self._get_updated_criteria(candidate)
2026-09-25 01:03:28.173765 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 210, in _get_updated_criteria
2026-09-25 01:03:28.173773 | ubuntu-focal |     for requirement in self._p.get_dependencies(candidate=candidate):
2026-09-25 01:03:28.173781 | ubuntu-focal |                        ~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173790 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 441, in get_dependencies
2026-09-25 01:03:28.173798 | ubuntu-focal |     req_map = self._api_proxy.get_collection_dependencies(candidate)
2026-09-25 01:03:28.173806 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 171, in get_collection_dependencies
2026-09-25 01:03:28.173815 | ubuntu-focal |     get_collection_version_metadata(collection_candidate).
2026-09-25 01:03:28.173823 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.173834 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 157, in get_collection_version_metadata
2026-09-25 01:03:28.173846 | ubuntu-focal |     raise last_err
2026-09-25 01:03:28.173859 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 124, in get_collection_version_metadata
2026-09-25 01:03:28.173871 | ubuntu-focal |     version_metadata = api.get_collection_version_metadata(
2026-09-25 01:03:28.173882 | ubuntu-focal |         collection_candidate.namespace,
2026-09-25 01:03:28.173894 | ubuntu-focal |         collection_candidate.name,
2026-09-25 01:03:28.173904 | ubuntu-focal |         collection_candidate.ver,
2026-09-25 01:03:28.173912 | ubuntu-focal |     )
2026-09-25 01:03:28.173921 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 144, in wrapped
2026-09-25 01:03:28.173951 | ubuntu-focal |     return method(self, *args, **kwargs)
2026-09-25 01:03:28.173960 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 809, in get_collection_version_metadata
2026-09-25 01:03:28.173969 | ubuntu-focal |     data = self._call_galaxy(n_collection_url, error_context_msg=error_context_msg, cache=True)
2026-09-25 01:03:28.173977 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 168, in run_function
2026-09-25 01:03:28.173986 | ubuntu-focal |     return call_retryable_function()
2026-09-25 01:03:28.173999 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 386, in _call_galaxy
2026-09-25 01:03:28.174007 | ubuntu-focal |     res = path_cache
2026-09-25 01:03:28.174016 | ubuntu-focal |           ~~~~~~~~~~^^^^^^^^^^^
2026-09-25 01:03:28.174024 | ubuntu-focal | KeyError: 'results'
2026-09-25 01:03:28.174032 | ubuntu-focal |
2026-09-25 01:03:28.174040 | ubuntu-focal | The above exception was the direct cause of the following exception:
2026-09-25 01:03:28.174048 | ubuntu-focal |
2026-09-25 01:03:28.174056 | ubuntu-focal | Traceback (most recent call last):
2026-09-25 01:03:28.174065 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 669, in cli_executor
2026-09-25 01:03:28.174073 | ubuntu-focal |     raise AnsibleError("Unexpected Exception, this is probably a bug.") from ex
2026-09-25 01:03:28.174081 | ubuntu-focal | ansible.errors.AnsibleError: Unexpected Exception, this is probably a bug: 'results'
2026-09-25 01:03:28.174089 | ubuntu-focal |
2026-09-25 01:03:28.174097 | ubuntu-focal |
2026-09-25 01:03:28.174971 | ubuntu-focal | Traceback (most recent call last):
2026-09-25 01:03:28.176968 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in <module>
2026-09-25 01:03:28.177000 | ubuntu-focal |     sys.exit(main())
2026-09-25 01:03:28.177009 | ubuntu-focal |              ~~~~^^
2026-09-25 01:03:28.177086 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1442, in __call__
2026-09-25 01:03:28.177098 | ubuntu-focal |     return self.main(*args, **kwargs)
2026-09-25 01:03:28.177107 | ubuntu-focal |            ~~~~~~~~~^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.177204 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1363, in main
2026-09-25 01:03:28.177215 | ubuntu-focal |     rv = self.invoke(ctx)
2026-09-25 01:03:28.177346 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1830, in invoke
2026-09-25 01:03:28.177361 | ubuntu-focal |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-09-25 01:03:28.177369 | ubuntu-focal |                            ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
2026-09-25 01:03:28.177475 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1226, in invoke
2026-09-25 01:03:28.177492 | ubuntu-focal |     return ctx.invoke(self.callback, **ctx.params)
2026-09-25 01:03:28.177504 | ubuntu-focal |            ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.177567 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 794, in invoke
2026-09-25 01:03:28.177583 | ubuntu-focal |     return callback(*args, **kwargs)
2026-09-25 01:03:28.177665 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 583, in wrapper
2026-09-25 01:03:28.177675 | ubuntu-focal |     return func(*args, **kwargs)
2026-09-25 01:03:28.177767 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/decorators.py", line 34, in new_func
2026-09-25 01:03:28.177776 | ubuntu-focal |     return f(get_current_context(), *args, **kwargs)
2026-09-25 01:03:28.177865 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 418, in wrapper
2026-09-25 01:03:28.177874 | ubuntu-focal |     return func(ctx)
2026-09-25 01:03:28.178037 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/test.py", line 81, in test
2026-09-25 01:03:28.178049 | ubuntu-focal |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-09-25 01:03:28.178057 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178143 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios
2026-09-25 01:03:28.178152 | ubuntu-focal |     _run_scenarios(scenarios, command_args, default_config)
2026-09-25 01:03:28.178164 | ubuntu-focal |     ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178354 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 240, in _run_scenarios
2026-09-25 01:03:28.178365 | ubuntu-focal |     scenario.config.runtime.prepare_environment(
2026-09-25 01:03:28.178373 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.178381 | ubuntu-focal |         install_local=True,
2026-09-25 01:03:28.178390 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178398 | ubuntu-focal |         role_name_check=role_name_check,
2026-09-25 01:03:28.178406 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178414 | ubuntu-focal |     )
2026-09-25 01:03:28.178422 | ubuntu-focal |     ^
2026-09-25 01:03:28.178540 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 752, in prepare_environment
2026-09-25 01:03:28.178549 | ubuntu-focal |     self.install_collection(
2026-09-25 01:03:28.178557 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.178759 | ubuntu-focal |         f"{name}{',' if is_url(name) else ':'}{required_version}",
2026-09-25 01:03:28.178772 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178780 | ubuntu-focal |         destination=destination,
2026-09-25 01:03:28.178788 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.178796 | ubuntu-focal |     )
2026-09-25 01:03:28.178805 | ubuntu-focal |     ^
2026-09-25 01:03:28.178816 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 609, in install_collection
2026-09-25 01:03:28.178825 | ubuntu-focal |     raise InvalidPrerequisiteError(msg)
2026-09-25 01:03:28.180582 | ubuntu-focal | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 250 code:
2026-09-25 01:03:28.180606 | ubuntu-focal | Starting galaxy collection install process
2026-09-25 01:03:28.180615 | ubuntu-focal | Process install dependency map
2026-09-25 01:03:28.180624 | ubuntu-focal |
2026-09-25 01:03:28.180632 | ubuntu-focal | ansible-galaxy [core 2.19.1]
2026-09-25 01:03:28.180644 | ubuntu-focal |   config file = None
2026-09-25 01:03:28.180654 | ubuntu-focal |   configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
2026-09-25 01:03:28.180664 | ubuntu-focal |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible
2026-09-25 01:03:28.180672 | ubuntu-focal |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages
2026-09-25 01:03:28.180682 | ubuntu-focal |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-09-25 01:03:28.180690 | ubuntu-focal |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03) [Clang 20.1.4 ] (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-09-25 01:03:28.180698 | ubuntu-focal |   jinja version = 3.1.6
2026-09-25 01:03:28.180707 | ubuntu-focal |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-09-25 01:03:28.180717 | ubuntu-focal | No config file found; using defaults
2026-09-25 01:03:28.180726 | ubuntu-focal | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-25 01:03:28.180735 | ubuntu-focal | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-09-25 01:03:28.180744 | ubuntu-focal | Opened /home/zuul/.ansible/galaxy_token
2026-09-25 01:03:28.180753 | ubuntu-focal | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection community.general: 'results'
2026-09-25 01:03:28.180761 | ubuntu-focal | [ERROR]: Unexpected Exception, this is probably a bug: 'results'
2026-09-25 01:03:28.180794 | ubuntu-focal |
2026-09-25 01:03:28.180804 | ubuntu-focal | Traceback (most recent call last):
2026-09-25 01:03:28.180813 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 660, in cli_executor
2026-09-25 01:03:28.180821 | ubuntu-focal |     exit_code = cli.run()
2026-09-25 01:03:28.180832 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 732, in run
2026-09-25 01:03:28.180843 | ubuntu-focal |     return context.CLIARGS['func']()
2026-09-25 01:03:28.180855 | ubuntu-focal |            ~~~~~~~~~~~~~~~~~~~~~~~^^
2026-09-25 01:03:28.180867 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 100, in method_wrapper
2026-09-25 01:03:28.180879 | ubuntu-focal |     return wrapped_method(*args, **kwargs)
2026-09-25 01:03:28.180890 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1397, in execute_install
2026-09-25 01:03:28.180901 | ubuntu-focal |     self._execute_install_collection(
2026-09-25 01:03:28.180912 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.180964 | ubuntu-focal |         collection_requirements, collection_path,
2026-09-25 01:03:28.180974 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.180982 | ubuntu-focal |         artifacts_manager=artifacts_manager,
2026-09-25 01:03:28.180990 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.180998 | ubuntu-focal |     )
2026-09-25 01:03:28.181006 | ubuntu-focal |     ^
2026-09-25 01:03:28.181015 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/galaxy.py", line 1446, in _execute_install_collection
2026-09-25 01:03:28.181023 | ubuntu-focal |     install_collections(
2026-09-25 01:03:28.181032 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.181040 | ubuntu-focal |         requirements, output_path, self.api_servers, ignore_errors,
2026-09-25 01:03:28.181048 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181056 | ubuntu-focal |     ...<5 lines>...
2026-09-25 01:03:28.181065 | ubuntu-focal |         read_requirement_paths=read_req_paths,
2026-09-25 01:03:28.181073 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181081 | ubuntu-focal |     )
2026-09-25 01:03:28.181089 | ubuntu-focal |     ^
2026-09-25 01:03:28.181098 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 735, in install_collections
2026-09-25 01:03:28.181106 | ubuntu-focal |     dependency_map = _resolve_depenency_map(
2026-09-25 01:03:28.181114 | ubuntu-focal |         collections,
2026-09-25 01:03:28.181122 | ubuntu-focal |     ...<7 lines>...
2026-09-25 01:03:28.181130 | ubuntu-focal |         offline=offline,
2026-09-25 01:03:28.181139 | ubuntu-focal |     )
2026-09-25 01:03:28.181147 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/__init__.py", line 1855, in _resolve_depenency_map
2026-09-25 01:03:28.181155 | ubuntu-focal |     return collection_dep_resolver.resolve(
2026-09-25 01:03:28.181163 | ubuntu-focal |            ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-09-25 01:03:28.181171 | ubuntu-focal |         requested_requirements,
2026-09-25 01:03:28.181179 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181187 | ubuntu-focal |         max_rounds=2000000,  # NOTE: same constant pip uses
2026-09-25 01:03:28.181196 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181204 | ubuntu-focal |     ).mapping
2026-09-25 01:03:28.181212 | ubuntu-focal |     ^
2026-09-25 01:03:28.181229 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 596, in resolve
2026-09-25 01:03:28.181238 | ubuntu-focal |     state = resolution.resolve(requirements, max_rounds=max_rounds)
2026-09-25 01:03:28.181246 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 508, in resolve
2026-09-25 01:03:28.181254 | ubuntu-focal |     failure_criterion = self._attempt_to_pin_criterion(name)
2026-09-25 01:03:28.181262 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 220, in _attempt_to_pin_criterion
2026-09-25 01:03:28.181271 | ubuntu-focal |     criteria = self._get_updated_criteria(candidate)
2026-09-25 01:03:28.181284 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/resolvelib/resolvers/resolution.py", line 210, in _get_updated_criteria
2026-09-25 01:03:28.181292 | ubuntu-focal |     for requirement in self._p.get_dependencies(candidate=candidate):
2026-09-25 01:03:28.181300 | ubuntu-focal |                        ~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181308 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/dependency_resolution/providers.py", line 441, in get_dependencies
2026-09-25 01:03:28.181317 | ubuntu-focal |     req_map = self._api_proxy.get_collection_dependencies(candidate)
2026-09-25 01:03:28.181325 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 171, in get_collection_dependencies
2026-09-25 01:03:28.181339 | ubuntu-focal |     get_collection_version_metadata(collection_candidate).
2026-09-25 01:03:28.181347 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^
2026-09-25 01:03:28.181355 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 157, in get_collection_version_metadata
2026-09-25 01:03:28.181364 | ubuntu-focal |     raise last_err
2026-09-25 01:03:28.181372 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/collection/galaxy_api_proxy.py", line 124, in get_collection_version_metadata
2026-09-25 01:03:28.181380 | ubuntu-focal |     version_metadata = api.get_collection_version_metadata(
2026-09-25 01:03:28.181390 | ubuntu-focal |         collection_candidate.namespace,
2026-09-25 01:03:28.181399 | ubuntu-focal |         collection_candidate.name,
2026-09-25 01:03:28.181407 | ubuntu-focal |         collection_candidate.ver,
2026-09-25 01:03:28.181415 | ubuntu-focal |     )
2026-09-25 01:03:28.181423 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 144, in wrapped
2026-09-25 01:03:28.181432 | ubuntu-focal |     return method(self, *args, **kwargs)
2026-09-25 01:03:28.181440 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 809, in get_collection_version_metadata
2026-09-25 01:03:28.181448 | ubuntu-focal |     data = self._call_galaxy(n_collection_url, error_context_msg=error_context_msg, cache=True)
2026-09-25 01:03:28.181456 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/module_utils/api.py", line 168, in run_function
2026-09-25 01:03:28.181465 | ubuntu-focal |     return call_retryable_function()
2026-09-25 01:03:28.181476 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/galaxy/api.py", line 386, in _call_galaxy
2026-09-25 01:03:28.181484 | ubuntu-focal |     res = path_cache['results']
2026-09-25 01:03:28.181492 | ubuntu-focal |           ~~~~~~~~~~^^^^^^^^^^^
2026-09-25 01:03:28.181500 | ubuntu-focal | KeyError: 'results'
2026-09-25 01:03:28.181508 | ubuntu-focal |
2026-09-25 01:03:28.181517 | ubuntu-focal | The above exception was the direct cause of the following exception:
2026-09-25 01:03:28.181525 | ubuntu-focal |
2026-09-25 01:03:28.181533 | ubuntu-focal | Traceback (most recent call last):
2026-09-25 01:03:28.181541 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/cli/__init__.py", line 669, in cli_executor
2026-09-25 01:03:28.181549 | ubuntu-focal |     raise AnsibleError("Unexpected Exception, this is probably a bug.") from ex
2026-09-25 01:03:28.181558 | ubuntu-focal | ansible.errors.AnsibleError: Unexpected Exception, this is probably a bug: 'results'
2026-09-25 01:03:28.181566 | ubuntu-focal |
2026-09-25 01:03:28.181574 | ubuntu-focal |
2026-09-25 01:03:28.639245 | ubuntu-focal | ERROR
2026-09-25 01:03:28.639449 | ubuntu-focal | {
2026-09-25 01:03:28.639505 | ubuntu-focal |   "delta": "0:04:05.181244",
2026-09-25 01:03:28.639543 | ubuntu-focal |   "end": "2026-09-25 01:03:28.319396",
2026-09-25 01:03:28.639578 | ubuntu-focal |   "msg": "non-zero return code",
2026-09-25 01:03:28.639612 | ubuntu-focal |   "rc": 1,
2026-09-25 01:03:28.639646 | ubuntu-focal |   "start": "2026-09-25 00:59:23.138152"
2026-09-25 01:03:28.639680 | ubuntu-focal | }
failure
2026-09-25 01:03:28.646265 | 
2026-09-25 01:03:28.646355 | PLAY RECAP
2026-09-25 01:03:28.646433 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-25 01:03:28.646475 | 
2026-09-25 01:03:28.771772 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-25 01:03:28.773997 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-25 01:03:29.317367 | 
2026-09-25 01:03:29.317484 | PLAY [all]
2026-09-25 01:03:29.327564 | 
2026-09-25 01:03:29.327671 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-25 01:03:29.391778 | ubuntu-focal | skipping: Conditional result was False
2026-09-25 01:03:29.398973 | 
2026-09-25 01:03:29.399177 | TASK [fetch-output : Set log path for single node]
2026-09-25 01:03:29.451994 | ubuntu-focal | ok
2026-09-25 01:03:29.461823 | 
2026-09-25 01:03:29.461987 | LOOP [fetch-output : Ensure local output dirs]
2026-09-25 01:03:29.907416 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/logs"
2026-09-25 01:03:30.161222 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/artifacts"
2026-09-25 01:03:30.376412 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/8f13064b94d745eab746961f57299ba4/work/docs"
2026-09-25 01:03:30.397927 | 
2026-09-25 01:03:30.398092 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-25 01:03:31.073382 | ubuntu-focal | ok
2026-09-25 01:03:31.073778 | ubuntu-focal | changed: All items complete
2026-09-25 01:03:31.073834 | 
2026-09-25 01:03:31.539177 | ubuntu-focal | changed: .d..t...... ./
2026-09-25 01:03:32.004740 | ubuntu-focal | changed: .d..t...... ./
2026-09-25 01:03:32.031745 | 
2026-09-25 01:03:32.032007 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-25 01:03:32.500069 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.009005
2026-09-25 01:03:32.755308 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.006924
2026-09-25 01:03:32.771581 | 
2026-09-25 01:03:32.771749 | PLAY [all]
2026-09-25 01:03:32.777499 | 
2026-09-25 01:03:32.777565 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-25 01:03:33.247479 | ubuntu-focal | changed
2026-09-25 01:03:33.259121 | 
2026-09-25 01:03:33.259242 | PLAY RECAP
2026-09-25 01:03:33.259359 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-25 01:03:33.259423 | 
2026-09-25 01:03:33.392186 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-25 01:03:33.394351 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-25 01:03:33.986569 | 
2026-09-25 01:03:33.987207 | PLAY [localhost]
2026-09-25 01:03:33.998643 | 
2026-09-25 01:03:33.998761 | TASK [Generate Zuul manifest]
2026-09-25 01:03:34.017010 | localhost | ok
2026-09-25 01:03:34.036972 | 
2026-09-25 01:03:34.037145 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-25 01:03:34.419988 | localhost | changed
2026-09-25 01:03:34.432134 | 
2026-09-25 01:03:34.432247 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-25 01:03:34.476353 | localhost | ok
2026-09-25 01:03:34.485026 | 
2026-09-25 01:03:34.485146 | TASK [Upload logs]
2026-09-25 01:03:34.502606 | localhost | ok
2026-09-25 01:03:34.561428 | 
2026-09-25 01:03:34.561554 | TASK [Set zuul-log-path fact]
2026-09-25 01:03:34.577315 | localhost | ok
2026-09-25 01:03:34.586787 | 
2026-09-25 01:03:34.586854 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-25 01:03:34.623837 | localhost | ok
2026-09-25 01:03:34.631994 | 
2026-09-25 01:03:34.632080 | TASK [upload-logs : Create log directories]
2026-09-25 01:03:35.048268 | localhost | changed
2026-09-25 01:03:35.061197 | 
2026-09-25 01:03:35.061378 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-25 01:03:35.487107 | localhost -> localhost | ok: Runtime: 0:00:00.005617
2026-09-25 01:03:35.491982 | 
2026-09-25 01:03:35.492059 | TASK [upload-logs : Upload logs to log server]
2026-09-25 01:03:35.950514 | localhost | Output suppressed because no_log was given
2026-09-25 01:03:35.958841 | 
2026-09-25 01:03:35.959025 | LOOP [upload-logs : Compress console log and json output]
2026-09-25 01:03:36.026889 | localhost | skipping: Conditional result was False
2026-09-25 01:03:36.035283 | localhost | skipping: Conditional result was False
2026-09-25 01:03:36.047872 | 
2026-09-25 01:03:36.048140 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-25 01:03:36.097988 | localhost | skipping: Conditional result was False
2026-09-25 01:03:36.098604 | 
2026-09-25 01:03:36.101310 | localhost | skipping: Conditional result was False
2026-09-25 01:03:36.113995 | 
2026-09-25 01:03:36.114245 | LOOP [upload-logs : Upload console log and json output]