2026-08-31 06:10:57.625899 | Job console starting
2026-08-31 06:10:57.634552 | Updating git repos
2026-08-31 06:10:57.660505 | Cloning repos into workspace
2026-08-31 06:10:57.693370 | Restoring repo states
2026-08-31 06:10:57.702325 | Merging changes
2026-08-31 06:10:58.284018 | Checking out repos
2026-08-31 06:10:58.398049 | Preparing playbooks
2026-08-31 06:10:59.667040 | Running Ansible setup
2026-08-31 06:11:04.624226 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-31 06:11:05.214022 | 
2026-08-31 06:11:05.214147 | PLAY [localhost]
2026-08-31 06:11:05.221524 | 
2026-08-31 06:11:05.221593 | TASK [Gathering Facts]
2026-08-31 06:11:06.113244 | localhost | ok
2026-08-31 06:11:06.120011 | 
2026-08-31 06:11:06.120088 | TASK [Setup log path fact]
2026-08-31 06:11:06.140836 | localhost | ok
2026-08-31 06:11:06.154518 | 
2026-08-31 06:11:06.154636 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-31 06:11:06.187255 | localhost | ok
2026-08-31 06:11:06.194860 | 
2026-08-31 06:11:06.194934 | TASK [emit-job-header : Print job information]
2026-08-31 06:11:06.235738 | # Job Information
2026-08-31 06:11:06.235931 | Ansible Version: 2.16.18
2026-08-31 06:11:06.235975 | Job: ansible-collection-containers-molecule-docker-upgrade-ubuntu-noble
2026-08-31 06:11:06.236104 | Pipeline: check
2026-08-31 06:11:06.236152 | Executor: 2d72f0692154
2026-08-31 06:11:06.236182 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/118
2026-08-31 06:11:06.236218 | Event ID: fc1ad3ee-a501-11f1-8ef4-58280a091ed8
2026-08-31 06:11:06.240214 | 
2026-08-31 06:11:06.240308 | LOOP [emit-job-header : Print node information]
2026-08-31 06:11:06.341961 | localhost | ok:
2026-08-31 06:11:06.342276 | localhost | # Node Information
2026-08-31 06:11:06.342331 | localhost | Inventory Hostname: ubuntu-noble
2026-08-31 06:11:06.342364 | localhost | Hostname: np0000191472
2026-08-31 06:11:06.342393 | localhost | Username: zuul
2026-08-31 06:11:06.342426 | localhost | Distro: Ubuntu 24.04
2026-08-31 06:11:06.342456 | localhost | Provider: yul1
2026-08-31 06:11:06.342484 | localhost | Region: ca-ymq-1
2026-08-31 06:11:06.342512 | localhost | Label: ubuntu-noble
2026-08-31 06:11:06.342539 | localhost | Product Name: OpenStack Nova
2026-08-31 06:11:06.342565 | localhost | Interface IP: 162.253.55.68
2026-08-31 06:11:06.363820 | 
2026-08-31 06:11:06.363971 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-31 06:11:06.772339 | localhost -> localhost | changed
2026-08-31 06:11:06.779161 | 
2026-08-31 06:11:06.779244 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-31 06:11:07.625519 | localhost -> localhost | changed
2026-08-31 06:11:07.636077 | 
2026-08-31 06:11:07.636157 | PLAY [all]
2026-08-31 06:11:07.645384 | 
2026-08-31 06:11:07.645454 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-31 06:11:07.881043 | ubuntu-noble -> localhost | ok
2026-08-31 06:11:07.887869 | 
2026-08-31 06:11:07.887945 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-31 06:11:07.924059 | ubuntu-noble | ok
2026-08-31 06:11:07.939360 | ubuntu-noble | included: /var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-31 06:11:07.945454 | 
2026-08-31 06:11:07.945517 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-31 06:11:09.075655 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-08-31 06:11:09.075878 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/e988a7ed74f24a39928eadaecebd3608_id_rsa
2026-08-31 06:11:09.075930 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/e988a7ed74f24a39928eadaecebd3608_id_rsa.pub
2026-08-31 06:11:09.075960 | ubuntu-noble -> localhost | The key fingerprint is:
2026-08-31 06:11:09.075983 | ubuntu-noble -> localhost | SHA256:oh2OL4ACgmHPHX9DwDLqTf+fSKSd1XRc7zZ6k0W+Ifo zuul-build-sshkey
2026-08-31 06:11:09.076037 | ubuntu-noble -> localhost | The key's randomart image is:
2026-08-31 06:11:09.076062 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-08-31 06:11:09.076110 | ubuntu-noble -> localhost | |      ...       .|
2026-08-31 06:11:09.076136 | ubuntu-noble -> localhost | |..   + . .    . o|
2026-08-31 06:11:09.076174 | ubuntu-noble -> localhost | |o.o o = .    . oo|
2026-08-31 06:11:09.076200 | ubuntu-noble -> localhost | |+  + o . o  o .+ |
2026-08-31 06:11:09.076220 | ubuntu-noble -> localhost | |o.. o + S... o o=|
2026-08-31 06:11:09.076893 | ubuntu-noble -> localhost | |o .. * ++ o . o.*|
2026-08-31 06:11:09.076921 | ubuntu-noble -> localhost | |.  .o o..+ . . = |
2026-08-31 06:11:09.076943 | ubuntu-noble -> localhost | |    ..  ... o . .|
2026-08-31 06:11:09.077050 | ubuntu-noble -> localhost | |     ..  ..o E   |
2026-08-31 06:11:09.077074 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-08-31 06:11:09.077124 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.722740
2026-08-31 06:11:09.082737 | 
2026-08-31 06:11:09.083380 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-31 06:11:09.117101 | ubuntu-noble | ok
2026-08-31 06:11:09.129243 | ubuntu-noble | included: /var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-31 06:11:09.145094 | 
2026-08-31 06:11:09.148391 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-31 06:11:09.173669 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:09.181601 | 
2026-08-31 06:11:09.181664 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-31 06:11:09.798939 | ubuntu-noble | changed
2026-08-31 06:11:09.804580 | 
2026-08-31 06:11:09.804646 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-31 06:11:10.036746 | ubuntu-noble | ok
2026-08-31 06:11:10.051244 | 
2026-08-31 06:11:10.051419 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-31 06:11:10.682463 | ubuntu-noble | changed
2026-08-31 06:11:10.690900 | 
2026-08-31 06:11:10.690991 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-31 06:11:11.328303 | ubuntu-noble | changed
2026-08-31 06:11:11.334974 | 
2026-08-31 06:11:11.335045 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-31 06:11:11.360874 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:11.371059 | 
2026-08-31 06:11:11.371148 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-31 06:11:11.718320 | ubuntu-noble -> localhost | changed
2026-08-31 06:11:11.733164 | 
2026-08-31 06:11:11.733258 | TASK [add-build-sshkey : Add back temp key]
2026-08-31 06:11:12.044419 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/e988a7ed74f24a39928eadaecebd3608_id_rsa (zuul-build-sshkey)
2026-08-31 06:11:12.044668 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012909
2026-08-31 06:11:12.053869 | 
2026-08-31 06:11:12.053941 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-31 06:11:12.414506 | ubuntu-noble | ok
2026-08-31 06:11:12.420919 | 
2026-08-31 06:11:12.421059 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-31 06:11:12.446067 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:12.462294 | 
2026-08-31 06:11:12.462356 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-31 06:11:12.831876 | ubuntu-noble | ok
2026-08-31 06:11:12.878158 | 
2026-08-31 06:11:12.878296 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-31 06:11:13.668619 | ubuntu-noble | Output suppressed because no_log was given
2026-08-31 06:11:13.682160 | 
2026-08-31 06:11:13.682230 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-31 06:11:13.930822 | ubuntu-noble | ok: "logs"
2026-08-31 06:11:13.931116 | ubuntu-noble | ok: All items complete
2026-08-31 06:11:13.931145 | 
2026-08-31 06:11:14.136847 | ubuntu-noble | ok: "artifacts"
2026-08-31 06:11:14.314902 | ubuntu-noble | ok: "docs"
2026-08-31 06:11:14.333595 | 
2026-08-31 06:11:14.333823 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-31 06:11:14.565184 | ubuntu-noble | changed: "logs"
2026-08-31 06:11:14.750408 | ubuntu-noble | changed: "artifacts"
2026-08-31 06:11:14.940496 | ubuntu-noble | changed: "docs"
2026-08-31 06:11:14.962264 | 
2026-08-31 06:11:14.962399 | PLAY RECAP
2026-08-31 06:11:14.962450 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-31 06:11:14.962482 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-31 06:11:14.962503 | 
2026-08-31 06:11:15.105062 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-31 06:11:15.106487 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-31 06:11:15.725451 | 
2026-08-31 06:11:15.725592 | PLAY [all]
2026-08-31 06:11:15.737463 | 
2026-08-31 06:11:15.737537 | TASK [setup-uv : Extract archive]
2026-08-31 06:11:18.234484 | ubuntu-noble | changed
2026-08-31 06:11:18.241338 | 
2026-08-31 06:11:18.241425 | TASK [setup-uv : Print version]
2026-08-31 06:11:18.651870 | ubuntu-noble | uv 0.8.13
2026-08-31 06:11:18.785694 | ubuntu-noble | ok: Runtime: 0:00:00.020024
2026-08-31 06:11:18.797703 | 
2026-08-31 06:11:18.797768 | TASK [Install Ansible collection siblings]
2026-08-31 06:11:19.255021 | ubuntu-noble | ok:
2026-08-31 06:11:19.255209 | ubuntu-noble | Skipping ansible.posix: no checked-out sibling
2026-08-31 06:11:19.255248 | ubuntu-noble | Skipping community.general: no checked-out sibling
2026-08-31 06:11:19.257142 | 
2026-08-31 06:11:19.257231 | PLAY RECAP
2026-08-31 06:11:19.257288 | ubuntu-noble | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-31 06:11:19.257319 | 
2026-08-31 06:11:19.381988 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-31 06:11:19.384439 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-31 06:11:19.980479 | 
2026-08-31 06:11:19.980616 | PLAY [all]
2026-08-31 06:11:19.992593 | 
2026-08-31 06:11:19.992667 | LOOP [Check inventory directories]
2026-08-31 06:11:20.335990 | ubuntu-noble | ok: "src/github.com/vexxhost/ansible-collection-containers"
2026-08-31 06:11:20.534804 | ubuntu-noble | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/docker-upgrade/inventory"
2026-08-31 06:11:20.715319 | ubuntu-noble | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/inventory"
2026-08-31 06:11:20.734964 | 
2026-08-31 06:11:20.735151 | LOOP [Copy inventory file for Zuul]
2026-08-31 06:11:21.764534 | ubuntu-noble | changed:
2026-08-31 06:11:21.764785 | ubuntu-noble | {
2026-08-31 06:11:21.764837 | ubuntu-noble |   "ansible_loop_var": "item",
2026-08-31 06:11:21.764872 | ubuntu-noble |   "changed": false,
2026-08-31 06:11:21.764901 | ubuntu-noble |   "failed": false,
2026-08-31 06:11:21.764938 | ubuntu-noble |   "invocation": {
2026-08-31 06:11:21.765003 | ubuntu-noble |     "module_args": {
2026-08-31 06:11:21.765033 | ubuntu-noble |       "checksum_algorithm": "sha1",
2026-08-31 06:11:21.765058 | ubuntu-noble |       "follow": true,
2026-08-31 06:11:21.765084 | ubuntu-noble |       "get_attributes": true,
2026-08-31 06:11:21.765111 | ubuntu-noble |       "get_checksum": true,
2026-08-31 06:11:21.765137 | ubuntu-noble |       "get_mime": true,
2026-08-31 06:11:21.765162 | ubuntu-noble |       "path": "src/github.com/vexxhost/ansible-collection-containers"
2026-08-31 06:11:21.765187 | ubuntu-noble |     }
2026-08-31 06:11:21.765212 | ubuntu-noble |   },
2026-08-31 06:11:21.765248 | ubuntu-noble |   "item": "src/github.com/vexxhost/ansible-collection-containers",
2026-08-31 06:11:21.765286 | ubuntu-noble |   "stat": {
2026-08-31 06:11:21.765313 | ubuntu-noble |     "atime": 1788156673.5490499,
2026-08-31 06:11:21.765339 | ubuntu-noble |     "attr_flags": "e",
2026-08-31 06:11:21.765377 | ubuntu-noble |     "attributes": [
2026-08-31 06:11:21.765403 | ubuntu-noble |       "extents"
2026-08-31 06:11:21.765428 | ubuntu-noble |     ],
2026-08-31 06:11:21.765452 | ubuntu-noble |     "block_size": 4096,
2026-08-31 06:11:21.765476 | ubuntu-noble |     "blocks": 8,
2026-08-31 06:11:21.765500 | ubuntu-noble |     "charset": "unknown",
2026-08-31 06:11:21.765526 | ubuntu-noble |     "ctime": 1788156673.5660505,
2026-08-31 06:11:21.765551 | ubuntu-noble |     "dev": 64769,
2026-08-31 06:11:21.765575 | ubuntu-noble |     "device_type": 0,
2026-08-31 06:11:21.765600 | ubuntu-noble |     "executable": true,
2026-08-31 06:11:21.765635 | ubuntu-noble |     "exists": true,
2026-08-31 06:11:21.765661 | ubuntu-noble |     "gid": 1000,
2026-08-31 06:11:21.765686 | ubuntu-noble |     "gr_name": "zuul",
2026-08-31 06:11:21.765710 | ubuntu-noble |     "inode": 1034272,
2026-08-31 06:11:21.765734 | ubuntu-noble |     "isblk": false,
2026-08-31 06:11:21.765759 | ubuntu-noble |     "ischr": false,
2026-08-31 06:11:21.765783 | ubuntu-noble |     "isdir": true,
2026-08-31 06:11:21.765808 | ubuntu-noble |     "isfifo": false,
2026-08-31 06:11:21.765832 | ubuntu-noble |     "isgid": false,
2026-08-31 06:11:21.765856 | ubuntu-noble |     "islnk": false,
2026-08-31 06:11:21.765880 | ubuntu-noble |     "isreg": false,
2026-08-31 06:11:21.765904 | ubuntu-noble |     "issock": false,
2026-08-31 06:11:21.765938 | ubuntu-noble |     "isuid": false,
2026-08-31 06:11:21.765963 | ubuntu-noble |     "mimetype": "unknown",
2026-08-31 06:11:21.765987 | ubuntu-noble |     "mode": "0755",
2026-08-31 06:11:21.766010 | ubuntu-noble |     "mtime": 1788156658.2523224,
2026-08-31 06:11:21.766034 | ubuntu-noble |     "nlink": 11,
2026-08-31 06:11:21.766058 | ubuntu-noble |     "path": "src/github.com/vexxhost/ansible-collection-containers",
2026-08-31 06:11:21.766083 | ubuntu-noble |     "pw_name": "zuul",
2026-08-31 06:11:21.766118 | ubuntu-noble |     "readable": true,
2026-08-31 06:11:21.766144 | ubuntu-noble |     "rgrp": true,
2026-08-31 06:11:21.766169 | ubuntu-noble |     "roth": true,
2026-08-31 06:11:21.766193 | ubuntu-noble |     "rusr": true,
2026-08-31 06:11:21.766217 | ubuntu-noble |     "size": 4096,
2026-08-31 06:11:21.766241 | ubuntu-noble |     "uid": 1000,
2026-08-31 06:11:21.766266 | ubuntu-noble |     "version": "3473626359",
2026-08-31 06:11:21.766290 | ubuntu-noble |     "wgrp": false,
2026-08-31 06:11:21.766326 | ubuntu-noble |     "woth": false,
2026-08-31 06:11:21.766352 | ubuntu-noble |     "writeable": true,
2026-08-31 06:11:21.766377 | ubuntu-noble |     "wusr": true,
2026-08-31 06:11:21.766401 | ubuntu-noble |     "xgrp": true,
2026-08-31 06:11:21.766424 | ubuntu-noble |     "xoth": true,
2026-08-31 06:11:21.766448 | ubuntu-noble |     "xusr": true
2026-08-31 06:11:21.766471 | ubuntu-noble |   }
2026-08-31 06:11:21.766494 | ubuntu-noble | }
2026-08-31 06:11:21.766544 | ubuntu-noble | ok: All items complete
2026-08-31 06:11:21.766574 | 
2026-08-31 06:11:21.768263 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:21.768864 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:21.783955 | 
2026-08-31 06:11:21.784103 | LOOP [Switch "ansible_host" to private IP]
2026-08-31 06:11:22.200444 | ubuntu-noble | changed: 1 replacements made
2026-08-31 06:11:22.202246 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:22.203105 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:11:22.229695 | 
2026-08-31 06:11:22.229864 | TASK [Run Molecule scenario]
2026-08-31 06:11:22.720997 | ubuntu-noble | Using CPython 3.12.3 interpreter at: /usr/bin/python3
2026-08-31 06:11:22.721111 | ubuntu-noble | Creating virtual environment at: .venv
2026-08-31 06:11:22.995402 | ubuntu-noble | Downloading ansible-core (2.3MiB)
2026-08-31 06:11:22.999863 | ubuntu-noble | Downloading cryptography (4.3MiB)
2026-08-31 06:11:23.000107 | ubuntu-noble | Downloading pygments (1.2MiB)
2026-08-31 06:11:23.185279 | ubuntu-noble |  Downloading cryptography
2026-08-31 06:11:23.242671 | ubuntu-noble |  Downloading pygments
2026-08-31 06:11:23.407320 | ubuntu-noble |  Downloading ansible-core
2026-08-31 06:11:23.478020 | ubuntu-noble | Installed 37 packages in 69ms
2026-08-31 06:11:24.278829 | ubuntu-noble | INFO     Collection 'vexxhost.containers' detected.
2026-08-31 06:11:24.278924 | ubuntu-noble | INFO     Scenarios will be used from 'extensions/molecule'
2026-08-31 06:11:25.171984 | ubuntu-noble | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-08-31 06:11:25.172080 | ubuntu-noble | INFO     default scenario not found, disabling shared state.
2026-08-31 06:11:25.172093 | ubuntu-noble | INFO     [docker-upgrade > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-31 06:11:25.172187 | ubuntu-noble | INFO     [docker-upgrade > prerun] Performing prerun with role_name_check=0...
2026-08-31 06:12:38.911424 | ubuntu-noble | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv ansible.posix:>=1.6.0
2026-08-31 06:12:38.911617 | ubuntu-noble | ERROR    Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code:
2026-08-31 06:12:38.911633 | ubuntu-noble | Starting galaxy collection install process
2026-08-31 06:12:38.911645 | ubuntu-noble | Process install dependency map
2026-08-31 06:12:38.911657 | ubuntu-noble | Starting collection install process
2026-08-31 06:12:38.911682 | ubuntu-noble | 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-1137sw9ng9n_/tmp2pt1nflx/ansible-posix-2.2.2-peerbmcx
2026-08-31 06:12:38.911703 | ubuntu-noble |
2026-08-31 06:12:38.911715 | ubuntu-noble | ansible-galaxy
2026-08-31 06:12:38.911726 | ubuntu-noble |   config file = None
2026-08-31 06:12:38.911737 | ubuntu-noble |   configured module search path =
2026-08-31 06:12:38.911748 | ubuntu-noble |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible
2026-08-31 06:12:38.911767 | ubuntu-noble |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/local/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages
2026-08-31 06:12:38.911781 | ubuntu-noble |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-08-31 06:12:38.911811 | ubuntu-noble |   python version = 3.12.3 (main, Jul 15 2026, 23:46:41)  (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-08-31 06:12:38.911822 | ubuntu-noble |   jinja version = 3.1.6
2026-08-31 06:12:38.911833 | ubuntu-noble |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-31 06:12:38.911845 | ubuntu-noble | No config file found; using defaults
2026-08-31 06:12:38.911862 | ubuntu-noble | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-08-31 06:12:38.911874 | ubuntu-noble | Created /home/zuul/.ansible/galaxy_token
2026-08-31 06:12:38.911885 | ubuntu-noble | : Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out
2026-08-31 06:12:38.911896 | ubuntu-noble |
2026-08-31 06:12:38.911907 | ubuntu-noble | Traceback (most recent call last):
2026-08-31 06:12:38.911923 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in <module>
2026-08-31 06:12:38.912299 | ubuntu-noble |     sys.exit(main())
2026-08-31 06:12:38.912607 | ubuntu-noble |              ^^^^^^
2026-08-31 06:12:38.912834 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/core.py", line 1442, in __call__
2026-08-31 06:12:38.913688 | ubuntu-noble |     return self.main(*args, **kwargs)
2026-08-31 06:12:38.913929 | ubuntu-noble |            ^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.914159 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/core.py", line 1363, in main
2026-08-31 06:12:38.914916 | ubuntu-noble |     rv = self.invoke(ctx)
2026-08-31 06:12:38.915136 | ubuntu-noble |          ^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.915384 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/core.py", line 1830, in invoke
2026-08-31 06:12:38.916284 | ubuntu-noble |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-08-31 06:12:38.916527 | ubuntu-noble |                            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.916742 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/core.py", line 1226, in invoke
2026-08-31 06:12:38.917391 | ubuntu-noble |     return ctx.invoke(self.callback, **ctx.params)
2026-08-31 06:12:38.917926 | ubuntu-noble |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.918136 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/core.py", line 794, in invoke
2026-08-31 06:12:38.918746 | ubuntu-noble |     return callback(*args, **kwargs)
2026-08-31 06:12:38.918973 | ubuntu-noble |            ^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.919173 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/molecule/click_cfg.py", line 583, in wrapper
2026-08-31 06:12:38.919687 | ubuntu-noble |     return func(*args, **kwargs)
2026-08-31 06:12:38.919956 | ubuntu-noble |            ^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.920162 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/click/decorators.py", line 34, in new_func
2026-08-31 06:12:38.920540 | ubuntu-noble |     return f(get_current_context(), *args, **kwargs)
2026-08-31 06:12:38.920886 | ubuntu-noble |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-08-31 06:12:38.921093 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/molecule/click_cfg.py", line 418, in wrapper
2026-08-31 06:12:38.921672 | ubuntu-noble |     return func(ctx)
2026-08-31 06:12:38.921866 | ubuntu-noble |            ^^^^^^^^^
2026-08-31 06:12:38.922066 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/molecule/command/test.py", line 81, in test
2026-08-31 06:12:38.922380 | ubuntu-noble |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-08-31 06:12:38.922748 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios
2026-08-31 06:12:38.923055 | ubuntu-noble |     _run_scenarios(scenarios, command_args, default_config)
2026-08-31 06:12:38.923300 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/molecule/command/base.py", line 240, in _run_scenarios
2026-08-31 06:12:38.923689 | ubuntu-noble |     scenario.config.runtime.prepare_environment(
2026-08-31 06:12:38.923908 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible_compat/runtime.py", line 752, in prepare_environment
2026-08-31 06:12:38.924370 | ubuntu-noble |     self.install_collection(
2026-08-31 06:12:38.924623 | ubuntu-noble |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible_compat/runtime.py", line 609, in install_collection
2026-08-31 06:12:38.925051 | ubuntu-noble |     raise InvalidPrerequisiteError(msg)
2026-08-31 06:12:38.926358 | ubuntu-noble | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv ansible.posix:>=1.6.0, returned 1 code:
2026-08-31 06:12:38.926389 | ubuntu-noble | Starting galaxy collection install process
2026-08-31 06:12:38.926397 | ubuntu-noble | Process install dependency map
2026-08-31 06:12:38.926406 | ubuntu-noble | Starting collection install process
2026-08-31 06:12:38.926414 | ubuntu-noble | 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-1137sw9ng9n_/tmp2pt1nflx/ansible-posix-2.2.2-peerbmcx
2026-08-31 06:12:38.926422 | ubuntu-noble |
2026-08-31 06:12:38.926440 | ubuntu-noble | ansible-galaxy [core 2.19.1]
2026-08-31 06:12:38.926472 | ubuntu-noble |   config file = None
2026-08-31 06:12:38.926485 | ubuntu-noble |   configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
2026-08-31 06:12:38.926493 | ubuntu-noble |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible
2026-08-31 06:12:38.926501 | ubuntu-noble |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/local/lib/python3.12/dist-packages:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages
2026-08-31 06:12:38.926511 | ubuntu-noble |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-08-31 06:12:38.926519 | ubuntu-noble |   python version = 3.12.3 (main, Jul 15 2026, 23:46:41) [GCC 13.3.0] (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-08-31 06:12:38.926527 | ubuntu-noble |   jinja version = 3.1.6
2026-08-31 06:12:38.926535 | ubuntu-noble |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-08-31 06:12:38.926543 | ubuntu-noble | No config file found; using defaults
2026-08-31 06:12:38.926551 | ubuntu-noble | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.12/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-08-31 06:12:38.926560 | ubuntu-noble | Created /home/zuul/.ansible/galaxy_token
2026-08-31 06:12:38.926568 | ubuntu-noble | [ERROR]: Failed to download collection tar from 'default' due to the following unforeseen error: The read operation timed out
2026-08-31 06:12:38.926581 | ubuntu-noble |
2026-08-31 06:12:39.346011 | ubuntu-noble | ERROR
2026-08-31 06:12:39.346180 | ubuntu-noble | {
2026-08-31 06:12:39.346209 | ubuntu-noble |   "delta": "0:01:16.415204",
2026-08-31 06:12:39.346230 | ubuntu-noble |   "end": "2026-08-31 06:12:39.022323",
2026-08-31 06:12:39.346249 | ubuntu-noble |   "msg": "non-zero return code",
2026-08-31 06:12:39.346267 | ubuntu-noble |   "rc": 1,
2026-08-31 06:12:39.346285 | ubuntu-noble |   "start": "2026-08-31 06:11:22.607119"
2026-08-31 06:12:39.346302 | ubuntu-noble | }
failure
2026-08-31 06:12:39.348732 | 
2026-08-31 06:12:39.348781 | PLAY RECAP
2026-08-31 06:12:39.348824 | ubuntu-noble | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-31 06:12:39.348846 | 
2026-08-31 06:12:39.518237 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-31 06:12:39.521033 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-31 06:12:40.298796 | 
2026-08-31 06:12:40.381725 | PLAY [all]
2026-08-31 06:12:40.400129 | 
2026-08-31 06:12:40.400234 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-31 06:12:40.445384 | ubuntu-noble | skipping: Conditional result was False
2026-08-31 06:12:40.455755 | 
2026-08-31 06:12:40.455872 | TASK [fetch-output : Set log path for single node]
2026-08-31 06:12:40.489337 | ubuntu-noble | ok
2026-08-31 06:12:40.497007 | 
2026-08-31 06:12:40.497079 | LOOP [fetch-output : Ensure local output dirs]
2026-08-31 06:12:40.902166 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/logs"
2026-08-31 06:12:41.097748 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/artifacts"
2026-08-31 06:12:41.292411 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/e988a7ed74f24a39928eadaecebd3608/work/docs"
2026-08-31 06:12:41.316385 | 
2026-08-31 06:12:41.316857 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-31 06:12:42.007969 | ubuntu-noble | ok
2026-08-31 06:12:42.150832 | ubuntu-noble | changed: All items complete
2026-08-31 06:12:42.150937 | 
2026-08-31 06:12:42.640665 | ubuntu-noble | changed: .d..t...... ./
2026-08-31 06:12:43.176309 | ubuntu-noble | changed: .d..t...... ./
2026-08-31 06:12:43.205025 | 
2026-08-31 06:12:43.205187 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-31 06:12:43.665343 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007973
2026-08-31 06:12:43.883012 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008055
2026-08-31 06:12:43.904834 | 
2026-08-31 06:12:43.904981 | PLAY [all]
2026-08-31 06:12:43.912131 | 
2026-08-31 06:12:43.912198 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-31 06:12:44.430859 | ubuntu-noble | changed
2026-08-31 06:12:44.437192 | 
2026-08-31 06:12:44.437244 | PLAY RECAP
2026-08-31 06:12:44.437295 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-31 06:12:44.437318 | 
2026-08-31 06:12:44.597201 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-31 06:12:44.598663 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-31 06:12:45.266665 | 
2026-08-31 06:12:45.266802 | PLAY [localhost]
2026-08-31 06:12:45.277576 | 
2026-08-31 06:12:45.277651 | TASK [Generate Zuul manifest]
2026-08-31 06:12:45.297736 | localhost | ok
2026-08-31 06:12:45.443841 | 
2026-08-31 06:12:45.444066 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-31 06:12:45.854065 | localhost | changed
2026-08-31 06:12:45.867470 | 
2026-08-31 06:12:45.867550 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-31 06:12:45.984477 | localhost | ok
2026-08-31 06:12:45.991649 | 
2026-08-31 06:12:45.991720 | TASK [Upload logs]
2026-08-31 06:12:46.012169 | localhost | ok
2026-08-31 06:12:46.090446 | 
2026-08-31 06:12:46.090559 | TASK [Set zuul-log-path fact]
2026-08-31 06:12:46.113053 | localhost | ok
2026-08-31 06:12:46.126509 | 
2026-08-31 06:12:46.126580 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-31 06:12:46.157960 | localhost | ok
2026-08-31 06:12:46.166527 | 
2026-08-31 06:12:46.166591 | TASK [upload-logs : Create log directories]
2026-08-31 06:12:46.574435 | localhost | changed
2026-08-31 06:12:46.582539 | 
2026-08-31 06:12:46.582612 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-31 06:12:47.154088 | localhost -> localhost | ok: Runtime: 0:00:00.005983
2026-08-31 06:12:47.161199 | 
2026-08-31 06:12:47.161330 | TASK [upload-logs : Upload logs to log server]
2026-08-31 06:12:47.633226 | localhost | Output suppressed because no_log was given
2026-08-31 06:12:47.637058 | 
2026-08-31 06:12:47.637137 | LOOP [upload-logs : Compress console log and json output]
2026-08-31 06:12:47.694291 | localhost | skipping: Conditional result was False
2026-08-31 06:12:47.702012 | localhost | skipping: Conditional result was False
2026-08-31 06:12:47.715592 | 
2026-08-31 06:12:47.716007 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-31 06:12:47.767872 | localhost | skipping: Conditional result was False
2026-08-31 06:12:47.768280 | 
2026-08-31 06:12:47.772127 | localhost | skipping: Conditional result was False
2026-08-31 06:12:47.781297 | 
2026-08-31 06:12:47.781452 | LOOP [upload-logs : Upload console log and json output]