2026-08-14 09:14:06.204396 | Job console starting 2026-08-14 09:14:06.214347 | Updating git repos 2026-08-14 09:14:06.247538 | Cloning repos into workspace 2026-08-14 09:14:06.302922 | Restoring repo states 2026-08-14 09:14:06.313510 | Merging changes 2026-08-14 09:14:06.678714 | Checking out repos 2026-08-14 09:14:06.744354 | Preparing playbooks 2026-08-14 09:14:08.169421 | Running Ansible setup 2026-08-14 09:14:12.424764 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-14 09:14:13.194558 | 2026-08-14 09:14:13.205277 | PLAY [localhost] 2026-08-14 09:14:13.220921 | 2026-08-14 09:14:13.221148 | TASK [Gathering Facts] 2026-08-14 09:14:14.394931 | localhost | ok 2026-08-14 09:14:14.408380 | 2026-08-14 09:14:14.437493 | TASK [Setup log path fact] 2026-08-14 09:14:14.462661 | localhost | ok 2026-08-14 09:14:14.491654 | 2026-08-14 09:14:14.491861 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-14 09:14:14.535962 | localhost | ok 2026-08-14 09:14:14.551302 | 2026-08-14 09:14:14.573245 | TASK [emit-job-header : Print job information] 2026-08-14 09:14:14.621810 | # Job Information 2026-08-14 09:14:14.622142 | Ansible Version: 2.16.18 2026-08-14 09:14:14.622207 | Job: ansible-collection-containers-molecule-nerdctl-ubuntu-jammy 2026-08-14 09:14:14.622263 | Pipeline: check 2026-08-14 09:14:14.622290 | Executor: 2d72f0692154 2026-08-14 09:14:14.622311 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/118 2026-08-14 09:14:14.622358 | Event ID: a802cb70-97bb-11f1-957e-53392f4bb2bb 2026-08-14 09:14:14.626922 | 2026-08-14 09:14:14.627581 | LOOP [emit-job-header : Print node information] 2026-08-14 09:14:14.736904 | localhost | ok: 2026-08-14 09:14:14.761462 | localhost | # Node Information 2026-08-14 09:14:14.761648 | localhost | Inventory Hostname: ubuntu-jammy 2026-08-14 09:14:14.761693 | localhost | Hostname: np0000189698 2026-08-14 09:14:14.761732 | localhost | Username: zuul 2026-08-14 09:14:14.761787 | localhost | Distro: Ubuntu 22.04 2026-08-14 09:14:14.761831 | localhost | Provider: yul1 2026-08-14 09:14:14.761864 | localhost | Region: ca-ymq-1 2026-08-14 09:14:14.761892 | localhost | Label: ubuntu-jammy 2026-08-14 09:14:14.761921 | localhost | Product Name: OpenStack Nova 2026-08-14 09:14:14.761949 | localhost | Interface IP: 199.204.45.35 2026-08-14 09:14:14.775956 | 2026-08-14 09:14:14.776120 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-14 09:14:15.422681 | localhost -> localhost | changed 2026-08-14 09:14:15.431797 | 2026-08-14 09:14:15.431935 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-14 09:14:16.613462 | localhost -> localhost | changed 2026-08-14 09:14:16.621032 | 2026-08-14 09:14:16.628266 | PLAY [all] 2026-08-14 09:14:16.645459 | 2026-08-14 09:14:16.657306 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-14 09:14:17.013653 | ubuntu-jammy -> localhost | ok 2026-08-14 09:14:17.025139 | 2026-08-14 09:14:17.086472 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-14 09:14:17.127036 | ubuntu-jammy | ok 2026-08-14 09:14:17.142767 | ubuntu-jammy | included: /var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-14 09:14:17.155550 | 2026-08-14 09:14:17.155756 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-14 09:14:19.132140 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2026-08-14 09:14:19.132353 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/cfed8718b6ae484ca20ee95a421826f4_id_rsa 2026-08-14 09:14:19.132389 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/cfed8718b6ae484ca20ee95a421826f4_id_rsa.pub 2026-08-14 09:14:19.132413 | ubuntu-jammy -> localhost | The key fingerprint is: 2026-08-14 09:14:19.132434 | ubuntu-jammy -> localhost | SHA256:f4hNJschkehUAE4dute6zedYxGSsJttO4HFh2gh+m7c zuul-build-sshkey 2026-08-14 09:14:19.132475 | ubuntu-jammy -> localhost | The key's randomart image is: 2026-08-14 09:14:19.132497 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2026-08-14 09:14:19.132526 | ubuntu-jammy -> localhost | | ooo=o. | 2026-08-14 09:14:19.132549 | ubuntu-jammy -> localhost | | o .+ .o | 2026-08-14 09:14:19.132570 | ubuntu-jammy -> localhost | | +o + = | 2026-08-14 09:14:19.132590 | ubuntu-jammy -> localhost | | . o.* O . | 2026-08-14 09:14:19.132609 | ubuntu-jammy -> localhost | | o O S B | 2026-08-14 09:14:19.132629 | ubuntu-jammy -> localhost | | + % X . | 2026-08-14 09:14:19.132649 | ubuntu-jammy -> localhost | | * = = . | 2026-08-14 09:14:19.132670 | ubuntu-jammy -> localhost | | B +.. | 2026-08-14 09:14:19.132695 | ubuntu-jammy -> localhost | | . Eo. | 2026-08-14 09:14:19.132715 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2026-08-14 09:14:19.132775 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:01.409561 2026-08-14 09:14:19.138573 | 2026-08-14 09:14:19.138643 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-14 09:14:19.173282 | ubuntu-jammy | ok 2026-08-14 09:14:19.184651 | ubuntu-jammy | included: /var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-14 09:14:19.193437 | 2026-08-14 09:14:19.193545 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-14 09:14:19.218367 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:19.230810 | 2026-08-14 09:14:19.230959 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-14 09:14:19.779343 | ubuntu-jammy | changed 2026-08-14 09:14:19.785970 | 2026-08-14 09:14:19.786044 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-14 09:14:19.981007 | ubuntu-jammy | ok 2026-08-14 09:14:19.988661 | 2026-08-14 09:14:19.988779 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-14 09:14:20.499908 | ubuntu-jammy | changed 2026-08-14 09:14:20.507764 | 2026-08-14 09:14:20.507895 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-14 09:14:21.069987 | ubuntu-jammy | changed 2026-08-14 09:14:21.077638 | 2026-08-14 09:14:21.077807 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-14 09:14:21.111294 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:21.122453 | 2026-08-14 09:14:21.122560 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-14 09:14:21.576826 | ubuntu-jammy -> localhost | changed 2026-08-14 09:14:21.594755 | 2026-08-14 09:14:21.594895 | TASK [add-build-sshkey : Add back temp key] 2026-08-14 09:14:21.916903 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/cfed8718b6ae484ca20ee95a421826f4_id_rsa (zuul-build-sshkey) 2026-08-14 09:14:21.917279 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.014163 2026-08-14 09:14:21.924602 | 2026-08-14 09:14:21.924699 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-14 09:14:22.272238 | ubuntu-jammy | ok 2026-08-14 09:14:22.278063 | 2026-08-14 09:14:22.278245 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-14 09:14:22.304427 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:22.321850 | 2026-08-14 09:14:22.322003 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-14 09:14:22.684258 | ubuntu-jammy | ok 2026-08-14 09:14:22.691895 | 2026-08-14 09:14:22.691976 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-14 09:14:23.651023 | ubuntu-jammy | Output suppressed because no_log was given 2026-08-14 09:14:23.660586 | 2026-08-14 09:14:23.660660 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-14 09:14:23.850099 | ubuntu-jammy | ok: "logs" 2026-08-14 09:14:24.574197 | ubuntu-jammy | ok: All items complete 2026-08-14 09:14:24.574326 | 2026-08-14 09:14:24.660072 | ubuntu-jammy | ok: "artifacts" 2026-08-14 09:14:24.665884 | ubuntu-jammy | ok: "docs" 2026-08-14 09:14:24.681941 | 2026-08-14 09:14:24.682329 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-14 09:14:24.884807 | ubuntu-jammy | changed: "logs" 2026-08-14 09:14:25.065961 | ubuntu-jammy | changed: "artifacts" 2026-08-14 09:14:25.225956 | ubuntu-jammy | changed: "docs" 2026-08-14 09:14:25.239799 | 2026-08-14 09:14:25.239954 | PLAY RECAP 2026-08-14 09:14:25.240007 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:14:25.240039 | ubuntu-jammy | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-14 09:14:25.240062 | 2026-08-14 09:14:25.456235 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-14 09:14:25.459076 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-14 09:14:26.280091 | 2026-08-14 09:14:26.280253 | PLAY [all] 2026-08-14 09:14:26.292618 | 2026-08-14 09:14:26.292719 | TASK [setup-uv : Extract archive] 2026-08-14 09:14:28.601745 | ubuntu-jammy | changed 2026-08-14 09:14:28.608524 | 2026-08-14 09:14:28.608671 | TASK [setup-uv : Print version] 2026-08-14 09:14:28.973532 | ubuntu-jammy | uv 0.8.13 2026-08-14 09:14:29.149121 | ubuntu-jammy | ok: Runtime: 0:00:00.013000 2026-08-14 09:14:29.158954 | 2026-08-14 09:14:29.159065 | TASK [Install Ansible collection siblings] 2026-08-14 09:14:29.612472 | ubuntu-jammy | ok: 2026-08-14 09:14:29.612757 | ubuntu-jammy | Skipping ansible.posix: no checked-out sibling 2026-08-14 09:14:29.612825 | ubuntu-jammy | Skipping community.general: no checked-out sibling 2026-08-14 09:14:29.620242 | 2026-08-14 09:14:29.620355 | PLAY RECAP 2026-08-14 09:14:29.620403 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:14:29.620432 | 2026-08-14 09:14:29.797600 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-14 09:14:29.799288 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-14 09:14:30.926981 | 2026-08-14 09:14:31.647744 | PLAY [all] 2026-08-14 09:14:31.668725 | 2026-08-14 09:14:31.668932 | LOOP [Check inventory directories] 2026-08-14 09:14:31.973355 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-08-14 09:14:32.129688 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/nerdctl/inventory" 2026-08-14 09:14:32.284220 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/nerdctl/inventory" 2026-08-14 09:14:32.303473 | 2026-08-14 09:14:32.303720 | LOOP [Copy inventory file for Zuul] 2026-08-14 09:14:33.185141 | ubuntu-jammy | changed: 2026-08-14 09:14:33.332049 | ubuntu-jammy | { 2026-08-14 09:14:33.332259 | ubuntu-jammy | "ansible_loop_var": "item", 2026-08-14 09:14:33.332321 | ubuntu-jammy | "changed": false, 2026-08-14 09:14:33.332369 | ubuntu-jammy | "failed": false, 2026-08-14 09:14:33.332426 | ubuntu-jammy | "invocation": { 2026-08-14 09:14:33.332471 | ubuntu-jammy | "module_args": { 2026-08-14 09:14:33.332525 | ubuntu-jammy | "checksum_algorithm": "sha1", 2026-08-14 09:14:33.332570 | ubuntu-jammy | "follow": true, 2026-08-14 09:14:33.332611 | ubuntu-jammy | "get_attributes": true, 2026-08-14 09:14:33.332657 | ubuntu-jammy | "get_checksum": true, 2026-08-14 09:14:33.332699 | ubuntu-jammy | "get_mime": true, 2026-08-14 09:14:33.332738 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-08-14 09:14:33.332780 | ubuntu-jammy | } 2026-08-14 09:14:33.332821 | ubuntu-jammy | }, 2026-08-14 09:14:33.332861 | ubuntu-jammy | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-14 09:14:33.332932 | ubuntu-jammy | "stat": { 2026-08-14 09:14:33.333013 | ubuntu-jammy | "atime": 1786698863.5497541, 2026-08-14 09:14:33.333058 | ubuntu-jammy | "attr_flags": "e", 2026-08-14 09:14:33.333100 | ubuntu-jammy | "attributes": [ 2026-08-14 09:14:33.333142 | ubuntu-jammy | "extents" 2026-08-14 09:14:33.333184 | ubuntu-jammy | ], 2026-08-14 09:14:33.333225 | ubuntu-jammy | "block_size": 4096, 2026-08-14 09:14:33.333263 | ubuntu-jammy | "blocks": 8, 2026-08-14 09:14:33.333484 | ubuntu-jammy | "charset": "unknown", 2026-08-14 09:14:33.333527 | ubuntu-jammy | "ctime": 1786698863.5577552, 2026-08-14 09:14:33.333567 | ubuntu-jammy | "dev": 64513, 2026-08-14 09:14:33.333608 | ubuntu-jammy | "device_type": 0, 2026-08-14 09:14:33.333648 | ubuntu-jammy | "executable": true, 2026-08-14 09:14:33.333688 | ubuntu-jammy | "exists": true, 2026-08-14 09:14:33.333727 | ubuntu-jammy | "gid": 1000, 2026-08-14 09:14:33.333769 | ubuntu-jammy | "gr_name": "zuul", 2026-08-14 09:14:33.333809 | ubuntu-jammy | "inode": 1042461, 2026-08-14 09:14:33.333848 | ubuntu-jammy | "isblk": false, 2026-08-14 09:14:33.333912 | ubuntu-jammy | "ischr": false, 2026-08-14 09:14:33.333957 | ubuntu-jammy | "isdir": true, 2026-08-14 09:14:33.333999 | ubuntu-jammy | "isfifo": false, 2026-08-14 09:14:33.334051 | ubuntu-jammy | "isgid": false, 2026-08-14 09:14:33.334097 | ubuntu-jammy | "islnk": false, 2026-08-14 09:14:33.334136 | ubuntu-jammy | "isreg": false, 2026-08-14 09:14:33.334175 | ubuntu-jammy | "issock": false, 2026-08-14 09:14:33.334215 | ubuntu-jammy | "isuid": false, 2026-08-14 09:14:33.334253 | ubuntu-jammy | "mimetype": "unknown", 2026-08-14 09:14:33.334306 | ubuntu-jammy | "mode": "0755", 2026-08-14 09:14:33.334355 | ubuntu-jammy | "mtime": 1786698846.636449, 2026-08-14 09:14:33.334400 | ubuntu-jammy | "nlink": 11, 2026-08-14 09:14:33.334446 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-14 09:14:33.334491 | ubuntu-jammy | "pw_name": "zuul", 2026-08-14 09:14:33.334545 | ubuntu-jammy | "readable": true, 2026-08-14 09:14:33.334592 | ubuntu-jammy | "rgrp": true, 2026-08-14 09:14:33.334637 | ubuntu-jammy | "roth": true, 2026-08-14 09:14:33.334684 | ubuntu-jammy | "rusr": true, 2026-08-14 09:14:33.334731 | ubuntu-jammy | "size": 4096, 2026-08-14 09:14:33.334779 | ubuntu-jammy | "uid": 1000, 2026-08-14 09:14:33.334824 | ubuntu-jammy | "version": "926511721", 2026-08-14 09:14:33.334872 | ubuntu-jammy | "wgrp": false, 2026-08-14 09:14:33.334920 | ubuntu-jammy | "woth": false, 2026-08-14 09:14:33.334968 | ubuntu-jammy | "writeable": true, 2026-08-14 09:14:33.335014 | ubuntu-jammy | "wusr": true, 2026-08-14 09:14:33.335058 | ubuntu-jammy | "xgrp": true, 2026-08-14 09:14:33.335104 | ubuntu-jammy | "xoth": true, 2026-08-14 09:14:33.335148 | ubuntu-jammy | "xusr": true 2026-08-14 09:14:33.335355 | ubuntu-jammy | } 2026-08-14 09:14:33.335438 | ubuntu-jammy | } 2026-08-14 09:14:33.335696 | ubuntu-jammy | ok: All items complete 2026-08-14 09:14:33.335761 | 2026-08-14 09:14:33.339659 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:33.341428 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:33.356170 | 2026-08-14 09:14:33.358046 | LOOP [Switch "ansible_host" to private IP] 2026-08-14 09:14:33.770810 | ubuntu-jammy | changed: 1 replacements made 2026-08-14 09:14:33.773767 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:33.775030 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:14:33.795863 | 2026-08-14 09:14:33.796095 | TASK [Run Molecule scenario] 2026-08-14 09:14:34.451980 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-08-14 09:14:35.190224 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-08-14 09:14:35.378745 | ubuntu-jammy | Using CPython 3.13.7 2026-08-14 09:14:35.378792 | ubuntu-jammy | Creating virtual environment at: .venv 2026-08-14 09:14:35.599455 | ubuntu-jammy | Downloading pygments (1.2MiB) 2026-08-14 09:14:35.600965 | ubuntu-jammy | Downloading cryptography (4.3MiB) 2026-08-14 09:14:35.659331 | ubuntu-jammy | Downloading ansible-core (2.3MiB) 2026-08-14 09:14:35.770779 | ubuntu-jammy | Downloading cryptography 2026-08-14 09:14:35.793499 | ubuntu-jammy | Downloading pygments 2026-08-14 09:14:35.950815 | ubuntu-jammy | Downloading ansible-core 2026-08-14 09:14:35.979416 | ubuntu-jammy | Installed 36 packages in 28ms 2026-08-14 09:14:37.082731 | ubuntu-jammy | INFO Collection 'vexxhost.containers' detected. 2026-08-14 09:14:37.082839 | ubuntu-jammy | INFO Scenarios will be used from 'extensions/molecule' 2026-08-14 09:14:37.926370 | ubuntu-jammy | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-08-14 09:14:37.926470 | ubuntu-jammy | INFO default scenario not found, disabling shared state. 2026-08-14 09:14:37.926483 | ubuntu-jammy | INFO [nerdctl > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-14 09:14:37.926565 | ubuntu-jammy | INFO [nerdctl > prerun] Performing prerun with role_name_check=0... 2026-08-14 09:15:42.260857 | ubuntu-jammy | WARNING Retrying execution failure 1 of: ansible-galaxy collection install -vvv ansible.posix:>=1.6.0 2026-08-14 09:15:42.261071 | ubuntu-jammy | ERROR Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-08-14 09:15:42.261085 | ubuntu-jammy | Starting galaxy collection install process 2026-08-14 09:15:42.261096 | ubuntu-jammy | Process install dependency map 2026-08-14 09:15:42.261107 | ubuntu-jammy | Starting collection install process 2026-08-14 09:15:42.261117 | ubuntu-jammy | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-posix-2.2.2.tar.gz to /home/zuul/.ansible/tmp/ansible-local-11105d80kevd/tmpq0zq9421/ansible-posix-2.2.2-sslat1pv 2026-08-14 09:15:42.261130 | ubuntu-jammy | 2026-08-14 09:15:42.261139 | ubuntu-jammy | ansible-galaxy 2026-08-14 09:15:42.261148 | ubuntu-jammy | config file = None 2026-08-14 09:15:42.261157 | ubuntu-jammy | configured module search path = 2026-08-14 09:15:42.261167 | ubuntu-jammy | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible 2026-08-14 09:15:42.261178 | 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-08-14 09:15:42.261191 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-08-14 09:15:42.261200 | 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-08-14 09:15:42.261210 | ubuntu-jammy | jinja version = 3.1.6 2026-08-14 09:15:42.261219 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-08-14 09:15:42.261228 | ubuntu-jammy | No config file found; using defaults 2026-08-14 09:15:42.261237 | 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-08-14 09:15:42.261246 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-08-14 09:15:42.261256 | ubuntu-jammy | : Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out 2026-08-14 09:15:42.261265 | ubuntu-jammy | 2026-08-14 09:15:42.264566 | ubuntu-jammy | Traceback (most recent call last): 2026-08-14 09:15:42.268319 | ubuntu-jammy | File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in 2026-08-14 09:15:42.268339 | ubuntu-jammy | sys.exit(main()) 2026-08-14 09:15:42.268349 | ubuntu-jammy | ~~~~^^ 2026-08-14 09:15:42.268725 | 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-08-14 09:15:42.268776 | ubuntu-jammy | return self.main(*args, **kwargs) 2026-08-14 09:15:42.268790 | ubuntu-jammy | ~~~~~~~~~^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.268984 | 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-08-14 09:15:42.268995 | ubuntu-jammy | rv = self.invoke(ctx) 2026-08-14 09:15:42.269367 | 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-08-14 09:15:42.269399 | ubuntu-jammy | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-08-14 09:15:42.269411 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 2026-08-14 09:15:42.269646 | 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-08-14 09:15:42.269658 | ubuntu-jammy | return ctx.invoke(self.callback, **ctx.params) 2026-08-14 09:15:42.269667 | ubuntu-jammy | ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.269897 | 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-08-14 09:15:42.269907 | ubuntu-jammy | return callback(*args, **kwargs) 2026-08-14 09:15:42.270165 | 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-08-14 09:15:42.270175 | ubuntu-jammy | return func(*args, **kwargs) 2026-08-14 09:15:42.270514 | 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-08-14 09:15:42.270525 | ubuntu-jammy | return f(get_current_context(), *args, **kwargs) 2026-08-14 09:15:42.270801 | 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-08-14 09:15:42.270811 | ubuntu-jammy | return func(ctx) 2026-08-14 09:15:42.271159 | 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-08-14 09:15:42.271195 | ubuntu-jammy | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-08-14 09:15:42.271214 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.271466 | 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-08-14 09:15:42.271484 | ubuntu-jammy | _run_scenarios(scenarios, command_args, default_config) 2026-08-14 09:15:42.271493 | ubuntu-jammy | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.272004 | 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-08-14 09:15:42.272018 | ubuntu-jammy | scenario.config.runtime.prepare_environment( 2026-08-14 09:15:42.272027 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-08-14 09:15:42.272036 | ubuntu-jammy | install_local=True, 2026-08-14 09:15:42.272044 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.272053 | ubuntu-jammy | role_name_check=role_name_check, 2026-08-14 09:15:42.272062 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.272070 | ubuntu-jammy | ) 2026-08-14 09:15:42.272079 | ubuntu-jammy | ^ 2026-08-14 09:15:42.272351 | 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-08-14 09:15:42.272362 | ubuntu-jammy | self.install_collection( 2026-08-14 09:15:42.272370 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~^ 2026-08-14 09:15:42.272379 | ubuntu-jammy | f"{name}{',' if is_url(name) else ':'}{required_version}", 2026-08-14 09:15:42.272388 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.272396 | ubuntu-jammy | destination=destination, 2026-08-14 09:15:42.272436 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^ 2026-08-14 09:15:42.272446 | ubuntu-jammy | ) 2026-08-14 09:15:42.272454 | ubuntu-jammy | ^ 2026-08-14 09:15:42.272483 | 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-08-14 09:15:42.272494 | ubuntu-jammy | raise InvalidPrerequisiteError(msg) 2026-08-14 09:15:42.272969 | ubuntu-jammy | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-08-14 09:15:42.272979 | ubuntu-jammy | Starting galaxy collection install process 2026-08-14 09:15:42.272988 | ubuntu-jammy | Process install dependency map 2026-08-14 09:15:42.272997 | ubuntu-jammy | Starting collection install process 2026-08-14 09:15:42.273006 | ubuntu-jammy | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/ansible-posix-2.2.2.tar.gz to /home/zuul/.ansible/tmp/ansible-local-11105d80kevd/tmpq0zq9421/ansible-posix-2.2.2-sslat1pv 2026-08-14 09:15:42.273015 | ubuntu-jammy | 2026-08-14 09:15:42.273024 | ubuntu-jammy | ansible-galaxy [core 2.19.1] 2026-08-14 09:15:42.273033 | ubuntu-jammy | config file = None 2026-08-14 09:15:42.273042 | ubuntu-jammy | configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-08-14 09:15:42.273050 | ubuntu-jammy | ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible 2026-08-14 09:15:42.273059 | 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-08-14 09:15:42.273069 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-08-14 09:15:42.273078 | 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-08-14 09:15:42.273089 | ubuntu-jammy | jinja version = 3.1.6 2026-08-14 09:15:42.273098 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-08-14 09:15:42.273106 | ubuntu-jammy | No config file found; using defaults 2026-08-14 09:15:42.273116 | 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-08-14 09:15:42.273126 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-08-14 09:15:42.273134 | ubuntu-jammy | [ERROR]: Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out 2026-08-14 09:15:42.273144 | ubuntu-jammy | 2026-08-14 09:15:42.507887 | ubuntu-jammy | ERROR 2026-08-14 09:15:42.508167 | ubuntu-jammy | { 2026-08-14 09:15:42.508220 | ubuntu-jammy | "delta": "0:01:08.143399", 2026-08-14 09:15:42.508258 | ubuntu-jammy | "end": "2026-08-14 09:15:42.381479", 2026-08-14 09:15:42.508291 | ubuntu-jammy | "msg": "non-zero return code", 2026-08-14 09:15:42.508326 | ubuntu-jammy | "rc": 1, 2026-08-14 09:15:42.508358 | ubuntu-jammy | "start": "2026-08-14 09:14:34.238080" 2026-08-14 09:15:42.508389 | ubuntu-jammy | } failure 2026-08-14 09:15:42.512114 | 2026-08-14 09:15:42.512191 | PLAY RECAP 2026-08-14 09:15:42.512251 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-14 09:15:42.512282 | 2026-08-14 09:15:42.677474 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-14 09:15:42.679268 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-14 09:15:43.378486 | 2026-08-14 09:15:43.378682 | PLAY [all] 2026-08-14 09:15:43.394363 | 2026-08-14 09:15:43.394549 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-14 09:15:43.442305 | ubuntu-jammy | skipping: Conditional result was False 2026-08-14 09:15:43.451764 | 2026-08-14 09:15:43.451976 | TASK [fetch-output : Set log path for single node] 2026-08-14 09:15:43.495767 | ubuntu-jammy | ok 2026-08-14 09:15:43.503387 | 2026-08-14 09:15:43.503705 | LOOP [fetch-output : Ensure local output dirs] 2026-08-14 09:15:44.054670 | ubuntu-jammy -> localhost | ok: "/var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/logs" 2026-08-14 09:15:44.361682 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/artifacts" 2026-08-14 09:15:44.647049 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/cfed8718b6ae484ca20ee95a421826f4/work/docs" 2026-08-14 09:15:44.665105 | 2026-08-14 09:15:44.665426 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-14 09:15:45.415567 | ubuntu-jammy | changed: .d..t...... ./ 2026-08-14 09:15:45.415971 | ubuntu-jammy | changed: All items complete 2026-08-14 09:15:45.416086 | 2026-08-14 09:15:45.935345 | ubuntu-jammy | changed: .d..t...... ./ 2026-08-14 09:15:46.453154 | ubuntu-jammy | changed: .d..t...... ./ 2026-08-14 09:15:46.477535 | 2026-08-14 09:15:46.477703 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-14 09:15:47.009905 | ubuntu-jammy -> localhost | ok: Item: artifacts Runtime: 0:00:00.008056 2026-08-14 09:15:47.287925 | ubuntu-jammy -> localhost | ok: Item: docs Runtime: 0:00:00.009077 2026-08-14 09:15:47.305373 | 2026-08-14 09:15:47.305552 | PLAY [all] 2026-08-14 09:15:47.312070 | 2026-08-14 09:15:47.312176 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-14 09:15:47.787103 | ubuntu-jammy | changed 2026-08-14 09:15:47.939357 | 2026-08-14 09:15:47.939522 | PLAY RECAP 2026-08-14 09:15:47.939650 | ubuntu-jammy | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-14 09:15:47.939694 | 2026-08-14 09:15:48.169139 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-14 09:15:48.171408 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-14 09:15:48.858558 | 2026-08-14 09:15:48.858733 | PLAY [localhost] 2026-08-14 09:15:48.872197 | 2026-08-14 09:15:48.872366 | TASK [Generate Zuul manifest] 2026-08-14 09:15:48.893301 | localhost | ok 2026-08-14 09:15:48.913429 | 2026-08-14 09:15:48.913632 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-14 09:15:49.357457 | localhost | changed 2026-08-14 09:15:49.373768 | 2026-08-14 09:15:49.373950 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-14 09:15:49.418079 | localhost | ok 2026-08-14 09:15:49.429875 | 2026-08-14 09:15:49.430022 | TASK [Upload logs] 2026-08-14 09:15:49.450678 | localhost | ok 2026-08-14 09:15:49.536434 | 2026-08-14 09:15:49.536582 | TASK [Set zuul-log-path fact] 2026-08-14 09:15:49.559036 | localhost | ok 2026-08-14 09:15:49.575029 | 2026-08-14 09:15:49.575180 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-14 09:15:49.607558 | localhost | ok 2026-08-14 09:15:49.617726 | 2026-08-14 09:15:49.617884 | TASK [upload-logs : Create log directories] 2026-08-14 09:15:50.147922 | localhost | changed 2026-08-14 09:15:50.155249 | 2026-08-14 09:15:50.155410 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-14 09:15:50.798615 | localhost -> localhost | ok: Runtime: 0:00:00.006124 2026-08-14 09:15:50.809752 | 2026-08-14 09:15:50.809900 | TASK [upload-logs : Upload logs to log server] 2026-08-14 09:15:51.663281 | localhost | Output suppressed because no_log was given 2026-08-14 09:15:51.668082 | 2026-08-14 09:15:51.668170 | LOOP [upload-logs : Compress console log and json output] 2026-08-14 09:15:51.728413 | localhost | skipping: Conditional result was False 2026-08-14 09:15:51.734463 | localhost | skipping: Conditional result was False 2026-08-14 09:15:51.749901 | 2026-08-14 09:15:51.750309 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-14 09:15:51.798211 | localhost | skipping: Conditional result was False 2026-08-14 09:15:51.798560 | 2026-08-14 09:15:51.804655 | localhost | skipping: Conditional result was False 2026-08-14 09:15:51.820261 | 2026-08-14 09:15:51.820498 | LOOP [upload-logs : Upload console log and json output]