2026-09-25 00:57:53.511987 | Job console starting 2026-09-25 00:57:53.521273 | Updating git repos 2026-09-25 00:57:53.542726 | Cloning repos into workspace 2026-09-25 00:57:53.645499 | Restoring repo states 2026-09-25 00:57:53.651446 | Merging changes 2026-09-25 00:57:53.979225 | Checking out repos 2026-09-25 00:57:54.023200 | Preparing playbooks 2026-09-25 00:57:55.844589 | Running Ansible setup 2026-09-25 00:57:59.234541 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 00:57:59.851281 | 2026-09-25 00:57:59.851416 | PLAY [localhost] 2026-09-25 00:57:59.858442 | 2026-09-25 00:57:59.858517 | TASK [Gathering Facts] 2026-09-25 00:58:00.722259 | localhost | ok 2026-09-25 00:58:00.736310 | 2026-09-25 00:58:00.736486 | TASK [Setup log path fact] 2026-09-25 00:58:00.753597 | localhost | ok 2026-09-25 00:58:00.763708 | 2026-09-25 00:58:00.763849 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 00:58:00.800689 | localhost | ok 2026-09-25 00:58:00.806224 | 2026-09-25 00:58:00.806297 | TASK [emit-job-header : Print job information] 2026-09-25 00:58:00.844148 | # Job Information 2026-09-25 00:58:00.844561 | Ansible Version: 2.16.18 2026-09-25 00:58:00.844623 | Job: ansible-collection-containers-molecule-containerd-ubuntu-jammy 2026-09-25 00:58:00.844654 | Pipeline: check 2026-09-25 00:58:00.844679 | Executor: 2d72f0692154 2026-09-25 00:58:00.844702 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149 2026-09-25 00:58:00.844730 | Event ID: 370be290-b87b-11f1-8216-00cbc496f9a1 2026-09-25 00:58:00.848799 | 2026-09-25 00:58:00.848941 | LOOP [emit-job-header : Print node information] 2026-09-25 00:58:00.932476 | localhost | ok: 2026-09-25 00:58:00.973606 | localhost | # Node Information 2026-09-25 00:58:00.973716 | localhost | Inventory Hostname: ubuntu-jammy 2026-09-25 00:58:00.973739 | localhost | Hostname: np0000193909 2026-09-25 00:58:00.973757 | localhost | Username: zuul 2026-09-25 00:58:00.973779 | localhost | Distro: Ubuntu 22.04 2026-09-25 00:58:00.973797 | localhost | Provider: yul1 2026-09-25 00:58:00.973813 | localhost | Region: ca-ymq-1 2026-09-25 00:58:00.973829 | localhost | Label: ubuntu-jammy 2026-09-25 00:58:00.973844 | localhost | Product Name: OpenStack Nova 2026-09-25 00:58:00.973859 | localhost | Interface IP: 199.19.213.142 2026-09-25 00:58:00.989398 | 2026-09-25 00:58:00.989597 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-25 00:58:01.370614 | localhost -> localhost | changed 2026-09-25 00:58:01.380154 | 2026-09-25 00:58:01.380339 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-25 00:58:02.175662 | localhost -> localhost | changed 2026-09-25 00:58:02.187314 | 2026-09-25 00:58:02.187480 | PLAY [all] 2026-09-25 00:58:02.203005 | 2026-09-25 00:58:02.203184 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-25 00:58:02.432478 | ubuntu-jammy -> localhost | ok 2026-09-25 00:58:02.444617 | 2026-09-25 00:58:02.444786 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-25 00:58:02.473895 | ubuntu-jammy | ok 2026-09-25 00:58:02.485952 | ubuntu-jammy | included: /var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-25 00:58:02.493245 | 2026-09-25 00:58:02.493324 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-25 00:58:03.667031 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2026-09-25 00:58:03.667271 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/a2e3a67340ca4d5497db48fbd1d7fd1c_id_rsa 2026-09-25 00:58:03.667309 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/a2e3a67340ca4d5497db48fbd1d7fd1c_id_rsa.pub 2026-09-25 00:58:03.667335 | ubuntu-jammy -> localhost | The key fingerprint is: 2026-09-25 00:58:03.667358 | ubuntu-jammy -> localhost | SHA256:VwoZQIslkncxpGns3o87FZB7O969HJEBoTZUMeJzd5Q zuul-build-sshkey 2026-09-25 00:58:03.667400 | ubuntu-jammy -> localhost | The key's randomart image is: 2026-09-25 00:58:03.667435 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2026-09-25 00:58:03.667464 | ubuntu-jammy -> localhost | | ...oB++.*o .. | 2026-09-25 00:58:03.667484 | ubuntu-jammy -> localhost | | .o.*+= = o .E | 2026-09-25 00:58:03.667503 | ubuntu-jammy -> localhost | | .*..oO . + . | 2026-09-25 00:58:03.667522 | ubuntu-jammy -> localhost | | o ..o= + + | 2026-09-25 00:58:03.667541 | ubuntu-jammy -> localhost | | . .Soo o | 2026-09-25 00:58:03.667559 | ubuntu-jammy -> localhost | | . . +. . | 2026-09-25 00:58:03.667577 | ubuntu-jammy -> localhost | | . .o o .. | 2026-09-25 00:58:03.667595 | ubuntu-jammy -> localhost | | .o. .... | 2026-09-25 00:58:03.667616 | ubuntu-jammy -> localhost | | oo. o. | 2026-09-25 00:58:03.667635 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2026-09-25 00:58:03.667695 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.733708 2026-09-25 00:58:03.672781 | 2026-09-25 00:58:03.672846 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-25 00:58:03.701996 | ubuntu-jammy | ok 2026-09-25 00:58:03.710144 | ubuntu-jammy | included: /var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-25 00:58:03.717322 | 2026-09-25 00:58:03.717389 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-25 00:58:03.741857 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:03.749576 | 2026-09-25 00:58:03.749680 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-25 00:58:04.198180 | ubuntu-jammy | changed 2026-09-25 00:58:04.204521 | 2026-09-25 00:58:04.204620 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-25 00:58:04.392080 | ubuntu-jammy | ok 2026-09-25 00:58:04.400248 | 2026-09-25 00:58:04.400332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-25 00:58:04.901514 | ubuntu-jammy | changed 2026-09-25 00:58:04.913899 | 2026-09-25 00:58:04.914174 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-25 00:58:05.407028 | ubuntu-jammy | changed 2026-09-25 00:58:05.417535 | 2026-09-25 00:58:05.417679 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-25 00:58:05.442703 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:05.453691 | 2026-09-25 00:58:05.453888 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-25 00:58:05.862963 | ubuntu-jammy -> localhost | changed 2026-09-25 00:58:05.871745 | 2026-09-25 00:58:05.871815 | TASK [add-build-sshkey : Add back temp key] 2026-09-25 00:58:06.159854 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/a2e3a67340ca4d5497db48fbd1d7fd1c_id_rsa (zuul-build-sshkey) 2026-09-25 00:58:06.160175 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.014953 2026-09-25 00:58:06.169743 | 2026-09-25 00:58:06.169888 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-25 00:58:06.499726 | ubuntu-jammy | ok 2026-09-25 00:58:06.509063 | 2026-09-25 00:58:06.509195 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-25 00:58:06.544780 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:06.562959 | 2026-09-25 00:58:06.563121 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-25 00:58:06.964319 | ubuntu-jammy | ok 2026-09-25 00:58:06.974096 | 2026-09-25 00:58:06.974880 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-25 00:58:07.778677 | ubuntu-jammy | Output suppressed because no_log was given 2026-09-25 00:58:07.800012 | 2026-09-25 00:58:07.800277 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-25 00:58:08.020542 | ubuntu-jammy | ok: "logs" 2026-09-25 00:58:08.020909 | ubuntu-jammy | ok: All items complete 2026-09-25 00:58:08.020968 | 2026-09-25 00:58:08.246566 | ubuntu-jammy | ok: "artifacts" 2026-09-25 00:58:08.371371 | ubuntu-jammy | ok: "docs" 2026-09-25 00:58:08.387573 | 2026-09-25 00:58:08.387785 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-25 00:58:08.595896 | ubuntu-jammy | changed: "logs" 2026-09-25 00:58:08.776126 | ubuntu-jammy | changed: "artifacts" 2026-09-25 00:58:08.938636 | ubuntu-jammy | changed: "docs" 2026-09-25 00:58:08.952759 | 2026-09-25 00:58:08.952954 | PLAY RECAP 2026-09-25 00:58:08.953064 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:58:08.953127 | ubuntu-jammy | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-25 00:58:08.953172 | 2026-09-25 00:58:09.098128 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-25 00:58:09.100061 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-25 00:58:09.659562 | 2026-09-25 00:58:09.659671 | PLAY [all] 2026-09-25 00:58:09.669706 | 2026-09-25 00:58:09.669789 | TASK [setup-uv : Extract archive] 2026-09-25 00:58:27.284067 | ubuntu-jammy | changed 2026-09-25 00:58:27.294792 | 2026-09-25 00:58:27.295117 | TASK [setup-uv : Print version] 2026-09-25 00:58:27.673010 | ubuntu-jammy | uv 0.8.13 2026-09-25 00:58:27.845775 | ubuntu-jammy | ok: Runtime: 0:00:00.013551 2026-09-25 00:58:27.863167 | 2026-09-25 00:58:27.863320 | TASK [Install Ansible collection siblings] 2026-09-25 00:58:28.271684 | ubuntu-jammy | ok: 2026-09-25 00:58:28.271904 | ubuntu-jammy | Skipping ansible.posix: no checked-out sibling 2026-09-25 00:58:28.271942 | ubuntu-jammy | Skipping community.general: no checked-out sibling 2026-09-25 00:58:28.273834 | 2026-09-25 00:58:28.273884 | PLAY RECAP 2026-09-25 00:58:28.273972 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:58:28.274012 | 2026-09-25 00:58:28.410596 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-25 00:58:28.412965 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-25 00:58:28.961258 | 2026-09-25 00:58:28.961379 | PLAY [all] 2026-09-25 00:58:28.971545 | 2026-09-25 00:58:28.971636 | LOOP [Check inventory directories] 2026-09-25 00:58:29.281828 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-09-25 00:58:29.431113 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/containerd/inventory" 2026-09-25 00:58:29.575002 | ubuntu-jammy | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/containerd/inventory" 2026-09-25 00:58:29.596841 | 2026-09-25 00:58:29.597055 | LOOP [Copy inventory file for Zuul] 2026-09-25 00:58:30.410308 | ubuntu-jammy | changed: 2026-09-25 00:58:30.410592 | ubuntu-jammy | { 2026-09-25 00:58:30.410647 | ubuntu-jammy | "ansible_loop_var": "item", 2026-09-25 00:58:30.410691 | ubuntu-jammy | "changed": false, 2026-09-25 00:58:30.410729 | ubuntu-jammy | "failed": false, 2026-09-25 00:58:30.410779 | ubuntu-jammy | "invocation": { 2026-09-25 00:58:30.410816 | ubuntu-jammy | "module_args": { 2026-09-25 00:58:30.410852 | ubuntu-jammy | "checksum_algorithm": "sha1", 2026-09-25 00:58:30.410885 | ubuntu-jammy | "follow": true, 2026-09-25 00:58:30.410919 | ubuntu-jammy | "get_attributes": true, 2026-09-25 00:58:30.410955 | ubuntu-jammy | "get_checksum": true, 2026-09-25 00:58:30.410989 | ubuntu-jammy | "get_mime": true, 2026-09-25 00:58:30.411023 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-09-25 00:58:30.411056 | ubuntu-jammy | } 2026-09-25 00:58:30.411089 | ubuntu-jammy | }, 2026-09-25 00:58:30.411122 | ubuntu-jammy | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-25 00:58:30.411171 | ubuntu-jammy | "stat": { 2026-09-25 00:58:30.411204 | ubuntu-jammy | "atime": 1790297887.666645, 2026-09-25 00:58:30.411237 | ubuntu-jammy | "attr_flags": "e", 2026-09-25 00:58:30.411270 | ubuntu-jammy | "attributes": [ 2026-09-25 00:58:30.411302 | ubuntu-jammy | "extents" 2026-09-25 00:58:30.411334 | ubuntu-jammy | ], 2026-09-25 00:58:30.411366 | ubuntu-jammy | "block_size": 4096, 2026-09-25 00:58:30.411398 | ubuntu-jammy | "blocks": 8, 2026-09-25 00:58:30.411430 | ubuntu-jammy | "charset": "unknown", 2026-09-25 00:58:30.411482 | ubuntu-jammy | "ctime": 1790297887.6746454, 2026-09-25 00:58:30.411517 | ubuntu-jammy | "dev": 64513, 2026-09-25 00:58:30.411549 | ubuntu-jammy | "device_type": 0, 2026-09-25 00:58:30.411582 | ubuntu-jammy | "executable": true, 2026-09-25 00:58:30.411614 | ubuntu-jammy | "exists": true, 2026-09-25 00:58:30.411646 | ubuntu-jammy | "gid": 1000, 2026-09-25 00:58:30.411677 | ubuntu-jammy | "gr_name": "zuul", 2026-09-25 00:58:30.411709 | ubuntu-jammy | "inode": 1043485, 2026-09-25 00:58:30.411741 | ubuntu-jammy | "isblk": false, 2026-09-25 00:58:30.411774 | ubuntu-jammy | "ischr": false, 2026-09-25 00:58:30.411807 | ubuntu-jammy | "isdir": true, 2026-09-25 00:58:30.411840 | ubuntu-jammy | "isfifo": false, 2026-09-25 00:58:30.411871 | ubuntu-jammy | "isgid": false, 2026-09-25 00:58:30.411915 | ubuntu-jammy | "islnk": false, 2026-09-25 00:58:30.411948 | ubuntu-jammy | "isreg": false, 2026-09-25 00:58:30.411979 | ubuntu-jammy | "issock": false, 2026-09-25 00:58:30.412011 | ubuntu-jammy | "isuid": false, 2026-09-25 00:58:30.412042 | ubuntu-jammy | "mimetype": "unknown", 2026-09-25 00:58:30.412074 | ubuntu-jammy | "mode": "0755", 2026-09-25 00:58:30.412105 | ubuntu-jammy | "mtime": 1790297873.6754215, 2026-09-25 00:58:30.412136 | ubuntu-jammy | "nlink": 11, 2026-09-25 00:58:30.412167 | ubuntu-jammy | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-25 00:58:30.412199 | ubuntu-jammy | "pw_name": "zuul", 2026-09-25 00:58:30.412235 | ubuntu-jammy | "readable": true, 2026-09-25 00:58:30.412268 | ubuntu-jammy | "rgrp": true, 2026-09-25 00:58:30.412301 | ubuntu-jammy | "roth": true, 2026-09-25 00:58:30.412333 | ubuntu-jammy | "rusr": true, 2026-09-25 00:58:30.412371 | ubuntu-jammy | "size": 4096, 2026-09-25 00:58:30.412481 | ubuntu-jammy | "uid": 1000, 2026-09-25 00:58:30.412591 | ubuntu-jammy | "version": "1629900874", 2026-09-25 00:58:30.412631 | ubuntu-jammy | "wgrp": false, 2026-09-25 00:58:30.412670 | ubuntu-jammy | "woth": false, 2026-09-25 00:58:30.412705 | ubuntu-jammy | "writeable": true, 2026-09-25 00:58:30.412738 | ubuntu-jammy | "wusr": true, 2026-09-25 00:58:30.412774 | ubuntu-jammy | "xgrp": true, 2026-09-25 00:58:30.412806 | ubuntu-jammy | "xoth": true, 2026-09-25 00:58:30.412838 | ubuntu-jammy | "xusr": true 2026-09-25 00:58:30.412869 | ubuntu-jammy | } 2026-09-25 00:58:30.412902 | ubuntu-jammy | } 2026-09-25 00:58:30.412971 | ubuntu-jammy | ok: All items complete 2026-09-25 00:58:30.413011 | 2026-09-25 00:58:30.415679 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:30.416874 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:30.433020 | 2026-09-25 00:58:30.433208 | LOOP [Switch "ansible_host" to private IP] 2026-09-25 00:58:30.798077 | ubuntu-jammy | changed: 1 replacements made 2026-09-25 00:58:30.801699 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:30.803418 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:30.819066 | 2026-09-25 00:58:30.819247 | TASK [Run Molecule scenario] 2026-09-25 00:58:31.474461 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-09-25 00:58:35.540848 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-09-25 00:58:35.740825 | ubuntu-jammy | Using CPython 3.13.7 2026-09-25 00:58:35.740928 | ubuntu-jammy | Creating virtual environment at: .venv 2026-09-25 00:58:36.262165 | ubuntu-jammy | Downloading cryptography (4.3MiB) 2026-09-25 00:58:36.263187 | ubuntu-jammy | Downloading pygments (1.2MiB) 2026-09-25 00:58:36.263475 | ubuntu-jammy | Downloading ansible-core (2.3MiB) 2026-09-25 00:58:36.424618 | ubuntu-jammy | Downloading cryptography 2026-09-25 00:58:36.472890 | ubuntu-jammy | Downloading pygments 2026-09-25 00:58:36.649097 | ubuntu-jammy | Downloading ansible-core 2026-09-25 00:58:36.694933 | ubuntu-jammy | Installed 36 packages in 45ms 2026-09-25 00:58:37.757815 | ubuntu-jammy | INFO Collection 'vexxhost.containers' detected. 2026-09-25 00:58:37.757912 | ubuntu-jammy | INFO Scenarios will be used from 'extensions/molecule' 2026-09-25 00:58:38.612274 | ubuntu-jammy | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-09-25 00:58:38.612367 | ubuntu-jammy | INFO default scenario not found, disabling shared state. 2026-09-25 00:58:38.612389 | ubuntu-jammy | INFO [containerd > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-25 00:58:38.612473 | ubuntu-jammy | INFO [containerd > prerun] Performing prerun with role_name_check=0... 2026-09-25 00:58:41.367154 | ubuntu-jammy | WARNING Retrying execution failure 1 of: ansible-galaxy collection install -vvv ansible.posix:>=1.6.0 2026-09-25 00:58:41.367265 | ubuntu-jammy | ERROR Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-09-25 00:58:41.367278 | ubuntu-jammy | Starting galaxy collection install process 2026-09-25 00:58:41.367288 | ubuntu-jammy | Process install dependency map 2026-09-25 00:58:41.367298 | ubuntu-jammy | 2026-09-25 00:58:41.367307 | ubuntu-jammy | ansible-galaxy 2026-09-25 00:58:41.367315 | ubuntu-jammy | config file = None 2026-09-25 00:58:41.367324 | ubuntu-jammy | configured module search path = 2026-09-25 00:58:41.367334 | 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:58:41.367344 | 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:58:41.367360 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-09-25 00:58:41.367369 | 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:58:41.367378 | ubuntu-jammy | jinja version = 3.1.6 2026-09-25 00:58:41.367387 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-09-25 00:58:41.367396 | ubuntu-jammy | No config file found; using defaults 2026-09-25 00:58:41.367406 | 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:58:41.367415 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-09-25 00:58:41.367428 | 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/': 2026-09-25 00:58:41.367441 | ubuntu-jammy | : Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/': 2026-09-25 00:58:41.367451 | ubuntu-jammy | 2026-09-25 00:58:41.367459 | ubuntu-jammy | Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/'. 2026-09-25 00:58:41.367468 | ubuntu-jammy | 2026-09-25 00:58:41.367476 | ubuntu-jammy | <<< caused by >>> 2026-09-25 00:58:41.367485 | ubuntu-jammy | 2026-09-25 00:58:41.367494 | ubuntu-jammy | 2026-09-25 00:58:41.367502 | ubuntu-jammy | 2026-09-25 00:58:41.367511 | ubuntu-jammy | 2026-09-25 00:58:41.370614 | ubuntu-jammy | Traceback (most recent call last): 2026-09-25 00:58:41.373948 | ubuntu-jammy | File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in 2026-09-25 00:58:41.373974 | ubuntu-jammy | sys.exit(main()) 2026-09-25 00:58:41.373983 | ubuntu-jammy | ~~~~^^ 2026-09-25 00:58:41.374275 | 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:58:41.374289 | ubuntu-jammy | return self.main(*args, **kwargs) 2026-09-25 00:58:41.374297 | ubuntu-jammy | ~~~~~~~~~^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.374519 | 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:58:41.374530 | ubuntu-jammy | rv = self.invoke(ctx) 2026-09-25 00:58:41.374782 | 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:58:41.374792 | ubuntu-jammy | return _process_result(sub_ctx.command.invoke(sub_ctx)) 2026-09-25 00:58:41.374802 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^ 2026-09-25 00:58:41.375049 | 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:58:41.375059 | ubuntu-jammy | return ctx.invoke(self.callback, **ctx.params) 2026-09-25 00:58:41.375067 | ubuntu-jammy | ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.375306 | 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:58:41.375317 | ubuntu-jammy | return callback(*args, **kwargs) 2026-09-25 00:58:41.375517 | 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:58:41.375527 | ubuntu-jammy | return func(*args, **kwargs) 2026-09-25 00:58:41.375775 | 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:58:41.375790 | ubuntu-jammy | return f(get_current_context(), *args, **kwargs) 2026-09-25 00:58:41.376017 | 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:58:41.376028 | ubuntu-jammy | return func(ctx) 2026-09-25 00:58:41.376460 | 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:58:41.376472 | ubuntu-jammy | base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude) 2026-09-25 00:58:41.376484 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.376756 | 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:58:41.376766 | ubuntu-jammy | _run_scenarios(scenarios, command_args, default_config) 2026-09-25 00:58:41.376774 | ubuntu-jammy | ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.377201 | 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:58:41.377211 | ubuntu-jammy | scenario.config.runtime.prepare_environment( 2026-09-25 00:58:41.377220 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^ 2026-09-25 00:58:41.377229 | ubuntu-jammy | install_local=True, 2026-09-25 00:58:41.377237 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.377246 | ubuntu-jammy | role_name_check=role_name_check, 2026-09-25 00:58:41.377254 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.377263 | ubuntu-jammy | ) 2026-09-25 00:58:41.377271 | ubuntu-jammy | ^ 2026-09-25 00:58:41.377640 | 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:58:41.377663 | ubuntu-jammy | self.install_collection( 2026-09-25 00:58:41.377671 | ubuntu-jammy | ~~~~~~~~~~~~~~~~~~~~~~~^ 2026-09-25 00:58:41.377680 | ubuntu-jammy | f"{name}{',' if is_url(name) else ':'}{required_version}", 2026-09-25 00:58:41.377688 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.377697 | ubuntu-jammy | destination=destination, 2026-09-25 00:58:41.377705 | ubuntu-jammy | ^^^^^^^^^^^^^^^^^^^^^^^^ 2026-09-25 00:58:41.377713 | ubuntu-jammy | ) 2026-09-25 00:58:41.377722 | ubuntu-jammy | ^ 2026-09-25 00:58:41.377857 | 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:58:41.377867 | ubuntu-jammy | raise InvalidPrerequisiteError(msg) 2026-09-25 00:58:41.378953 | ubuntu-jammy | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code: 2026-09-25 00:58:41.378965 | ubuntu-jammy | Starting galaxy collection install process 2026-09-25 00:58:41.378974 | ubuntu-jammy | Process install dependency map 2026-09-25 00:58:41.378983 | ubuntu-jammy | 2026-09-25 00:58:41.378991 | ubuntu-jammy | ansible-galaxy [core 2.19.1] 2026-09-25 00:58:41.379000 | ubuntu-jammy | config file = None 2026-09-25 00:58:41.379008 | ubuntu-jammy | configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-09-25 00:58:41.379017 | 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:58:41.379026 | 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:58:41.379034 | ubuntu-jammy | executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy 2026-09-25 00:58:41.379043 | 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:58:41.379051 | ubuntu-jammy | jinja version = 3.1.6 2026-09-25 00:58:41.379060 | ubuntu-jammy | pyyaml version = 6.0.2 (with libyaml v0.2.5) 2026-09-25 00:58:41.379068 | ubuntu-jammy | No config file found; using defaults 2026-09-25 00:58:41.379077 | 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:58:41.379085 | ubuntu-jammy | Created /home/zuul/.ansible/galaxy_token 2026-09-25 00:58:41.379100 | 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/': 2026-09-25 00:58:41.379110 | ubuntu-jammy | [ERROR]: Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/': 2026-09-25 00:58:41.379119 | ubuntu-jammy | 2026-09-25 00:58:41.379128 | ubuntu-jammy | Unknown error when attempting to call Galaxy at 'https://galaxy.ansible.com/api/v3/collections/ansible/posix/'. 2026-09-25 00:58:41.379152 | ubuntu-jammy | 2026-09-25 00:58:41.379161 | ubuntu-jammy | <<< caused by >>> 2026-09-25 00:58:41.379170 | ubuntu-jammy | 2026-09-25 00:58:41.379179 | ubuntu-jammy | 2026-09-25 00:58:41.379188 | ubuntu-jammy | 2026-09-25 00:58:41.379197 | ubuntu-jammy | 2026-09-25 00:58:41.887366 | ubuntu-jammy | ERROR 2026-09-25 00:58:41.887615 | ubuntu-jammy | { 2026-09-25 00:58:41.887654 | ubuntu-jammy | "delta": "0:00:10.263693", 2026-09-25 00:58:41.887680 | ubuntu-jammy | "end": "2026-09-25 00:58:41.475984", 2026-09-25 00:58:41.887703 | ubuntu-jammy | "msg": "non-zero return code", 2026-09-25 00:58:41.887728 | ubuntu-jammy | "rc": 1, 2026-09-25 00:58:41.887752 | ubuntu-jammy | "start": "2026-09-25 00:58:31.212291" 2026-09-25 00:58:41.887775 | ubuntu-jammy | } failure 2026-09-25 00:58:41.890849 | 2026-09-25 00:58:41.890907 | PLAY RECAP 2026-09-25 00:58:41.890958 | ubuntu-jammy | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-25 00:58:41.890984 | 2026-09-25 00:58:42.000458 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-25 00:58:42.002655 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 00:58:42.567144 | 2026-09-25 00:58:42.567251 | PLAY [all] 2026-09-25 00:58:42.577327 | 2026-09-25 00:58:42.577409 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-25 00:58:42.641370 | ubuntu-jammy | skipping: Conditional result was False 2026-09-25 00:58:42.648016 | 2026-09-25 00:58:42.648132 | TASK [fetch-output : Set log path for single node] 2026-09-25 00:58:42.691157 | ubuntu-jammy | ok 2026-09-25 00:58:42.700064 | 2026-09-25 00:58:42.700288 | LOOP [fetch-output : Ensure local output dirs] 2026-09-25 00:58:43.178881 | ubuntu-jammy -> localhost | ok: "/var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/logs" 2026-09-25 00:58:43.400873 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/artifacts" 2026-09-25 00:58:43.592570 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/a2e3a67340ca4d5497db48fbd1d7fd1c/work/docs" 2026-09-25 00:58:43.605596 | 2026-09-25 00:58:43.605695 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-25 00:58:44.226914 | ubuntu-jammy | ok 2026-09-25 00:58:44.227196 | ubuntu-jammy | changed: All items complete 2026-09-25 00:58:44.227248 | 2026-09-25 00:58:44.713109 | ubuntu-jammy | changed: .d..t...... ./ 2026-09-25 00:58:45.212336 | ubuntu-jammy | changed: .d..t...... ./ 2026-09-25 00:58:45.237384 | 2026-09-25 00:58:45.237644 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-25 00:58:45.760706 | ubuntu-jammy -> localhost | ok: Item: artifacts Runtime: 0:00:00.007933 2026-09-25 00:58:45.996923 | ubuntu-jammy -> localhost | ok: Item: docs Runtime: 0:00:00.007021 2026-09-25 00:58:46.021070 | 2026-09-25 00:58:46.021275 | PLAY [all] 2026-09-25 00:58:46.037035 | 2026-09-25 00:58:46.037268 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-25 00:58:46.466773 | ubuntu-jammy | changed 2026-09-25 00:58:46.477621 | 2026-09-25 00:58:46.477721 | PLAY RECAP 2026-09-25 00:58:46.477809 | ubuntu-jammy | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-25 00:58:46.477891 | 2026-09-25 00:58:46.594161 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-25 00:58:46.595937 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-25 00:58:47.111606 | 2026-09-25 00:58:47.111758 | PLAY [localhost] 2026-09-25 00:58:47.122164 | 2026-09-25 00:58:47.122277 | TASK [Generate Zuul manifest] 2026-09-25 00:58:47.140104 | localhost | ok 2026-09-25 00:58:47.153789 | 2026-09-25 00:58:47.153902 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-25 00:58:47.532154 | localhost | changed 2026-09-25 00:58:47.547416 | 2026-09-25 00:58:47.547641 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-25 00:58:47.578979 | localhost | ok 2026-09-25 00:58:47.588270 | 2026-09-25 00:58:47.588454 | TASK [Upload logs] 2026-09-25 00:58:47.609665 | localhost | ok 2026-09-25 00:58:47.681720 | 2026-09-25 00:58:47.681915 | TASK [Set zuul-log-path fact] 2026-09-25 00:58:47.701269 | localhost | ok 2026-09-25 00:58:47.712770 | 2026-09-25 00:58:47.712942 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-25 00:58:47.743631 | localhost | ok 2026-09-25 00:58:47.752791 | 2026-09-25 00:58:47.752971 | TASK [upload-logs : Create log directories] 2026-09-25 00:58:48.171263 | localhost | changed 2026-09-25 00:58:48.180301 | 2026-09-25 00:58:48.180548 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-25 00:58:48.601435 | localhost -> localhost | ok: Runtime: 0:00:00.004414 2026-09-25 00:58:48.611910 | 2026-09-25 00:58:48.612145 | TASK [upload-logs : Upload logs to log server] 2026-09-25 00:58:49.091907 | localhost | Output suppressed because no_log was given 2026-09-25 00:58:49.099807 | 2026-09-25 00:58:49.099955 | LOOP [upload-logs : Compress console log and json output] 2026-09-25 00:58:49.163556 | localhost | skipping: Conditional result was False 2026-09-25 00:58:49.173079 | localhost | skipping: Conditional result was False 2026-09-25 00:58:49.186219 | 2026-09-25 00:58:49.186508 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-25 00:58:49.229811 | localhost | skipping: Conditional result was False 2026-09-25 00:58:49.230185 | 2026-09-25 00:58:49.233401 | localhost | skipping: Conditional result was False 2026-09-25 00:58:49.252782 | 2026-09-25 00:58:49.253056 | LOOP [upload-logs : Upload console log and json output]