2026-08-12 00:58:14.287535 | Job console starting 2026-08-12 00:58:14.296702 | Updating git repos 2026-08-12 00:58:14.322868 | Cloning repos into workspace 2026-08-12 00:58:14.351615 | Restoring repo states 2026-08-12 00:58:14.361257 | Merging changes 2026-08-12 00:58:14.854177 | Checking out repos 2026-08-12 00:58:14.885700 | Preparing playbooks 2026-08-12 00:58:16.856110 | Running Ansible setup 2026-08-12 00:58:20.804678 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-12 00:58:21.398968 | 2026-08-12 00:58:21.399081 | PLAY [localhost] 2026-08-12 00:58:21.407707 | 2026-08-12 00:58:21.407784 | TASK [Gathering Facts] 2026-08-12 00:58:22.307341 | localhost | ok 2026-08-12 00:58:22.318094 | 2026-08-12 00:58:22.318218 | TASK [Setup log path fact] 2026-08-12 00:58:22.337955 | localhost | ok 2026-08-12 00:58:22.350467 | 2026-08-12 00:58:22.350561 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 00:58:22.380463 | localhost | ok 2026-08-12 00:58:22.387337 | 2026-08-12 00:58:22.387418 | TASK [emit-job-header : Print job information] 2026-08-12 00:58:22.448011 | # Job Information 2026-08-12 00:58:22.448254 | Ansible Version: 2.16.18 2026-08-12 00:58:22.448323 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-08-12 00:58:22.448372 | Pipeline: check 2026-08-12 00:58:22.448417 | Executor: 2d72f0692154 2026-08-12 00:58:22.448461 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/141 2026-08-12 00:58:22.448510 | Event ID: 9d5b1ec0-95e5-11f1-83a5-16991d845851 2026-08-12 00:58:22.454739 | 2026-08-12 00:58:22.454848 | LOOP [emit-job-header : Print node information] 2026-08-12 00:58:22.545465 | localhost | ok: 2026-08-12 00:58:22.545672 | localhost | # Node Information 2026-08-12 00:58:22.545713 | localhost | Inventory Hostname: ubuntu-focal 2026-08-12 00:58:22.545746 | localhost | Hostname: np0000188829 2026-08-12 00:58:22.545776 | localhost | Username: zuul 2026-08-12 00:58:22.545811 | localhost | Distro: Ubuntu 20.04 2026-08-12 00:58:22.545840 | localhost | Provider: yul1 2026-08-12 00:58:22.545869 | localhost | Region: ca-ymq-1 2026-08-12 00:58:22.545897 | localhost | Label: ubuntu-focal 2026-08-12 00:58:22.545924 | localhost | Product Name: OpenStack Nova 2026-08-12 00:58:22.545953 | localhost | Interface IP: 199.19.213.44 2026-08-12 00:58:22.563464 | 2026-08-12 00:58:22.563645 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-12 00:58:22.930887 | localhost -> localhost | changed 2026-08-12 00:58:22.935782 | 2026-08-12 00:58:22.936028 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-12 00:58:23.817382 | localhost -> localhost | changed 2026-08-12 00:58:23.824535 | 2026-08-12 00:58:23.824611 | PLAY [all] 2026-08-12 00:58:23.832253 | 2026-08-12 00:58:23.832319 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-12 00:58:24.058185 | ubuntu-focal -> localhost | ok 2026-08-12 00:58:24.064008 | 2026-08-12 00:58:24.064071 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-12 00:58:24.096496 | ubuntu-focal | ok 2026-08-12 00:58:24.114236 | ubuntu-focal | included: /var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-12 00:58:24.119860 | 2026-08-12 00:58:24.119927 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-12 00:58:25.414582 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-08-12 00:58:25.414734 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/2042d0f2f3db459cb0d86cc73cfe4990_id_rsa 2026-08-12 00:58:25.414764 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/2042d0f2f3db459cb0d86cc73cfe4990_id_rsa.pub 2026-08-12 00:58:25.414787 | ubuntu-focal -> localhost | The key fingerprint is: 2026-08-12 00:58:25.414809 | ubuntu-focal -> localhost | SHA256:y8hBIKetdFIoDGBIe6DKb9lmL5VCVg6/XvgAX+REOXg zuul-build-sshkey 2026-08-12 00:58:25.414837 | ubuntu-focal -> localhost | The key's randomart image is: 2026-08-12 00:58:25.414859 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-08-12 00:58:25.414884 | ubuntu-focal -> localhost | |O+..+ o.. | 2026-08-12 00:58:25.414906 | ubuntu-focal -> localhost | |=.+* o o E | 2026-08-12 00:58:25.414926 | ubuntu-focal -> localhost | |.o+.o * = . | 2026-08-12 00:58:25.414947 | ubuntu-focal -> localhost | |o..+ = o o | 2026-08-12 00:58:25.414967 | ubuntu-focal -> localhost | |... o + S | 2026-08-12 00:58:25.414987 | ubuntu-focal -> localhost | | . oo @ o | 2026-08-12 00:58:25.415007 | ubuntu-focal -> localhost | | + +* * | 2026-08-12 00:58:25.415026 | ubuntu-focal -> localhost | | . o... . | 2026-08-12 00:58:25.415049 | ubuntu-focal -> localhost | | .. | 2026-08-12 00:58:25.415069 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-08-12 00:58:25.415117 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.934281 2026-08-12 00:58:25.420904 | 2026-08-12 00:58:25.421047 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-12 00:58:25.452948 | ubuntu-focal | ok 2026-08-12 00:58:25.462393 | ubuntu-focal | included: /var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-12 00:58:25.470824 | 2026-08-12 00:58:25.470912 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-12 00:58:25.494789 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:25.506441 | 2026-08-12 00:58:25.506633 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-12 00:58:25.914592 | ubuntu-focal | changed 2026-08-12 00:58:25.921487 | 2026-08-12 00:58:25.921558 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-12 00:58:26.103696 | ubuntu-focal | ok 2026-08-12 00:58:26.306232 | 2026-08-12 00:58:26.306357 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-12 00:58:26.746712 | ubuntu-focal | changed 2026-08-12 00:58:26.753073 | 2026-08-12 00:58:26.753154 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-12 00:58:27.194706 | ubuntu-focal | changed 2026-08-12 00:58:27.201980 | 2026-08-12 00:58:27.202108 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-12 00:58:27.227148 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:27.235662 | 2026-08-12 00:58:27.235755 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-12 00:58:27.616343 | ubuntu-focal -> localhost | changed 2026-08-12 00:58:27.634896 | 2026-08-12 00:58:27.635035 | TASK [add-build-sshkey : Add back temp key] 2026-08-12 00:58:27.920171 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/2042d0f2f3db459cb0d86cc73cfe4990_id_rsa (zuul-build-sshkey) 2026-08-12 00:58:27.920972 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.014148 2026-08-12 00:58:27.928858 | 2026-08-12 00:58:27.929168 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-12 00:58:28.235215 | ubuntu-focal | ok 2026-08-12 00:58:28.243868 | 2026-08-12 00:58:28.243947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-12 00:58:28.267550 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:28.284189 | 2026-08-12 00:58:28.284285 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-12 00:58:28.610901 | ubuntu-focal | ok 2026-08-12 00:58:28.617569 | 2026-08-12 00:58:28.617640 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-12 00:58:29.262819 | ubuntu-focal | Output suppressed because no_log was given 2026-08-12 00:58:29.271159 | 2026-08-12 00:58:29.271222 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-12 00:58:29.438315 | ubuntu-focal | ok: "logs" 2026-08-12 00:58:29.438625 | ubuntu-focal | ok: All items complete 2026-08-12 00:58:29.438681 | 2026-08-12 00:58:29.620492 | ubuntu-focal | ok: "artifacts" 2026-08-12 00:58:29.737357 | ubuntu-focal | ok: "docs" 2026-08-12 00:58:29.749921 | 2026-08-12 00:58:29.750066 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-12 00:58:29.927181 | ubuntu-focal | changed: "logs" 2026-08-12 00:58:30.069798 | ubuntu-focal | changed: "artifacts" 2026-08-12 00:58:30.218414 | ubuntu-focal | changed: "docs" 2026-08-12 00:58:30.238227 | 2026-08-12 00:58:30.238328 | PLAY RECAP 2026-08-12 00:58:30.238375 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 00:58:30.238406 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-12 00:58:30.238429 | 2026-08-12 00:58:30.345222 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-12 00:58:30.347542 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-12 00:58:30.922781 | 2026-08-12 00:58:30.922913 | PLAY [all] 2026-08-12 00:58:30.933494 | 2026-08-12 00:58:30.933569 | TASK [setup-uv : Extract archive] 2026-08-12 00:58:33.091197 | ubuntu-focal | changed 2026-08-12 00:58:33.098473 | 2026-08-12 00:58:33.098596 | TASK [setup-uv : Print version] 2026-08-12 00:58:33.431512 | ubuntu-focal | uv 0.8.13 2026-08-12 00:58:33.644071 | ubuntu-focal | ok: Runtime: 0:00:00.008953 2026-08-12 00:58:33.656764 | 2026-08-12 00:58:33.656855 | TASK [Install Ansible collection siblings] 2026-08-12 00:58:34.035466 | ubuntu-focal | ok: 2026-08-12 00:58:34.035673 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling 2026-08-12 00:58:34.035713 | ubuntu-focal | Skipping community.general: no checked-out sibling 2026-08-12 00:58:34.037971 | 2026-08-12 00:58:34.038034 | PLAY RECAP 2026-08-12 00:58:34.038095 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 00:58:34.038126 | 2026-08-12 00:58:34.146663 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-12 00:58:34.149087 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-12 00:58:34.723905 | 2026-08-12 00:58:34.724029 | PLAY [all] 2026-08-12 00:58:34.735212 | 2026-08-12 00:58:34.735284 | LOOP [Check inventory directories] 2026-08-12 00:58:35.002826 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-08-12 00:58:35.146309 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/forget-package/inventory" 2026-08-12 00:58:35.297356 | ubuntu-focal | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/inventory" 2026-08-12 00:58:35.309782 | 2026-08-12 00:58:35.309962 | LOOP [Copy inventory file for Zuul] 2026-08-12 00:58:36.054531 | ubuntu-focal | changed: 2026-08-12 00:58:36.054701 | ubuntu-focal | { 2026-08-12 00:58:36.054730 | ubuntu-focal | "ansible_loop_var": "item", 2026-08-12 00:58:36.054753 | ubuntu-focal | "changed": false, 2026-08-12 00:58:36.054773 | ubuntu-focal | "failed": false, 2026-08-12 00:58:36.054799 | ubuntu-focal | "invocation": { 2026-08-12 00:58:36.054820 | ubuntu-focal | "module_args": { 2026-08-12 00:58:36.054839 | ubuntu-focal | "checksum_algorithm": "sha1", 2026-08-12 00:58:36.054857 | ubuntu-focal | "follow": true, 2026-08-12 00:58:36.054875 | ubuntu-focal | "get_attributes": true, 2026-08-12 00:58:36.054893 | ubuntu-focal | "get_checksum": true, 2026-08-12 00:58:36.054911 | ubuntu-focal | "get_mime": true, 2026-08-12 00:58:36.054928 | ubuntu-focal | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-08-12 00:58:36.054946 | ubuntu-focal | } 2026-08-12 00:58:36.054964 | ubuntu-focal | }, 2026-08-12 00:58:36.054982 | ubuntu-focal | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-12 00:58:36.055011 | ubuntu-focal | "stat": { 2026-08-12 00:58:36.055030 | ubuntu-focal | "atime": 1786496309.1890793, 2026-08-12 00:58:36.055048 | ubuntu-focal | "attr_flags": "e", 2026-08-12 00:58:36.055066 | ubuntu-focal | "attributes": [ 2026-08-12 00:58:36.055084 | ubuntu-focal | "extents" 2026-08-12 00:58:36.055101 | ubuntu-focal | ], 2026-08-12 00:58:36.055119 | ubuntu-focal | "block_size": 4096, 2026-08-12 00:58:36.055137 | ubuntu-focal | "blocks": 8, 2026-08-12 00:58:36.055156 | ubuntu-focal | "charset": "binary", 2026-08-12 00:58:36.055185 | ubuntu-focal | "ctime": 1786496309.1890793, 2026-08-12 00:58:36.055210 | ubuntu-focal | "dev": 64513, 2026-08-12 00:58:36.055233 | ubuntu-focal | "device_type": 0, 2026-08-12 00:58:36.055344 | ubuntu-focal | "executable": true, 2026-08-12 00:58:36.055376 | ubuntu-focal | "exists": true, 2026-08-12 00:58:36.055396 | ubuntu-focal | "gid": 1000, 2026-08-12 00:58:36.055414 | ubuntu-focal | "gr_name": "zuul", 2026-08-12 00:58:36.055433 | ubuntu-focal | "inode": 1035293, 2026-08-12 00:58:36.055451 | ubuntu-focal | "isblk": false, 2026-08-12 00:58:36.055470 | ubuntu-focal | "ischr": false, 2026-08-12 00:58:36.055488 | ubuntu-focal | "isdir": true, 2026-08-12 00:58:36.055505 | ubuntu-focal | "isfifo": false, 2026-08-12 00:58:36.055523 | ubuntu-focal | "isgid": false, 2026-08-12 00:58:36.055540 | ubuntu-focal | "islnk": false, 2026-08-12 00:58:36.055558 | ubuntu-focal | "isreg": false, 2026-08-12 00:58:36.055575 | ubuntu-focal | "issock": false, 2026-08-12 00:58:36.055592 | ubuntu-focal | "isuid": false, 2026-08-12 00:58:36.055609 | ubuntu-focal | "mimetype": "inode/directory", 2026-08-12 00:58:36.055626 | ubuntu-focal | "mode": "0755", 2026-08-12 00:58:36.055642 | ubuntu-focal | "mtime": 1786496294.81834, 2026-08-12 00:58:36.055660 | ubuntu-focal | "nlink": 11, 2026-08-12 00:58:36.055677 | ubuntu-focal | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-08-12 00:58:36.055694 | ubuntu-focal | "pw_name": "zuul", 2026-08-12 00:58:36.055714 | ubuntu-focal | "readable": true, 2026-08-12 00:58:36.055733 | ubuntu-focal | "rgrp": true, 2026-08-12 00:58:36.055751 | ubuntu-focal | "roth": true, 2026-08-12 00:58:36.055769 | ubuntu-focal | "rusr": true, 2026-08-12 00:58:36.055786 | ubuntu-focal | "size": 4096, 2026-08-12 00:58:36.055804 | ubuntu-focal | "uid": 1000, 2026-08-12 00:58:36.055822 | ubuntu-focal | "version": "3802841199", 2026-08-12 00:58:36.055841 | ubuntu-focal | "wgrp": false, 2026-08-12 00:58:36.055860 | ubuntu-focal | "woth": false, 2026-08-12 00:58:36.055878 | ubuntu-focal | "writeable": true, 2026-08-12 00:58:36.055896 | ubuntu-focal | "wusr": true, 2026-08-12 00:58:36.055914 | ubuntu-focal | "xgrp": true, 2026-08-12 00:58:36.055932 | ubuntu-focal | "xoth": true, 2026-08-12 00:58:36.055950 | ubuntu-focal | "xusr": true 2026-08-12 00:58:36.055968 | ubuntu-focal | } 2026-08-12 00:58:36.055986 | ubuntu-focal | } 2026-08-12 00:58:36.056032 | ubuntu-focal | ok: All items complete 2026-08-12 00:58:36.056055 | 2026-08-12 00:58:36.057341 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:36.057962 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:36.073091 | 2026-08-12 00:58:36.073215 | LOOP [Switch "ansible_host" to private IP] 2026-08-12 00:58:36.444417 | ubuntu-focal | changed: 1 replacements made 2026-08-12 00:58:36.446331 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:36.448337 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:36.470578 | 2026-08-12 00:58:36.470885 | TASK [Run Molecule scenario] 2026-08-12 00:58:37.287248 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-08-12 00:58:38.019933 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-08-12 00:58:38.197537 | ubuntu-focal | Using CPython 3.13.7 2026-08-12 00:58:38.197632 | ubuntu-focal | Creating virtual environment at: .venv 2026-08-12 00:58:38.245453 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-08-12 00:58:38.249839 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-08-12 00:58:38.264461 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-08-12 00:58:38.428556 | ubuntu-focal | Downloading pygments 2026-08-12 00:58:38.491179 | ubuntu-focal | Downloading cryptography 2026-08-12 00:58:38.586715 | ubuntu-focal | Downloading ansible-core 2026-08-12 00:58:38.613020 | ubuntu-focal | Installed 36 packages in 25ms 2026-08-12 00:58:39.806419 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-08-12 00:58:39.806496 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-08-12 00:58:40.708605 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-08-12 00:58:40.708682 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-08-12 00:58:40.708863 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-12 00:58:40.708965 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-08-12 00:58:51.020492 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-08-12 00:58:51.020757 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-08-12 00:58:51.021090 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-08-12 00:58:51.021206 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-12 00:58:51.026979 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-08-12 00:58:51.027250 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-12 00:58:51.032252 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-08-12 00:58:51.032280 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-08-12 00:58:51.032351 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-08-12 00:58:51.037514 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-08-12 00:58:51.573288 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-08-12 00:58:51.573530 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-08-12 00:58:51.573748 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-08-12 00:58:51.573929 | ubuntu-focal | 2026-08-12 00:58:51.939041 | ubuntu-focal | 2026-08-12 00:58:51.939260 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-08-12 00:58:52.003013 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-08-12 00:58:52.013583 | ubuntu-focal | INFO [forget-package > create] Executing 2026-08-12 00:58:52.015124 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-12 00:58:52.020328 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-08-12 00:58:52.535302 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-08-12 00:58:52.535401 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-08-12 00:58:52.535422 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-08-12 00:58:52.535759 | ubuntu-focal | 2026-08-12 00:58:52.905628 | ubuntu-focal | 2026-08-12 00:58:52.905845 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-08-12 00:58:52.906115 | ubuntu-focal | 2026-08-12 00:58:52.906332 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-08-12 00:58:52.906558 | ubuntu-focal | Wednesday 12 August 2026 00:58:52 +0000 (0:00:00.030) 0:00:00.030 ****** 2026-08-12 00:58:53.397472 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.21/reference_appendices/interpreter_discovery.html for more information. 2026-08-12 00:58:53.397923 | ubuntu-focal | [ERROR]: Task failed: Action failed: The following modules failed to execute: ansible.legacy.setup. 2026-08-12 00:58:53.398150 | ubuntu-focal | 2026-08-12 00:58:53.398408 | ubuntu-focal | Task failed: Action failed. 2026-08-12 00:58:53.398601 | ubuntu-focal | 2026-08-12 00:58:53.398790 | ubuntu-focal | <<< caused by >>> 2026-08-12 00:58:53.398959 | ubuntu-focal | 2026-08-12 00:58:53.399148 | ubuntu-focal | The following modules failed to execute: ansible.legacy.setup. 2026-08-12 00:58:53.399311 | ubuntu-focal | 2026-08-12 00:58:53.399488 | ubuntu-focal | +--[ Sub-Event 1 of 1 ]--- 2026-08-12 00:58:53.399722 | ubuntu-focal | | 2026-08-12 00:58:53.399954 | ubuntu-focal | | Ansible requires Python 3.9 or newer on the target. Current version: 3.8.10 (default, Mar 18 2025, 20:04:55) [GCC 9.4.0] 2026-08-12 00:58:53.400118 | ubuntu-focal | | 2026-08-12 00:58:53.400318 | ubuntu-focal | +--[ End Sub-Event ]--- 2026-08-12 00:58:53.400500 | ubuntu-focal | 2026-08-12 00:58:53.400903 | ubuntu-focal | fatal: [ubuntu-focal]: FAILED! => {"ansible_facts": {}, "changed": false, "failed_modules": {"ansible.legacy.setup": {"ansible_facts": {"discovered_interpreter_python": "/usr/bin/python3"}, "changed": false, "deprecations": [], "exception": "(traceback unavailable)", "failed": true, "msg": "Ansible requires Python 3.9 or newer on the target. Current version: 3.8.10 (default, Mar 18 2025, 20:04:55) [GCC 9.4.0]", "warnings": ["Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3', but future installation of another Python interpreter could cause a different interpreter to be discovered."]}}, "msg": "The following modules failed to execute: ansible.legacy.setup."} 2026-08-12 00:58:53.401114 | ubuntu-focal | 2026-08-12 00:58:53.401293 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-08-12 00:58:53.401524 | ubuntu-focal | ubuntu-focal : ok=0 changed=0 unreachable=0 failed=1 skipped=0 rescued=0 ignored=0 2026-08-12 00:58:53.401770 | ubuntu-focal | 2026-08-12 00:58:53.401940 | ubuntu-focal | 2026-08-12 00:58:53.402124 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-08-12 00:58:53.402315 | ubuntu-focal | Wednesday 12 August 2026 00:58:53 +0000 (0:00:00.494) 0:00:00.525 ****** 2026-08-12 00:58:53.402490 | ubuntu-focal | =============================================================================== 2026-08-12 00:58:53.402670 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 0.49s 2026-08-12 00:58:53.486979 | ubuntu-focal | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.forget-package/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/prepare.yml 2026-08-12 00:58:53.487185 | ubuntu-focal | ERROR [forget-package > prepare] Executed: Failed 2026-08-12 00:58:53.487339 | ubuntu-focal | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.forget-package/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/prepare.yml 2026-08-12 00:58:54.033892 | ubuntu-focal | ERROR 2026-08-12 00:58:54.034177 | ubuntu-focal | { 2026-08-12 00:58:54.034219 | ubuntu-focal | "delta": "0:00:16.739339", 2026-08-12 00:58:54.034248 | ubuntu-focal | "end": "2026-08-12 00:58:53.561681", 2026-08-12 00:58:54.034275 | ubuntu-focal | "msg": "non-zero return code", 2026-08-12 00:58:54.034299 | ubuntu-focal | "rc": 2, 2026-08-12 00:58:54.034324 | ubuntu-focal | "start": "2026-08-12 00:58:36.822342" 2026-08-12 00:58:54.034348 | ubuntu-focal | } failure 2026-08-12 00:58:54.036936 | 2026-08-12 00:58:54.037016 | PLAY RECAP 2026-08-12 00:58:54.037077 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-12 00:58:54.037107 | 2026-08-12 00:58:54.196321 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-12 00:58:54.199080 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 00:58:54.819624 | 2026-08-12 00:58:54.819779 | PLAY [all] 2026-08-12 00:58:54.831295 | 2026-08-12 00:58:54.831382 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-12 00:58:54.876902 | ubuntu-focal | skipping: Conditional result was False 2026-08-12 00:58:54.885516 | 2026-08-12 00:58:54.885653 | TASK [fetch-output : Set log path for single node] 2026-08-12 00:58:54.929578 | ubuntu-focal | ok 2026-08-12 00:58:54.937052 | 2026-08-12 00:58:54.937146 | LOOP [fetch-output : Ensure local output dirs] 2026-08-12 00:58:55.302699 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/logs" 2026-08-12 00:58:55.504207 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/artifacts" 2026-08-12 00:58:55.718043 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/2042d0f2f3db459cb0d86cc73cfe4990/work/docs" 2026-08-12 00:58:55.739309 | 2026-08-12 00:58:55.739425 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-12 00:58:56.357835 | ubuntu-focal | changed: .d..t...... ./ 2026-08-12 00:58:56.358160 | ubuntu-focal | changed: All items complete 2026-08-12 00:58:56.358240 | 2026-08-12 00:58:56.786349 | ubuntu-focal | changed: .d..t...... ./ 2026-08-12 00:58:57.201119 | ubuntu-focal | changed: .d..t...... ./ 2026-08-12 00:58:57.227463 | 2026-08-12 00:58:57.227591 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-12 00:58:57.651820 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.021447 2026-08-12 00:58:57.875584 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.006511 2026-08-12 00:58:57.895484 | 2026-08-12 00:58:57.895596 | PLAY [all] 2026-08-12 00:58:57.901517 | 2026-08-12 00:58:57.901587 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-12 00:58:58.279266 | ubuntu-focal | changed 2026-08-12 00:58:58.286889 | 2026-08-12 00:58:58.286941 | PLAY RECAP 2026-08-12 00:58:58.287094 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-12 00:58:58.287135 | 2026-08-12 00:58:58.398571 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 00:58:58.400939 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-12 00:58:58.959174 | 2026-08-12 00:58:58.959314 | PLAY [localhost] 2026-08-12 00:58:58.971021 | 2026-08-12 00:58:58.971188 | TASK [Generate Zuul manifest] 2026-08-12 00:58:58.993183 | localhost | ok 2026-08-12 00:58:59.009660 | 2026-08-12 00:58:59.009735 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-12 00:58:59.418190 | localhost | changed 2026-08-12 00:58:59.441349 | 2026-08-12 00:58:59.441459 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-12 00:58:59.475686 | localhost | ok 2026-08-12 00:58:59.483304 | 2026-08-12 00:58:59.483366 | TASK [Upload logs] 2026-08-12 00:58:59.505393 | localhost | ok 2026-08-12 00:58:59.566491 | 2026-08-12 00:58:59.566631 | TASK [Set zuul-log-path fact] 2026-08-12 00:58:59.588774 | localhost | ok 2026-08-12 00:58:59.600796 | 2026-08-12 00:58:59.600911 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 00:58:59.632463 | localhost | ok 2026-08-12 00:58:59.641153 | 2026-08-12 00:58:59.641239 | TASK [upload-logs : Create log directories] 2026-08-12 00:59:00.059105 | localhost | changed 2026-08-12 00:59:00.068781 | 2026-08-12 00:59:00.068902 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-12 00:59:00.469205 | localhost -> localhost | ok: Runtime: 0:00:00.004788 2026-08-12 00:59:00.475837 | 2026-08-12 00:59:00.475944 | TASK [upload-logs : Upload logs to log server] 2026-08-12 00:59:00.912420 | localhost | Output suppressed because no_log was given 2026-08-12 00:59:00.917519 | 2026-08-12 00:59:00.917607 | LOOP [upload-logs : Compress console log and json output] 2026-08-12 00:59:00.961874 | localhost | skipping: Conditional result was False 2026-08-12 00:59:00.969263 | localhost | skipping: Conditional result was False 2026-08-12 00:59:00.981716 | 2026-08-12 00:59:00.981845 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-12 00:59:01.025924 | localhost | skipping: Conditional result was False 2026-08-12 00:59:01.026391 | 2026-08-12 00:59:01.030383 | localhost | skipping: Conditional result was False 2026-08-12 00:59:01.046118 | 2026-08-12 00:59:01.046354 | LOOP [upload-logs : Upload console log and json output]