2026-09-25 00:55:10.928698 | Job console starting 2026-09-25 00:55:10.939513 | Updating git repos 2026-09-25 00:55:10.984380 | Cloning repos into workspace 2026-09-25 00:55:11.020345 | Restoring repo states 2026-09-25 00:55:11.031446 | Merging changes 2026-09-25 00:55:11.407692 | Checking out repos 2026-09-25 00:55:11.447938 | Preparing playbooks 2026-09-25 00:55:13.134252 | Running Ansible setup 2026-09-25 00:55:16.386300 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 00:55:16.917250 | 2026-09-25 00:55:16.917352 | PLAY [localhost] 2026-09-25 00:55:16.924180 | 2026-09-25 00:55:16.924242 | TASK [Gathering Facts] 2026-09-25 00:55:17.757654 | localhost | ok 2026-09-25 00:55:17.763330 | 2026-09-25 00:55:17.763397 | TASK [Setup log path fact] 2026-09-25 00:55:17.778929 | localhost | ok 2026-09-25 00:55:17.787388 | 2026-09-25 00:55:17.787446 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 00:55:17.813477 | localhost | ok 2026-09-25 00:55:17.820910 | 2026-09-25 00:55:17.820999 | TASK [emit-job-header : Print job information] 2026-09-25 00:55:17.870490 | # Job Information 2026-09-25 00:55:17.870679 | Ansible Version: 2.16.18 2026-09-25 00:55:17.870739 | Job: ansible-collection-containers-molecule-nerdctl-ubuntu-jammy 2026-09-25 00:55:17.870783 | Pipeline: check 2026-09-25 00:55:17.870821 | Executor: 2d72f0692154 2026-09-25 00:55:17.870858 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149 2026-09-25 00:55:17.870901 | Event ID: 370be290-b87b-11f1-8216-00cbc496f9a1 2026-09-25 00:55:17.875825 | 2026-09-25 00:55:17.875941 | LOOP [emit-job-header : Print node information] 2026-09-25 00:55:17.971886 | localhost | ok: 2026-09-25 00:55:17.972022 | localhost | # Node Information 2026-09-25 00:55:17.972055 | localhost | Inventory Hostname: ubuntu-jammy 2026-09-25 00:55:17.972191 | localhost | Hostname: np0000193896 2026-09-25 00:55:17.972223 | localhost | Username: zuul 2026-09-25 00:55:17.972246 | localhost | Distro: Ubuntu 22.04 2026-09-25 00:55:17.972264 | localhost | Provider: yul1 2026-09-25 00:55:17.972280 | localhost | Region: ca-ymq-1 2026-09-25 00:55:17.972296 | localhost | Label: ubuntu-jammy 2026-09-25 00:55:17.972312 | localhost | Product Name: OpenStack Nova 2026-09-25 00:55:17.972328 | localhost | Interface IP: 199.19.213.140 2026-09-25 00:55:17.992369 | 2026-09-25 00:55:17.992581 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-25 00:55:18.491747 | localhost -> localhost | changed 2026-09-25 00:55:18.497794 | 2026-09-25 00:55:18.497879 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-25 00:55:19.493351 | localhost -> localhost | changed 2026-09-25 00:55:19.498317 | 2026-09-25 00:55:19.498368 | PLAY [all] 2026-09-25 00:55:19.504714 | 2026-09-25 00:55:19.504773 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-25 00:55:19.719230 | ubuntu-jammy -> localhost | ok 2026-09-25 00:55:19.724069 | 2026-09-25 00:55:19.724140 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-25 00:55:19.750647 | ubuntu-jammy | ok 2026-09-25 00:55:19.761592 | ubuntu-jammy | included: /var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-25 00:55:19.767222 | 2026-09-25 00:55:19.767276 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-25 00:55:20.864425 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2026-09-25 00:55:20.865050 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/ba9390868b0a4a4e94c8c7ee3624ed4e_id_rsa 2026-09-25 00:55:20.865142 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/ba9390868b0a4a4e94c8c7ee3624ed4e_id_rsa.pub 2026-09-25 00:55:20.865193 | ubuntu-jammy -> localhost | The key fingerprint is: 2026-09-25 00:55:20.865235 | ubuntu-jammy -> localhost | SHA256:qzVm2GP2f0FbYAd9mq9/pbY4TPvWsI9ilW0yVpPgsi4 zuul-build-sshkey 2026-09-25 00:55:20.865293 | ubuntu-jammy -> localhost | The key's randomart image is: 2026-09-25 00:55:20.865335 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2026-09-25 00:55:20.865380 | ubuntu-jammy -> localhost | | .o | 2026-09-25 00:55:20.865422 | ubuntu-jammy -> localhost | | .o +| 2026-09-25 00:55:20.865463 | ubuntu-jammy -> localhost | | ...=o| 2026-09-25 00:55:20.865510 | ubuntu-jammy -> localhost | | . .+oo| 2026-09-25 00:55:20.865556 | ubuntu-jammy -> localhost | | S o. B.| 2026-09-25 00:55:20.865602 | ubuntu-jammy -> localhost | | o . .. X =| 2026-09-25 00:55:20.865646 | ubuntu-jammy -> localhost | | . @ .o + @.| 2026-09-25 00:55:20.865683 | ubuntu-jammy -> localhost | | B E .*.B.o| 2026-09-25 00:55:20.865722 | ubuntu-jammy -> localhost | | . oooB+++| 2026-09-25 00:55:20.865758 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2026-09-25 00:55:20.865839 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.639566 2026-09-25 00:55:20.875326 | 2026-09-25 00:55:20.875409 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-25 00:55:20.904773 | ubuntu-jammy | ok 2026-09-25 00:55:20.915314 | ubuntu-jammy | included: /var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-25 00:55:20.924621 | 2026-09-25 00:55:20.924707 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-25 00:55:20.948577 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:20.955917 | 2026-09-25 00:55:20.956005 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-25 00:55:21.406610 | ubuntu-jammy | changed 2026-09-25 00:55:21.411069 | 2026-09-25 00:55:21.411138 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-25 00:55:21.581149 | ubuntu-jammy | ok 2026-09-25 00:55:21.586760 | 2026-09-25 00:55:21.586835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-25 00:55:22.073615 | ubuntu-jammy | changed 2026-09-25 00:55:22.084934 | 2026-09-25 00:55:22.085160 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-25 00:55:22.576418 | ubuntu-jammy | changed 2026-09-25 00:55:22.582765 | 2026-09-25 00:55:22.582846 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-25 00:55:22.606808 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:22.613520 | 2026-09-25 00:55:22.613602 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-25 00:55:23.001066 | ubuntu-jammy -> localhost | changed 2026-09-25 00:55:23.025768 | 2026-09-25 00:55:23.025941 | TASK [add-build-sshkey : Add back temp key] 2026-09-25 00:55:23.353409 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/ba9390868b0a4a4e94c8c7ee3624ed4e_id_rsa (zuul-build-sshkey) 2026-09-25 00:55:23.353675 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.014847 2026-09-25 00:55:23.362298 | 2026-09-25 00:55:23.362415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-25 00:55:23.719421 | ubuntu-jammy | ok 2026-09-25 00:55:23.728122 | 2026-09-25 00:55:23.728295 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-25 00:55:23.753653 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:23.764188 | 2026-09-25 00:55:23.764275 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-25 00:55:24.091780 | ubuntu-jammy | ok 2026-09-25 00:55:24.101865 | 2026-09-25 00:55:24.102000 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-25 00:55:24.879120 | ubuntu-jammy | Output suppressed because no_log was given 2026-09-25 00:55:24.893730 | 2026-09-25 00:55:24.893820 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-25 00:55:25.098271 | ubuntu-jammy | ok: "logs" 2026-09-25 00:55:25.098525 | ubuntu-jammy | ok: All items complete 2026-09-25 00:55:25.098563 | 2026-09-25 00:55:25.288235 | ubuntu-jammy | ok: "artifacts" 2026-09-25 00:55:25.404909 | ubuntu-jammy | ok: "docs" 2026-09-25 00:55:25.423986 | 2026-09-25 00:55:25.424192 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-25 00:55:25.631526 | ubuntu-jammy | changed: "logs" 2026-09-25 00:55:25.784865 | ubuntu-jammy | changed: "artifacts" 2026-09-25 00:55:25.925506 | ubuntu-jammy | changed: "docs" 2026-09-25 00:55:25.938924 | 2026-09-25 00:55:25.939023 | PLAY RECAP 2026-09-25 00:55:25.939067 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:55:25.939095 | ubuntu-jammy | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-25 00:55:25.939130 | 2026-09-25 00:55:26.039864 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 00:55:26.041918 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-25 00:55:26.664146 | 2026-09-25 00:55:26.664267 | PLAY [all] 2026-09-25 00:55:26.674016 | 2026-09-25 00:55:26.674101 | TASK [setup-uv : Extract archive] 2026-09-25 00:55:28.956325 | ubuntu-jammy | changed 2026-09-25 00:55:28.967465 | 2026-09-25 00:55:28.992601 | TASK [setup-uv : Print version] 2026-09-25 00:55:29.364806 | ubuntu-jammy | uv 0.8.13 2026-09-25 00:55:29.543043 | ubuntu-jammy | ok: Runtime: 0:00:00.014513 2026-09-25 00:55:29.559474 | 2026-09-25 00:55:29.559600 | TASK [Install Ansible collection siblings] 2026-09-25 00:55:29.968046 | ubuntu-jammy | ok: 2026-09-25 00:55:29.968290 | ubuntu-jammy | Skipping ansible.posix: no checked-out sibling 2026-09-25 00:55:29.968348 | ubuntu-jammy | Skipping community.general: no checked-out sibling 2026-09-25 00:55:29.970674 | 2026-09-25 00:55:29.970756 | PLAY RECAP 2026-09-25 00:55:29.970835 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:55:29.970876 | 2026-09-25 00:55:30.077964 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-25 00:55:30.080409 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-25 00:55:30.591107 | 2026-09-25 00:55:30.591223 | PLAY [all] 2026-09-25 00:55:30.601285 | 2026-09-25 00:55:30.601351 | LOOP [Check inventory directories] 2026-09-25 00:55:30.916570 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-09-25 00:55:31.090483 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/nerdctl/inventory" 2026-09-25 00:55:31.264695 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/nerdctl/inventory" 2026-09-25 00:55:31.277328 | 2026-09-25 00:55:31.277482 | LOOP [Copy inventory file for Zuul] 2026-09-25 00:55:32.113304 | ubuntu-jammy | changed: 2026-09-25 00:55:32.113615 | ubuntu-jammy | { 2026-09-25 00:55:32.113676 | ubuntu-jammy | "ansible_loop_var": "item", 2026-09-25 00:55:32.113720 | ubuntu-jammy | "changed": false, 2026-09-25 00:55:32.113759 | ubuntu-jammy | "failed": false, 2026-09-25 00:55:32.113802 | ubuntu-jammy | "invocation": { 2026-09-25 00:55:32.113839 | ubuntu-jammy | "module_args": { 2026-09-25 00:55:32.113874 | ubuntu-jammy | "checksum_algorithm": "sha1", 2026-09-25 00:55:32.113908 | ubuntu-jammy | "follow": true, 2026-09-25 00:55:32.113943 | ubuntu-jammy | "get_attributes": true, 2026-09-25 00:55:32.113979 | ubuntu-jammy | "get_checksum": true, 2026-09-25 00:55:32.114014 | ubuntu-jammy | "get_mime": true, 2026-09-25 00:55:32.114047 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-09-25 00:55:32.114082 | ubuntu-jammy | } 2026-09-25 00:55:32.114116 | ubuntu-jammy | }, 2026-09-25 00:55:32.114175 | ubuntu-jammy | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-25 00:55:32.114225 | ubuntu-jammy | "stat": { 2026-09-25 00:55:32.114261 | ubuntu-jammy | "atime": 1790297724.7609437, 2026-09-25 00:55:32.114296 | ubuntu-jammy | "attr_flags": "e", 2026-09-25 00:55:32.114330 | ubuntu-jammy | "attributes": [ 2026-09-25 00:55:32.114364 | ubuntu-jammy | "extents" 2026-09-25 00:55:32.114398 | ubuntu-jammy | ], 2026-09-25 00:55:32.114432 | ubuntu-jammy | "block_size": 4096, 2026-09-25 00:55:32.114466 | ubuntu-jammy | "blocks": 8, 2026-09-25 00:55:32.114500 | ubuntu-jammy | "charset": "unknown", 2026-09-25 00:55:32.114536 | ubuntu-jammy | "ctime": 1790297724.7729435, 2026-09-25 00:55:32.114571 | ubuntu-jammy | "dev": 64513, 2026-09-25 00:55:32.114603 | ubuntu-jammy | "device_type": 0, 2026-09-25 00:55:32.114636 | ubuntu-jammy | "executable": true, 2026-09-25 00:55:32.114668 | ubuntu-jammy | "exists": true, 2026-09-25 00:55:32.114700 | ubuntu-jammy | "gid": 1000, 2026-09-25 00:55:32.114732 | ubuntu-jammy | "gr_name": "zuul", 2026-09-25 00:55:32.114765 | ubuntu-jammy | "inode": 1043485, 2026-09-25 00:55:32.114797 | ubuntu-jammy | "isblk": false, 2026-09-25 00:55:32.114831 | ubuntu-jammy | "ischr": false, 2026-09-25 00:55:32.114863 | ubuntu-jammy | "isdir": true, 2026-09-25 00:55:32.114895 | ubuntu-jammy | "isfifo": false, 2026-09-25 00:55:32.114928 | ubuntu-jammy | "isgid": false, 2026-09-25 00:55:32.114959 | ubuntu-jammy | "islnk": false, 2026-09-25 00:55:32.114991 | ubuntu-jammy | "isreg": false, 2026-09-25 00:55:32.115023 | ubuntu-jammy | "issock": false, 2026-09-25 00:55:32.115054 | ubuntu-jammy | "isuid": false, 2026-09-25 00:55:32.115085 | ubuntu-jammy | "mimetype": "unknown", 2026-09-25 00:55:32.115132 | ubuntu-jammy | "mode": "0755", 2026-09-25 00:55:32.115165 | ubuntu-jammy | "mtime": 1790297711.0876193, 2026-09-25 00:55:32.115197 | ubuntu-jammy | "nlink": 11, 2026-09-25 00:55:32.115229 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-25 00:55:32.115262 | ubuntu-jammy | "pw_name": "zuul", 2026-09-25 00:55:32.115300 | ubuntu-jammy | "readable": true, 2026-09-25 00:55:32.115332 | ubuntu-jammy | "rgrp": true, 2026-09-25 00:55:32.115365 | ubuntu-jammy | "roth": true, 2026-09-25 00:55:32.115397 | ubuntu-jammy | "rusr": true, 2026-09-25 00:55:32.115430 | ubuntu-jammy | "size": 4096, 2026-09-25 00:55:32.115462 | ubuntu-jammy | "uid": 1000, 2026-09-25 00:55:32.115494 | ubuntu-jammy | "version": "601952475", 2026-09-25 00:55:32.115527 | ubuntu-jammy | "wgrp": false, 2026-09-25 00:55:32.115562 | ubuntu-jammy | "woth": false, 2026-09-25 00:55:32.115596 | ubuntu-jammy | "writeable": true, 2026-09-25 00:55:32.115629 | ubuntu-jammy | "wusr": true, 2026-09-25 00:55:32.115662 | ubuntu-jammy | "xgrp": true, 2026-09-25 00:55:32.115694 | ubuntu-jammy | "xoth": true, 2026-09-25 00:55:32.115726 | ubuntu-jammy | "xusr": true 2026-09-25 00:55:32.115758 | ubuntu-jammy | } 2026-09-25 00:55:32.115790 | ubuntu-jammy | } 2026-09-25 00:55:32.115847 | ubuntu-jammy | ok: All items complete 2026-09-25 00:55:32.115887 | 2026-09-25 00:55:32.118112 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:32.119277 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:32.135994 | 2026-09-25 00:55:32.136179 | LOOP [Switch "ansible_host" to private IP] 2026-09-25 00:55:32.468439 | ubuntu-jammy | changed: 1 replacements made 2026-09-25 00:55:32.469558 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:32.474240 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:32.492973 | 2026-09-25 00:55:32.493162 | TASK [Run Molecule scenario] 2026-09-25 00:55:33.099779 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-09-25 00:55:33.940955 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-09-25 00:55:34.149448 | ubuntu-jammy | Using CPython 3.13.7 2026-09-25 00:55:34.149533 | ubuntu-jammy | Creating virtual environment at: .venv 2026-09-25 00:55:35.905279 | ubuntu-jammy | Downloading pygments (1.2MiB) 2026-09-25 00:55:35.912879 | ubuntu-jammy | Downloading ansible-core (2.3MiB) 2026-09-25 00:55:35.913125 | ubuntu-jammy | Downloading cryptography (4.3MiB) 2026-09-25 00:55:36.091063 | ubuntu-jammy | Downloading cryptography 2026-09-25 00:55:36.135545 | ubuntu-jammy | Downloading pygments 2026-09-25 00:55:36.306275 | ubuntu-jammy | Downloading ansible-core 2026-09-25 00:55:36.340523 | ubuntu-jammy | Installed 36 packages in 33ms 2026-09-25 00:55:37.420196 | ubuntu-jammy | INFO Collection 'vexxhost.containers' detected. 2026-09-25 00:55:37.420324 | ubuntu-jammy | INFO Scenarios will be used from 'extensions/molecule' 2026-09-25 00:55:38.311248 | ubuntu-jammy | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-09-25 00:55:38.311377 | ubuntu-jammy | INFO default scenario not found, disabling shared state. 2026-09-25 00:55:38.311573 | ubuntu-jammy | INFO [nerdctl > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-25 00:55:38.311704 | ubuntu-jammy | INFO [nerdctl > prerun] Performing prerun with role_name_check=0... 2026-09-25 00:55:41.204350 | ubuntu-jammy | WARNING Retrying execution failure 1 of: ansible-galaxy collection install -vvv ansible.posix:>=1.6.0 2026-09-25 00:55:41.204555 | ubuntu-jammy | ERROR Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-09-25 00:55:41.204576 | ubuntu-jammy | Starting galaxy collection install process 2026-09-25 00:55:41.204583 | ubuntu-jammy | Process install dependency map 2026-09-25 00:55:41.204589 | ubuntu-jammy | 2026-09-25 00:55:41.204594 | ubuntu-jammy | ansible-galaxy 2026-09-25 00:55:41.204599 | ubuntu-jammy | config file = None 2026-09-25 00:55:41.204604 | ubuntu-jammy | configured module search path = 2026-09-25 00:55:41.204610 | ubuntu-jammy | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible 2026-09-25 00:55:41.204616 | ubuntu-jammy | 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 00:55:41.204625 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-09-25 00:55:41.204630 | ubuntu-jammy | 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 00:55:41.204635 | ubuntu-jammy | jinja version = 3.1.6 2026-09-25 00:55:41.204641 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-09-25 00:55:41.204646 | ubuntu-jammy | No config file found; using defaults 2026-09-25 00:55:41.204651 | ubuntu-jammy | 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 00:55:41.204657 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-09-25 00:55:41.204665 | ubuntu-jammy | : Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection ansible.posix: Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100': 2026-09-25 00:55:41.204671 | ubuntu-jammy | : Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100': 2026-09-25 00:55:41.204676 | ubuntu-jammy | 2026-09-25 00:55:41.204681 | ubuntu-jammy | Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100'. 2026-09-25 00:55:41.204686 | ubuntu-jammy | 2026-09-25 00:55:41.204691 | ubuntu-jammy | <<< caused by >>> 2026-09-25 00:55:41.204696 | ubuntu-jammy | 2026-09-25 00:55:41.204701 | ubuntu-jammy | 2026-09-25 00:55:41.204706 | ubuntu-jammy | 2026-09-25 00:55:41.204724 | ubuntu-jammy | 2026-09-25 00:55:41.206844 | ubuntu-jammy | Traceback (most recent call last): 2026-09-25 00:55:41.208898 | ubuntu-jammy | File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in 2026-09-25 00:55:41.208914 | ubuntu-jammy | sys.exit(main()) 2026-09-25 00:55:41.208920 | ubuntu-jammy | ~~~~^^ 2026-09-25 00:55:41.209128 | ubuntu-jammy | 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 00:55:41.209141 | ubuntu-jammy | return self.main(*args, **kwargs) 2026-09-25 00:55:41.209147 | ubuntu-jammy | ~~~~~~~~~^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.209317 | ubuntu-jammy | 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 00:55:41.209330 | ubuntu-jammy | rv = self.invoke(ctx) 2026-09-25 00:55:41.209537 | ubuntu-jammy | 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 00:55:41.209550 | ubuntu-jammy | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-09-25 00:55:41.209556 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 2026-09-25 00:55:41.209751 | ubuntu-jammy | 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 00:55:41.209763 | ubuntu-jammy | return ctx.invoke(self.callback, **ctx.params) 2026-09-25 00:55:41.209769 | ubuntu-jammy | ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.209936 | ubuntu-jammy | 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 00:55:41.209949 | ubuntu-jammy | return callback(*args, **kwargs) 2026-09-25 00:55:41.210111 | ubuntu-jammy | 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 00:55:41.210123 | ubuntu-jammy | return func(*args, **kwargs) 2026-09-25 00:55:41.210282 | ubuntu-jammy | 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 00:55:41.210294 | ubuntu-jammy | return f(get_current_context(), *args, **kwargs) 2026-09-25 00:55:41.210451 | ubuntu-jammy | 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 00:55:41.210463 | ubuntu-jammy | return func(ctx) 2026-09-25 00:55:41.210683 | ubuntu-jammy | 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 00:55:41.210697 | ubuntu-jammy | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-09-25 00:55:41.210704 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.210885 | ubuntu-jammy | 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 00:55:41.210898 | ubuntu-jammy | _run_scenarios(scenarios, command_args, default_config) 2026-09-25 00:55:41.210903 | ubuntu-jammy | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.211185 | ubuntu-jammy | 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 00:55:41.211198 | ubuntu-jammy | scenario.config.runtime.prepare_environment( 2026-09-25 00:55:41.211204 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-09-25 00:55:41.211210 | ubuntu-jammy | install_local=True, 2026-09-25 00:55:41.211214 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.211220 | ubuntu-jammy | role_name_check=role_name_check, 2026-09-25 00:55:41.211225 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.211230 | ubuntu-jammy | ) 2026-09-25 00:55:41.211235 | ubuntu-jammy | ^ 2026-09-25 00:55:41.211520 | ubuntu-jammy | 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 00:55:41.211545 | ubuntu-jammy | self.install_collection( 2026-09-25 00:55:41.211551 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~^ 2026-09-25 00:55:41.211556 | ubuntu-jammy | f"{name}{',' if is_url(name) else ':'}{required_version}", 2026-09-25 00:55:41.211561 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.211566 | ubuntu-jammy | destination=destination, 2026-09-25 00:55:41.211571 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:55:41.211576 | ubuntu-jammy | ) 2026-09-25 00:55:41.211581 | ubuntu-jammy | ^ 2026-09-25 00:55:41.211749 | ubuntu-jammy | 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 00:55:41.211761 | ubuntu-jammy | raise InvalidPrerequisiteError(msg) 2026-09-25 00:55:41.212435 | ubuntu-jammy | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-09-25 00:55:41.212448 | ubuntu-jammy | Starting galaxy collection install process 2026-09-25 00:55:41.212454 | ubuntu-jammy | Process install dependency map 2026-09-25 00:55:41.212459 | ubuntu-jammy | 2026-09-25 00:55:41.212477 | ubuntu-jammy | ansible-galaxy [core 2.19.1] 2026-09-25 00:55:41.212483 | ubuntu-jammy | config file = None 2026-09-25 00:55:41.212489 | ubuntu-jammy | configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-09-25 00:55:41.212494 | ubuntu-jammy | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible 2026-09-25 00:55:41.212499 | ubuntu-jammy | 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 00:55:41.212504 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-09-25 00:55:41.212509 | ubuntu-jammy | 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 00:55:41.212515 | ubuntu-jammy | jinja version = 3.1.6 2026-09-25 00:55:41.212520 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-09-25 00:55:41.212525 | ubuntu-jammy | No config file found; using defaults 2026-09-25 00:55:41.212531 | ubuntu-jammy | 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 00:55:41.212536 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-09-25 00:55:41.212542 | ubuntu-jammy | [WARNING]: Skipping Galaxy server https://galaxy.ansible.com/api/. Got an unexpected error when getting available versions of collection ansible.posix: Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100': 2026-09-25 00:55:41.212548 | ubuntu-jammy | [ERROR]: Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100': 2026-09-25 00:55:41.212553 | ubuntu-jammy | 2026-09-25 00:55:41.212558 | ubuntu-jammy | Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/versions/?limit=100'. 2026-09-25 00:55:41.212563 | ubuntu-jammy | 2026-09-25 00:55:41.212568 | ubuntu-jammy | <<< caused by >>> 2026-09-25 00:55:41.212573 | ubuntu-jammy | 2026-09-25 00:55:41.212578 | ubuntu-jammy | 2026-09-25 00:55:41.212583 | ubuntu-jammy | 2026-09-25 00:55:41.212588 | ubuntu-jammy | 2026-09-25 00:55:41.558205 | ubuntu-jammy | ERROR 2026-09-25 00:55:41.558462 | ubuntu-jammy | { 2026-09-25 00:55:41.558517 | ubuntu-jammy | "delta": "0:00:08.484392", 2026-09-25 00:55:41.558556 | ubuntu-jammy | "end": "2026-09-25 00:55:41.349281", 2026-09-25 00:55:41.558591 | ubuntu-jammy | "msg": "non-zero return code", 2026-09-25 00:55:41.558625 | ubuntu-jammy | "rc": 1, 2026-09-25 00:55:41.558658 | ubuntu-jammy | "start": "2026-09-25 00:55:32.864889" 2026-09-25 00:55:41.558692 | ubuntu-jammy | } failure 2026-09-25 00:55:41.562295 | 2026-09-25 00:55:41.562389 | PLAY RECAP 2026-09-25 00:55:41.562464 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:55:41.562503 | 2026-09-25 00:55:41.681106 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-25 00:55:41.682208 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 00:55:42.226735 | 2026-09-25 00:55:42.226842 | PLAY [all] 2026-09-25 00:55:42.236443 | 2026-09-25 00:55:42.236530 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-25 00:55:42.289718 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:55:42.294392 | 2026-09-25 00:55:42.294466 | TASK [fetch-output : Set log path for single node] 2026-09-25 00:55:42.335711 | ubuntu-jammy | ok 2026-09-25 00:55:42.344293 | 2026-09-25 00:55:42.344421 | LOOP [fetch-output : Ensure local output dirs] 2026-09-25 00:55:42.723641 | ubuntu-jammy -> localhost | ok: "/var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/logs" 2026-09-25 00:55:42.918875 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/artifacts" 2026-09-25 00:55:43.136186 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/ba9390868b0a4a4e94c8c7ee3624ed4e/work/docs" 2026-09-25 00:55:43.149749 | 2026-09-25 00:55:43.149875 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-25 00:55:43.799082 | ubuntu-jammy | ok 2026-09-25 00:55:43.799375 | ubuntu-jammy | changed: All items complete 2026-09-25 00:55:43.799430 | 2026-09-25 00:55:44.301733 | ubuntu-jammy | changed: .d..t...... ./ 2026-09-25 00:55:44.806983 | ubuntu-jammy | changed: .d..t...... ./ 2026-09-25 00:55:44.834228 | 2026-09-25 00:55:44.834363 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-25 00:55:45.261941 | ubuntu-jammy -> localhost | ok: Item: artifacts Runtime: 0:00:00.005320 2026-09-25 00:55:45.467900 | ubuntu-jammy -> localhost | ok: Item: docs Runtime: 0:00:00.006651 2026-09-25 00:55:45.488175 | 2026-09-25 00:55:45.488308 | PLAY [all] 2026-09-25 00:55:45.499002 | 2026-09-25 00:55:45.499127 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-25 00:55:45.917455 | ubuntu-jammy | changed 2026-09-25 00:55:45.928734 | 2026-09-25 00:55:45.928861 | PLAY RECAP 2026-09-25 00:55:45.928964 | ubuntu-jammy | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-25 00:55:45.929008 | 2026-09-25 00:55:46.049611 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 00:55:46.051036 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-25 00:55:46.573273 | 2026-09-25 00:55:46.573376 | PLAY [localhost] 2026-09-25 00:55:46.583303 | 2026-09-25 00:55:46.583376 | TASK [Generate Zuul manifest] 2026-09-25 00:55:46.609851 | localhost | ok 2026-09-25 00:55:46.624313 | 2026-09-25 00:55:46.624407 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-25 00:55:47.010536 | localhost | changed 2026-09-25 00:55:47.029871 | 2026-09-25 00:55:47.030020 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-25 00:55:47.076119 | localhost | ok 2026-09-25 00:55:47.090362 | 2026-09-25 00:55:47.090497 | TASK [Upload logs] 2026-09-25 00:55:47.110980 | localhost | ok 2026-09-25 00:55:47.178562 | 2026-09-25 00:55:47.178680 | TASK [Set zuul-log-path fact] 2026-09-25 00:55:47.194694 | localhost | ok 2026-09-25 00:55:47.204220 | 2026-09-25 00:55:47.204282 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 00:55:47.232829 | localhost | ok 2026-09-25 00:55:47.240858 | 2026-09-25 00:55:47.240940 | TASK [upload-logs : Create log directories] 2026-09-25 00:55:47.625810 | localhost | changed 2026-09-25 00:55:47.637128 | 2026-09-25 00:55:47.637408 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-25 00:55:48.082202 | localhost -> localhost | ok: Runtime: 0:00:00.004674 2026-09-25 00:55:48.095209 | 2026-09-25 00:55:48.095471 | TASK [upload-logs : Upload logs to log server] 2026-09-25 00:55:48.646936 | localhost | Output suppressed because no_log was given 2026-09-25 00:55:48.654302 | 2026-09-25 00:55:48.654453 | LOOP [upload-logs : Compress console log and json output] 2026-09-25 00:55:48.711616 | localhost | skipping: Conditional result was False 2026-09-25 00:55:48.719593 | localhost | skipping: Conditional result was False 2026-09-25 00:55:48.728589 | 2026-09-25 00:55:48.728737 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-25 00:55:48.768655 | localhost | skipping: Conditional result was False 2026-09-25 00:55:48.769033 | 2026-09-25 00:55:48.772594 | localhost | skipping: Conditional result was False 2026-09-25 00:55:48.788724 | 2026-09-25 00:55:48.788924 | LOOP [upload-logs : Upload console log and json output]