2026-07-26 00:59:44.653880 | Job console starting
2026-07-26 00:59:44.679857 | Updating git repos
2026-07-26 00:59:44.716772 | Cloning repos into workspace
2026-07-26 00:59:45.016184 | Restoring repo states
2026-07-26 00:59:45.023092 | Merging changes
2026-07-26 00:59:45.308940 | Checking out repos
2026-07-26 00:59:45.350677 | Preparing playbooks
2026-07-26 00:59:47.122290 | Running Ansible setup
2026-07-26 00:59:50.751397 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 00:59:51.371655 | 
2026-07-26 00:59:51.371777 | PLAY [localhost]
2026-07-26 00:59:51.379417 | 
2026-07-26 00:59:51.379488 | TASK [Gathering Facts]
2026-07-26 00:59:52.264505 | localhost | ok
2026-07-26 00:59:52.275642 | 
2026-07-26 00:59:52.275804 | TASK [Setup log path fact]
2026-07-26 00:59:52.299278 | localhost | ok
2026-07-26 00:59:52.312844 | 
2026-07-26 00:59:52.313018 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 00:59:52.344224 | localhost | ok
2026-07-26 00:59:52.352647 | 
2026-07-26 00:59:52.352790 | TASK [emit-job-header : Print job information]
2026-07-26 00:59:52.394059 | # Job Information
2026-07-26 00:59:52.394257 | Ansible Version: 2.16.18
2026-07-26 00:59:52.394305 | Job: ansible-collection-containers-molecule-containerd-ubuntu-focal
2026-07-26 00:59:52.394339 | Pipeline: check
2026-07-26 00:59:52.394369 | Executor: 2d72f0692154
2026-07-26 00:59:52.394399 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/143
2026-07-26 00:59:52.394432 | Event ID: 8666f790-888c-11f1-818d-f8ec3d49f744
2026-07-26 00:59:52.398451 | 
2026-07-26 00:59:52.398542 | LOOP [emit-job-header : Print node information]
2026-07-26 00:59:52.493769 | localhost | ok:
2026-07-26 00:59:52.493966 | localhost | # Node Information
2026-07-26 00:59:52.494001 | localhost | Inventory Hostname: ubuntu-focal
2026-07-26 00:59:52.494030 | localhost | Hostname: np0000186929
2026-07-26 00:59:52.494058 | localhost | Username: zuul
2026-07-26 00:59:52.494089 | localhost | Distro: Ubuntu 20.04
2026-07-26 00:59:52.494118 | localhost | Provider: yul1
2026-07-26 00:59:52.494143 | localhost | Region: ca-ymq-1
2026-07-26 00:59:52.494165 | localhost | Label: ubuntu-focal
2026-07-26 00:59:52.494231 | localhost | Product Name: OpenStack Nova
2026-07-26 00:59:52.494273 | localhost | Interface IP: 199.204.45.238
2026-07-26 00:59:52.505534 | 
2026-07-26 00:59:52.505693 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-07-26 00:59:52.980233 | localhost -> localhost | changed
2026-07-26 00:59:52.987513 | 
2026-07-26 00:59:52.987642 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-07-26 00:59:53.847094 | localhost -> localhost | changed
2026-07-26 00:59:53.853985 | 
2026-07-26 00:59:53.854060 | PLAY [all]
2026-07-26 00:59:53.871840 | 
2026-07-26 00:59:53.871975 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-07-26 00:59:54.130209 | ubuntu-focal -> localhost | ok
2026-07-26 00:59:54.140461 | 
2026-07-26 00:59:54.140548 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-07-26 00:59:54.173008 | ubuntu-focal | ok
2026-07-26 00:59:54.189398 | ubuntu-focal | included: /var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-07-26 00:59:54.194774 | 
2026-07-26 00:59:54.194832 | TASK [add-build-sshkey : Create Temp SSH key]
2026-07-26 00:59:55.993945 | ubuntu-focal -> localhost | Generating public/private rsa key pair.
2026-07-26 00:59:55.994135 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/898fce3aad7a45eb9d12ca98125393f2_id_rsa
2026-07-26 00:59:55.994179 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/898fce3aad7a45eb9d12ca98125393f2_id_rsa.pub
2026-07-26 00:59:55.994212 | ubuntu-focal -> localhost | The key fingerprint is:
2026-07-26 00:59:55.994243 | ubuntu-focal -> localhost | SHA256:AEZJ3lyDkjPbwbSKc9qwg6p+okeeV8pkPMNSrQZwufw zuul-build-sshkey
2026-07-26 00:59:55.994288 | ubuntu-focal -> localhost | The key's randomart image is:
2026-07-26 00:59:55.994320 | ubuntu-focal -> localhost | +---[RSA 3072]----+
2026-07-26 00:59:55.994357 | ubuntu-focal -> localhost | |   +==..o        |
2026-07-26 00:59:55.994389 | ubuntu-focal -> localhost | |. oo*++o .       |
2026-07-26 00:59:55.994420 | ubuntu-focal -> localhost | | + ..B=.         |
2026-07-26 00:59:55.994450 | ubuntu-focal -> localhost | |  +.o.o.         |
2026-07-26 00:59:55.994480 | ubuntu-focal -> localhost | |  +*o.  S        |
2026-07-26 00:59:55.994510 | ubuntu-focal -> localhost | | .oBE .          |
2026-07-26 00:59:55.994538 | ubuntu-focal -> localhost | |.o+B.=           |
2026-07-26 00:59:55.994567 | ubuntu-focal -> localhost | |..+o+            |
2026-07-26 00:59:55.994622 | ubuntu-focal -> localhost | |Boo.             |
2026-07-26 00:59:55.994653 | ubuntu-focal -> localhost | +----[SHA256]-----+
2026-07-26 00:59:55.994717 | ubuntu-focal -> localhost | ok: Runtime: 0:00:01.387229
2026-07-26 00:59:56.001296 | 
2026-07-26 00:59:56.001353 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-07-26 00:59:56.024256 | ubuntu-focal | ok
2026-07-26 00:59:56.034510 | ubuntu-focal | included: /var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-07-26 00:59:56.047796 | 
2026-07-26 00:59:56.047881 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-07-26 00:59:56.063895 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 00:59:56.074565 | 
2026-07-26 00:59:56.074673 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-07-26 00:59:56.507267 | ubuntu-focal | changed
2026-07-26 00:59:56.514574 | 
2026-07-26 00:59:56.514704 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-07-26 00:59:56.690242 | ubuntu-focal | ok
2026-07-26 00:59:56.695542 | 
2026-07-26 00:59:56.695607 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-07-26 00:59:57.158498 | ubuntu-focal | changed
2026-07-26 00:59:57.164180 | 
2026-07-26 00:59:57.164249 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-07-26 00:59:57.582415 | ubuntu-focal | changed
2026-07-26 00:59:57.634668 | 
2026-07-26 00:59:57.634805 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-07-26 00:59:57.658973 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 00:59:57.693615 | 
2026-07-26 00:59:57.693779 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-07-26 00:59:58.122839 | ubuntu-focal -> localhost | changed
2026-07-26 00:59:58.142351 | 
2026-07-26 00:59:58.142501 | TASK [add-build-sshkey : Add back temp key]
2026-07-26 00:59:58.418240 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/898fce3aad7a45eb9d12ca98125393f2_id_rsa (zuul-build-sshkey)
2026-07-26 00:59:58.418499 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.011142
2026-07-26 00:59:58.426869 | 
2026-07-26 00:59:58.427003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-07-26 00:59:58.753710 | ubuntu-focal | ok
2026-07-26 00:59:58.758245 | 
2026-07-26 00:59:58.758306 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-07-26 00:59:58.781242 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 00:59:58.799524 | 
2026-07-26 00:59:58.799651 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-07-26 00:59:59.130264 | ubuntu-focal | ok
2026-07-26 00:59:59.135894 | 
2026-07-26 00:59:59.135953 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-07-26 00:59:59.993371 | ubuntu-focal | Output suppressed because no_log was given
2026-07-26 01:00:00.043554 | 
2026-07-26 01:00:00.043688 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-07-26 01:00:00.212447 | ubuntu-focal | ok: "logs"
2026-07-26 01:00:00.212771 | ubuntu-focal | ok: All items complete
2026-07-26 01:00:00.212805 | 
2026-07-26 01:00:00.363577 | ubuntu-focal | ok: "artifacts"
2026-07-26 01:00:00.518804 | ubuntu-focal | ok: "docs"
2026-07-26 01:00:00.536415 | 
2026-07-26 01:00:00.536613 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-07-26 01:00:00.721734 | ubuntu-focal | changed: "logs"
2026-07-26 01:00:00.867833 | ubuntu-focal | changed: "artifacts"
2026-07-26 01:00:01.027685 | ubuntu-focal | changed: "docs"
2026-07-26 01:00:01.056005 | 
2026-07-26 01:00:01.056209 | PLAY RECAP
2026-07-26 01:00:01.056479 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 01:00:01.056548 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-07-26 01:00:01.056608 | 
2026-07-26 01:00:01.225128 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-07-26 01:00:01.230836 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 01:00:01.857229 | 
2026-07-26 01:00:01.857345 | PLAY [all]
2026-07-26 01:00:01.868281 | 
2026-07-26 01:00:01.868357 | TASK [setup-uv : Extract archive]
2026-07-26 01:00:04.260298 | ubuntu-focal | changed
2026-07-26 01:00:04.268561 | 
2026-07-26 01:00:04.268750 | TASK [setup-uv : Print version]
2026-07-26 01:00:04.618604 | ubuntu-focal | uv 0.8.13
2026-07-26 01:00:04.828838 | ubuntu-focal | ok: Runtime: 0:00:00.008398
2026-07-26 01:00:04.838360 | 
2026-07-26 01:00:04.838446 | TASK [Install Ansible collection siblings]
2026-07-26 01:00:05.213211 | ubuntu-focal | ok:
2026-07-26 01:00:05.213378 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling
2026-07-26 01:00:05.213407 | ubuntu-focal | Skipping community.general: no checked-out sibling
2026-07-26 01:00:05.215034 | 
2026-07-26 01:00:05.215079 | PLAY RECAP
2026-07-26 01:00:05.215123 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-07-26 01:00:05.215144 | 
2026-07-26 01:00:05.376615 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-07-26 01:00:05.378118 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-26 01:00:05.953767 | 
2026-07-26 01:00:05.953879 | PLAY [all]
2026-07-26 01:00:05.965711 | 
2026-07-26 01:00:05.965783 | LOOP [Check inventory directories]
2026-07-26 01:00:06.248584 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers"
2026-07-26 01:00:06.388556 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/containerd/inventory"
2026-07-26 01:00:06.545190 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/containerd/inventory"
2026-07-26 01:00:06.565394 | 
2026-07-26 01:00:06.565570 | LOOP [Copy inventory file for Zuul]
2026-07-26 01:00:07.326775 | ubuntu-focal | changed:
2026-07-26 01:00:07.326995 | ubuntu-focal | {
2026-07-26 01:00:07.327036 | ubuntu-focal |   "ansible_loop_var": "item",
2026-07-26 01:00:07.327069 | ubuntu-focal |   "changed": false,
2026-07-26 01:00:07.327098 | ubuntu-focal |   "failed": false,
2026-07-26 01:00:07.327129 | ubuntu-focal |   "invocation": {
2026-07-26 01:00:07.327156 | ubuntu-focal |     "module_args": {
2026-07-26 01:00:07.327181 | ubuntu-focal |       "checksum_algorithm": "sha1",
2026-07-26 01:00:07.327206 | ubuntu-focal |       "follow": true,
2026-07-26 01:00:07.327276 | ubuntu-focal |       "get_attributes": true,
2026-07-26 01:00:07.327305 | ubuntu-focal |       "get_checksum": true,
2026-07-26 01:00:07.327330 | ubuntu-focal |       "get_mime": true,
2026-07-26 01:00:07.327354 | ubuntu-focal |       "path": "src/github.com/vexxhost/ansible-collection-containers"
2026-07-26 01:00:07.327380 | ubuntu-focal |     }
2026-07-26 01:00:07.327404 | ubuntu-focal |   },
2026-07-26 01:00:07.327429 | ubuntu-focal |   "item": "src/github.com/vexxhost/ansible-collection-containers",
2026-07-26 01:00:07.327466 | ubuntu-focal |   "stat": {
2026-07-26 01:00:07.327492 | ubuntu-focal |     "atime": 1785027599.8908312,
2026-07-26 01:00:07.327518 | ubuntu-focal |     "attr_flags": "e",
2026-07-26 01:00:07.327543 | ubuntu-focal |     "attributes": [
2026-07-26 01:00:07.327567 | ubuntu-focal |       "extents"
2026-07-26 01:00:07.327592 | ubuntu-focal |     ],
2026-07-26 01:00:07.327616 | ubuntu-focal |     "block_size": 4096,
2026-07-26 01:00:07.327641 | ubuntu-focal |     "blocks": 8,
2026-07-26 01:00:07.327666 | ubuntu-focal |     "charset": "binary",
2026-07-26 01:00:07.327691 | ubuntu-focal |     "ctime": 1785027599.8908312,
2026-07-26 01:00:07.327716 | ubuntu-focal |     "dev": 64513,
2026-07-26 01:00:07.327740 | ubuntu-focal |     "device_type": 0,
2026-07-26 01:00:07.327764 | ubuntu-focal |     "executable": true,
2026-07-26 01:00:07.327788 | ubuntu-focal |     "exists": true,
2026-07-26 01:00:07.327813 | ubuntu-focal |     "gid": 1000,
2026-07-26 01:00:07.327836 | ubuntu-focal |     "gr_name": "zuul",
2026-07-26 01:00:07.327860 | ubuntu-focal |     "inode": 1035293,
2026-07-26 01:00:07.327884 | ubuntu-focal |     "isblk": false,
2026-07-26 01:00:07.327909 | ubuntu-focal |     "ischr": false,
2026-07-26 01:00:07.327932 | ubuntu-focal |     "isdir": true,
2026-07-26 01:00:07.327956 | ubuntu-focal |     "isfifo": false,
2026-07-26 01:00:07.327981 | ubuntu-focal |     "isgid": false,
2026-07-26 01:00:07.328004 | ubuntu-focal |     "islnk": false,
2026-07-26 01:00:07.328028 | ubuntu-focal |     "isreg": false,
2026-07-26 01:00:07.328051 | ubuntu-focal |     "issock": false,
2026-07-26 01:00:07.328074 | ubuntu-focal |     "isuid": false,
2026-07-26 01:00:07.328098 | ubuntu-focal |     "mimetype": "inode/directory",
2026-07-26 01:00:07.328121 | ubuntu-focal |     "mode": "0755",
2026-07-26 01:00:07.328146 | ubuntu-focal |     "mtime": 1785027585.049454,
2026-07-26 01:00:07.328169 | ubuntu-focal |     "nlink": 11,
2026-07-26 01:00:07.328194 | ubuntu-focal |     "path": "src/github.com/vexxhost/ansible-collection-containers",
2026-07-26 01:00:07.328218 | ubuntu-focal |     "pw_name": "zuul",
2026-07-26 01:00:07.328246 | ubuntu-focal |     "readable": true,
2026-07-26 01:00:07.328271 | ubuntu-focal |     "rgrp": true,
2026-07-26 01:00:07.328296 | ubuntu-focal |     "roth": true,
2026-07-26 01:00:07.328326 | ubuntu-focal |     "rusr": true,
2026-07-26 01:00:07.328355 | ubuntu-focal |     "size": 4096,
2026-07-26 01:00:07.328385 | ubuntu-focal |     "uid": 1000,
2026-07-26 01:00:07.328415 | ubuntu-focal |     "version": "498507123",
2026-07-26 01:00:07.328445 | ubuntu-focal |     "wgrp": false,
2026-07-26 01:00:07.328476 | ubuntu-focal |     "woth": false,
2026-07-26 01:00:07.328501 | ubuntu-focal |     "writeable": true,
2026-07-26 01:00:07.328525 | ubuntu-focal |     "wusr": true,
2026-07-26 01:00:07.328549 | ubuntu-focal |     "xgrp": true,
2026-07-26 01:00:07.328573 | ubuntu-focal |     "xoth": true,
2026-07-26 01:00:07.328597 | ubuntu-focal |     "xusr": true
2026-07-26 01:00:07.328621 | ubuntu-focal |   }
2026-07-26 01:00:07.328645 | ubuntu-focal | }
2026-07-26 01:00:07.328690 | ubuntu-focal | ok: All items complete
2026-07-26 01:00:07.328721 | 
2026-07-26 01:00:07.330359 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 01:00:07.331160 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 01:00:07.346586 | 
2026-07-26 01:00:07.346723 | LOOP [Switch "ansible_host" to private IP]
2026-07-26 01:00:07.673830 | ubuntu-focal | changed: 1 replacements made
2026-07-26 01:00:07.675100 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 01:00:07.675707 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 01:00:07.695632 | 
2026-07-26 01:00:07.695781 | TASK [Run Molecule scenario]
2026-07-26 01:00:08.358216 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB)
2026-07-26 01:00:09.072576 | ubuntu-focal |  Downloading cpython-3.13.7-linux-x86_64-gnu (download)
2026-07-26 01:00:09.253642 | ubuntu-focal | Using CPython 3.13.7
2026-07-26 01:00:09.253732 | ubuntu-focal | Creating virtual environment at: .venv
2026-07-26 01:00:09.485869 | ubuntu-focal | Downloading pygments (1.2MiB)
2026-07-26 01:00:09.488150 | ubuntu-focal | Downloading ansible-core (2.3MiB)
2026-07-26 01:00:09.488327 | ubuntu-focal | Downloading cryptography (4.3MiB)
2026-07-26 01:00:09.642597 | ubuntu-focal |  Downloading cryptography
2026-07-26 01:00:09.681674 | ubuntu-focal |  Downloading pygments
2026-07-26 01:00:09.823017 | ubuntu-focal |  Downloading ansible-core
2026-07-26 01:00:09.848420 | ubuntu-focal | Installed 36 packages in 24ms
2026-07-26 01:00:10.946044 | ubuntu-focal | INFO     Collection 'vexxhost.containers' detected.
2026-07-26 01:00:10.946548 | ubuntu-focal | INFO     Scenarios will be used from 'extensions/molecule'
2026-07-26 01:00:11.775835 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-07-26 01:00:11.775917 | ubuntu-focal | INFO     default scenario not found, disabling shared state.
2026-07-26 01:00:11.776038 | ubuntu-focal | INFO     [containerd > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-07-26 01:00:11.776077 | ubuntu-focal | INFO     [containerd > prerun] Performing prerun with role_name_check=0...
2026-07-26 01:01:28.944131 | ubuntu-focal | WARNING  Retrying execution failure 1 of: ansible-galaxy collection install -vvv community.general:>=4.5.0
2026-07-26 01:01:28.944235 | ubuntu-focal | ERROR    Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-07-26 01:01:28.944248 | ubuntu-focal | Starting galaxy collection install process
2026-07-26 01:01:28.944258 | ubuntu-focal | Process install dependency map
2026-07-26 01:01:28.944268 | ubuntu-focal | Starting collection install process
2026-07-26 01:01:28.944281 | ubuntu-focal | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.2.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-10366jv1c3ue/tmpfq8ouvgq/community-general-13.2.0-whda58u9
2026-07-26 01:01:28.944291 | ubuntu-focal | Installing 'community.general:13.2.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-26 01:01:28.944301 | ubuntu-focal | community.general:13.2.0 was installed successfully
2026-07-26 01:01:28.944311 | ubuntu-focal | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-library_inventory_filtering_v1-1.1.5.tar.gz to /home/zuul/.ansible/tmp/ansible-local-10366jv1c3ue/tmpfq8ouvgq/community-library_inventory_filtering_v1-1.1.5-eceghgd1
2026-07-26 01:01:28.944325 | ubuntu-focal |
2026-07-26 01:01:28.944335 | ubuntu-focal | ansible-galaxy
2026-07-26 01:01:28.944344 | ubuntu-focal |   config file = None
2026-07-26 01:01:28.944354 | ubuntu-focal |   configured module search path =
2026-07-26 01:01:28.944363 | ubuntu-focal |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible
2026-07-26 01:01:28.944373 | ubuntu-focal |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages
2026-07-26 01:01:28.944382 | ubuntu-focal |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-07-26 01:01:28.944391 | ubuntu-focal |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03)  (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-07-26 01:01:28.944407 | ubuntu-focal |   jinja version = 3.1.6
2026-07-26 01:01:28.944417 | ubuntu-focal |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-07-26 01:01:28.944426 | ubuntu-focal | No config file found; using defaults
2026-07-26 01:01:28.944435 | ubuntu-focal | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-07-26 01:01:28.944445 | ubuntu-focal | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-26 01:01:28.944473 | ubuntu-focal | Opened /home/zuul/.ansible/galaxy_token
2026-07-26 01:01:28.944482 | ubuntu-focal | Collection 'community.general:13.2.0' obtained from server default https://galaxy.ansible.com/api/
2026-07-26 01:01:28.944491 | ubuntu-focal | : Failed to download collection tar from 'default': HTTP Error 502: Bad Gateway
2026-07-26 01:01:28.944499 | ubuntu-focal |
2026-07-26 01:01:28.946832 | ubuntu-focal | Traceback (most recent call last):
2026-07-26 01:01:28.948569 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/molecule", line 10, in <module>
2026-07-26 01:01:28.948607 | ubuntu-focal |     sys.exit(main())
2026-07-26 01:01:28.948622 | ubuntu-focal |              ~~~~^^
2026-07-26 01:01:28.948688 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1442, in __call__
2026-07-26 01:01:28.948723 | ubuntu-focal |     return self.main(*args, **kwargs)
2026-07-26 01:01:28.948733 | ubuntu-focal |            ~~~~~~~~~^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.948808 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1363, in main
2026-07-26 01:01:28.948828 | ubuntu-focal |     rv = self.invoke(ctx)
2026-07-26 01:01:28.948964 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1830, in invoke
2026-07-26 01:01:28.948977 | ubuntu-focal |     return _process_result(sub_ctx.command.invoke(sub_ctx))
2026-07-26 01:01:28.948987 | ubuntu-focal |                            ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
2026-07-26 01:01:28.949091 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 1226, in invoke
2026-07-26 01:01:28.949126 | ubuntu-focal |     return ctx.invoke(self.callback, **ctx.params)
2026-07-26 01:01:28.949139 | ubuntu-focal |            ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.958763 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/core.py", line 794, in invoke
2026-07-26 01:01:28.959548 | ubuntu-focal |     return callback(*args, **kwargs)
2026-07-26 01:01:28.959567 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 583, in wrapper
2026-07-26 01:01:28.959577 | ubuntu-focal |     return func(*args, **kwargs)
2026-07-26 01:01:28.959587 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/click/decorators.py", line 34, in new_func
2026-07-26 01:01:28.959595 | ubuntu-focal |     return f(get_current_context(), *args, **kwargs)
2026-07-26 01:01:28.959605 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/click_cfg.py", line 418, in wrapper
2026-07-26 01:01:28.959614 | ubuntu-focal |     return func(ctx)
2026-07-26 01:01:28.959622 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/test.py", line 81, in test
2026-07-26 01:01:28.959631 | ubuntu-focal |     base.execute_cmdline_scenarios(scenario_name, args, command_args, ansible_args, exclude)
2026-07-26 01:01:28.959641 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959649 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 169, in execute_cmdline_scenarios
2026-07-26 01:01:28.959658 | ubuntu-focal |     _run_scenarios(scenarios, command_args, default_config)
2026-07-26 01:01:28.959668 | ubuntu-focal |     ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959676 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/molecule/command/base.py", line 240, in _run_scenarios
2026-07-26 01:01:28.959685 | ubuntu-focal |     scenario.config.runtime.prepare_environment(
2026-07-26 01:01:28.959694 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~^
2026-07-26 01:01:28.959702 | ubuntu-focal |         install_local=True,
2026-07-26 01:01:28.959711 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959733 | ubuntu-focal |         role_name_check=role_name_check,
2026-07-26 01:01:28.959742 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959751 | ubuntu-focal |     )
2026-07-26 01:01:28.959760 | ubuntu-focal |     ^
2026-07-26 01:01:28.959768 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 752, in prepare_environment
2026-07-26 01:01:28.959777 | ubuntu-focal |     self.install_collection(
2026-07-26 01:01:28.959785 | ubuntu-focal |     ~~~~~~~~~~~~~~~~~~~~~~~^
2026-07-26 01:01:28.959794 | ubuntu-focal |         f"{name}{',' if is_url(name) else ':'}{required_version}",
2026-07-26 01:01:28.959803 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959812 | ubuntu-focal |         destination=destination,
2026-07-26 01:01:28.959820 | ubuntu-focal |         ^^^^^^^^^^^^^^^^^^^^^^^^
2026-07-26 01:01:28.959829 | ubuntu-focal |     )
2026-07-26 01:01:28.959837 | ubuntu-focal |     ^
2026-07-26 01:01:28.959846 | ubuntu-focal |   File "/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible_compat/runtime.py", line 609, in install_collection
2026-07-26 01:01:28.959855 | ubuntu-focal |     raise InvalidPrerequisiteError(msg)
2026-07-26 01:01:28.959996 | ubuntu-focal | ansible_compat.errors.InvalidPrerequisiteError: Command ansible-galaxy collection install -vvv community.general:>=4.5.0, returned 1 code:
2026-07-26 01:01:28.960007 | ubuntu-focal | Starting galaxy collection install process
2026-07-26 01:01:28.960016 | ubuntu-focal | Process install dependency map
2026-07-26 01:01:28.960025 | ubuntu-focal | Starting collection install process
2026-07-26 01:01:28.960034 | ubuntu-focal | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-general-13.2.0.tar.gz to /home/zuul/.ansible/tmp/ansible-local-10366jv1c3ue/tmpfq8ouvgq/community-general-13.2.0-whda58u9
2026-07-26 01:01:28.960044 | ubuntu-focal | Installing 'community.general:13.2.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-07-26 01:01:28.960053 | ubuntu-focal | community.general:13.2.0 was installed successfully
2026-07-26 01:01:28.960062 | ubuntu-focal | Downloading https://galaxy.ansible.com/api/v3/plugin/ansible/content/published/collections/artifacts/community-library_inventory_filtering_v1-1.1.5.tar.gz to /home/zuul/.ansible/tmp/ansible-local-10366jv1c3ue/tmpfq8ouvgq/community-library_inventory_filtering_v1-1.1.5-eceghgd1
2026-07-26 01:01:28.960081 | ubuntu-focal |
2026-07-26 01:01:28.960090 | ubuntu-focal | ansible-galaxy [core 2.19.1]
2026-07-26 01:01:28.960099 | ubuntu-focal |   config file = None
2026-07-26 01:01:28.960107 | ubuntu-focal |   configured module search path = ['/home/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules']
2026-07-26 01:01:28.960116 | ubuntu-focal |   ansible python module location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible
2026-07-26 01:01:28.960125 | ubuntu-focal |   ansible collection location = /home/zuul/.ansible/collections:/usr/share/ansible/collections:/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages
2026-07-26 01:01:28.960138 | ubuntu-focal |   executable location = /home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/ansible-galaxy
2026-07-26 01:01:28.960147 | ubuntu-focal |   python version = 3.13.7 (main, Aug 18 2025, 19:20:03) [Clang 20.1.4 ] (/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/bin/python)
2026-07-26 01:01:28.960155 | ubuntu-focal |   jinja version = 3.1.6
2026-07-26 01:01:28.960164 | ubuntu-focal |   pyyaml version = 6.0.2 (with libyaml v0.2.5)
2026-07-26 01:01:28.960172 | ubuntu-focal | No config file found; using defaults
2026-07-26 01:01:28.960182 | ubuntu-focal | Found installed collection ansible._protomatter:2.19.1 at '/home/zuul/src/github.com/vexxhost/ansible-collection-containers/.venv/lib/python3.13/site-packages/ansible/_internal/ansible_collections/ansible/_protomatter'
2026-07-26 01:01:28.960191 | ubuntu-focal | Found installed collection ansible.posix:2.2.2 at '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-07-26 01:01:28.960199 | ubuntu-focal | Opened /home/zuul/.ansible/galaxy_token
2026-07-26 01:01:28.960208 | ubuntu-focal | Collection 'community.general:13.2.0' obtained from server default https://galaxy.ansible.com/api/
2026-07-26 01:01:28.960223 | ubuntu-focal | [ERROR]: Failed to download collection tar from 'default': HTTP Error 502: Bad Gateway
2026-07-26 01:01:28.960231 | ubuntu-focal |
2026-07-26 01:01:29.386066 | ubuntu-focal | ERROR
2026-07-26 01:01:29.386356 | ubuntu-focal | {
2026-07-26 01:01:29.386415 | ubuntu-focal |   "delta": "0:01:20.979418",
2026-07-26 01:01:29.386448 | ubuntu-focal |   "end": "2026-07-26 01:01:29.046465",
2026-07-26 01:01:29.386474 | ubuntu-focal |   "msg": "non-zero return code",
2026-07-26 01:01:29.386500 | ubuntu-focal |   "rc": 1,
2026-07-26 01:01:29.386524 | ubuntu-focal |   "start": "2026-07-26 01:00:08.067047"
2026-07-26 01:01:29.386549 | ubuntu-focal | }
failure
2026-07-26 01:01:29.389366 | 
2026-07-26 01:01:29.389430 | PLAY RECAP
2026-07-26 01:01:29.389489 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-07-26 01:01:29.389520 | 
2026-07-26 01:01:29.505323 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-07-26 01:01:29.508652 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 01:01:30.103907 | 
2026-07-26 01:01:30.104393 | PLAY [all]
2026-07-26 01:01:30.115850 | 
2026-07-26 01:01:30.115932 | TASK [fetch-output : Set log path for multiple nodes]
2026-07-26 01:01:30.161810 | ubuntu-focal | skipping: Conditional result was False
2026-07-26 01:01:30.172443 | 
2026-07-26 01:01:30.172525 | TASK [fetch-output : Set log path for single node]
2026-07-26 01:01:30.217005 | ubuntu-focal | ok
2026-07-26 01:01:30.221732 | 
2026-07-26 01:01:30.221804 | LOOP [fetch-output : Ensure local output dirs]
2026-07-26 01:01:30.597897 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/logs"
2026-07-26 01:01:30.820295 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/artifacts"
2026-07-26 01:01:31.025928 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/898fce3aad7a45eb9d12ca98125393f2/work/docs"
2026-07-26 01:01:31.041233 | 
2026-07-26 01:01:31.041397 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-07-26 01:01:31.626989 | ubuntu-focal | changed: .d..t...... ./
2026-07-26 01:01:31.627229 | ubuntu-focal | changed: All items complete
2026-07-26 01:01:31.627286 | 
2026-07-26 01:01:32.035914 | ubuntu-focal | changed: .d..t...... ./
2026-07-26 01:01:32.448465 | ubuntu-focal | changed: .d..t...... ./
2026-07-26 01:01:32.467907 | 
2026-07-26 01:01:32.468087 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-07-26 01:01:32.896610 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.008828
2026-07-26 01:01:33.134958 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007008
2026-07-26 01:01:33.150239 | 
2026-07-26 01:01:33.150391 | PLAY [all]
2026-07-26 01:01:33.157031 | 
2026-07-26 01:01:33.157143 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-07-26 01:01:33.618556 | ubuntu-focal | changed
2026-07-26 01:01:33.626801 | 
2026-07-26 01:01:33.626870 | PLAY RECAP
2026-07-26 01:01:33.626939 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-07-26 01:01:33.626973 | 
2026-07-26 01:01:33.799181 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-07-26 01:01:33.801487 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-07-26 01:01:34.355028 | 
2026-07-26 01:01:34.355137 | PLAY [localhost]
2026-07-26 01:01:34.365295 | 
2026-07-26 01:01:34.365369 | TASK [Generate Zuul manifest]
2026-07-26 01:01:34.386955 | localhost | ok
2026-07-26 01:01:34.402955 | 
2026-07-26 01:01:34.403027 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-07-26 01:01:34.820822 | localhost | changed
2026-07-26 01:01:34.833300 | 
2026-07-26 01:01:34.833381 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-07-26 01:01:34.867337 | localhost | ok
2026-07-26 01:01:34.875654 | 
2026-07-26 01:01:34.875727 | TASK [Upload logs]
2026-07-26 01:01:34.895137 | localhost | ok
2026-07-26 01:01:34.962851 | 
2026-07-26 01:01:34.962974 | TASK [Set zuul-log-path fact]
2026-07-26 01:01:34.982836 | localhost | ok
2026-07-26 01:01:34.997436 | 
2026-07-26 01:01:34.997505 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-07-26 01:01:35.028891 | localhost | ok
2026-07-26 01:01:35.038518 | 
2026-07-26 01:01:35.038596 | TASK [upload-logs : Create log directories]
2026-07-26 01:01:35.445504 | localhost | changed
2026-07-26 01:01:35.451767 | 
2026-07-26 01:01:35.451863 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-07-26 01:01:35.962200 | localhost -> localhost | ok: Runtime: 0:00:00.006808
2026-07-26 01:01:35.968332 | 
2026-07-26 01:01:35.968406 | TASK [upload-logs : Upload logs to log server]
2026-07-26 01:01:36.424753 | localhost | Output suppressed because no_log was given
2026-07-26 01:01:36.428836 | 
2026-07-26 01:01:36.428904 | LOOP [upload-logs : Compress console log and json output]
2026-07-26 01:01:36.473089 | localhost | skipping: Conditional result was False
2026-07-26 01:01:36.480014 | localhost | skipping: Conditional result was False
2026-07-26 01:01:36.493763 | 
2026-07-26 01:01:36.493975 | LOOP [upload-logs : Upload compressed console log and json output]
2026-07-26 01:01:36.538173 | localhost | skipping: Conditional result was False
2026-07-26 01:01:36.538647 | 
2026-07-26 01:01:36.545979 | localhost | skipping: Conditional result was False
2026-07-26 01:01:36.558561 | 
2026-07-26 01:01:36.558924 | LOOP [upload-logs : Upload console log and json output]