2026-09-12 00:55:32.692803 | Job console starting 2026-09-12 00:55:32.715216 | Updating git repos 2026-09-12 00:55:32.751609 | Cloning repos into workspace 2026-09-12 00:55:32.876637 | Restoring repo states 2026-09-12 00:55:32.885805 | Merging changes 2026-09-12 00:55:33.597057 | Checking out repos 2026-09-12 00:55:33.712163 | Preparing playbooks 2026-09-12 00:55:35.380310 | Running Ansible setup 2026-09-12 00:55:39.033221 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-12 00:55:39.608074 | 2026-09-12 00:55:39.608545 | PLAY [localhost] 2026-09-12 00:55:39.615342 | 2026-09-12 00:55:39.615406 | TASK [Gathering Facts] 2026-09-12 00:55:40.500902 | localhost | ok 2026-09-12 00:55:40.506961 | 2026-09-12 00:55:40.507035 | TASK [Setup log path fact] 2026-09-12 00:55:40.523809 | localhost | ok 2026-09-12 00:55:40.532908 | 2026-09-12 00:55:40.532986 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 00:55:40.569674 | localhost | ok 2026-09-12 00:55:40.576603 | 2026-09-12 00:55:40.576684 | TASK [emit-job-header : Print job information] 2026-09-12 00:55:40.604522 | # Job Information 2026-09-12 00:55:40.604665 | Ansible Version: 2.16.18 2026-09-12 00:55:40.604704 | Job: ansible-collection-containers-molecule-forget-package-debian-trixie 2026-09-12 00:55:40.604732 | Pipeline: check 2026-09-12 00:55:40.604756 | Executor: 2d72f0692154 2026-09-12 00:55:40.604780 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/150 2026-09-12 00:55:40.604808 | Event ID: c02f8e60-ae43-11f1-9f8b-a3c8ebe95043 2026-09-12 00:55:40.609029 | 2026-09-12 00:55:40.609196 | LOOP [emit-job-header : Print node information] 2026-09-12 00:55:40.712791 | localhost | ok: 2026-09-12 00:55:40.713288 | localhost | # Node Information 2026-09-12 00:55:40.713351 | localhost | Inventory Hostname: debian-trixie 2026-09-12 00:55:40.713395 | localhost | Hostname: np0000192654 2026-09-12 00:55:40.713434 | localhost | Username: zuul 2026-09-12 00:55:40.713482 | localhost | Distro: Debian 13.6 2026-09-12 00:55:40.713522 | localhost | Provider: yul1 2026-09-12 00:55:40.713560 | localhost | Region: ca-ymq-1 2026-09-12 00:55:40.713597 | localhost | Label: debian-trixie 2026-09-12 00:55:40.713634 | localhost | Product Name: OpenStack Nova 2026-09-12 00:55:40.713670 | localhost | Interface IP: 162.253.55.76 2026-09-12 00:55:40.728537 | 2026-09-12 00:55:40.728670 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-12 00:55:41.117323 | localhost -> localhost | changed 2026-09-12 00:55:41.121894 | 2026-09-12 00:55:41.121955 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-12 00:55:42.065186 | localhost -> localhost | changed 2026-09-12 00:55:42.079292 | 2026-09-12 00:55:42.079425 | PLAY [all] 2026-09-12 00:55:42.090849 | 2026-09-12 00:55:42.090934 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-12 00:55:42.348700 | debian-trixie -> localhost | ok 2026-09-12 00:55:42.358923 | 2026-09-12 00:55:42.359057 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-12 00:55:42.390840 | debian-trixie | ok 2026-09-12 00:55:42.412921 | debian-trixie | included: /var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-12 00:55:42.418367 | 2026-09-12 00:55:42.418443 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-12 00:55:43.634735 | debian-trixie -> localhost | Generating public/private rsa key pair. 2026-09-12 00:55:43.635018 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/5e71b0c06dc94a5990a9e61dc0ac6e12_id_rsa 2026-09-12 00:55:43.635081 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/5e71b0c06dc94a5990a9e61dc0ac6e12_id_rsa.pub 2026-09-12 00:55:43.635127 | debian-trixie -> localhost | The key fingerprint is: 2026-09-12 00:55:43.635170 | debian-trixie -> localhost | SHA256:oB4wM5ix0Omvi5jz03m074kQooEtb6BXNh54kjJ62nQ zuul-build-sshkey 2026-09-12 00:55:43.635230 | debian-trixie -> localhost | The key's randomart image is: 2026-09-12 00:55:43.635302 | debian-trixie -> localhost | +---[RSA 3072]----+ 2026-09-12 00:55:43.635355 | debian-trixie -> localhost | |o. . | 2026-09-12 00:55:43.635399 | debian-trixie -> localhost | |.=o | 2026-09-12 00:55:43.635440 | debian-trixie -> localhost | |+.= . | 2026-09-12 00:55:43.635482 | debian-trixie -> localhost | |...B . . | 2026-09-12 00:55:43.635522 | debian-trixie -> localhost | |B *.X S | 2026-09-12 00:55:43.635562 | debian-trixie -> localhost | |oO O.=. | 2026-09-12 00:55:43.635602 | debian-trixie -> localhost | |+ *oEo . | 2026-09-12 00:55:43.635642 | debian-trixie -> localhost | |oXo.o.o. . | 2026-09-12 00:55:43.635688 | debian-trixie -> localhost | |=o+o ..o+ | 2026-09-12 00:55:43.635728 | debian-trixie -> localhost | +----[SHA256]-----+ 2026-09-12 00:55:43.635841 | debian-trixie -> localhost | ok: Runtime: 0:00:00.769612 2026-09-12 00:55:43.643957 | 2026-09-12 00:55:43.644081 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-12 00:55:43.665726 | debian-trixie | ok 2026-09-12 00:55:43.679892 | debian-trixie | included: /var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-12 00:55:43.687629 | 2026-09-12 00:55:43.687706 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-12 00:55:43.711873 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:43.720378 | 2026-09-12 00:55:43.720531 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-12 00:55:44.258794 | debian-trixie | changed 2026-09-12 00:55:44.266384 | 2026-09-12 00:55:44.266511 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-12 00:55:44.491889 | debian-trixie | ok 2026-09-12 00:55:44.501512 | 2026-09-12 00:55:44.501637 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-12 00:55:45.099028 | debian-trixie | changed 2026-09-12 00:55:45.104932 | 2026-09-12 00:55:45.105019 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-12 00:55:45.713211 | debian-trixie | changed 2026-09-12 00:55:45.718195 | 2026-09-12 00:55:45.718292 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-12 00:55:45.742503 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:45.750680 | 2026-09-12 00:55:45.750811 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-12 00:55:46.140124 | debian-trixie -> localhost | changed 2026-09-12 00:55:46.155346 | 2026-09-12 00:55:46.155482 | TASK [add-build-sshkey : Add back temp key] 2026-09-12 00:55:46.457028 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/5e71b0c06dc94a5990a9e61dc0ac6e12_id_rsa (zuul-build-sshkey) 2026-09-12 00:55:46.457336 | debian-trixie -> localhost | ok: Runtime: 0:00:00.017476 2026-09-12 00:55:46.464765 | 2026-09-12 00:55:46.464888 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-12 00:55:46.891927 | debian-trixie | ok 2026-09-12 00:55:46.906424 | 2026-09-12 00:55:46.906642 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-12 00:55:46.935349 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:46.954348 | 2026-09-12 00:55:46.954483 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-12 00:55:47.363663 | debian-trixie | ok 2026-09-12 00:55:47.373855 | 2026-09-12 00:55:47.374000 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-12 00:55:48.176528 | debian-trixie | Output suppressed because no_log was given 2026-09-12 00:55:48.190464 | 2026-09-12 00:55:48.190592 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-12 00:55:48.442041 | debian-trixie | ok: "logs" 2026-09-12 00:55:48.442438 | debian-trixie | ok: All items complete 2026-09-12 00:55:48.442495 | 2026-09-12 00:55:48.715408 | debian-trixie | ok: "artifacts" 2026-09-12 00:55:48.928560 | debian-trixie | ok: "docs" 2026-09-12 00:55:48.946509 | 2026-09-12 00:55:48.946685 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-12 00:55:49.186760 | debian-trixie | changed: "logs" 2026-09-12 00:55:49.404266 | debian-trixie | changed: "artifacts" 2026-09-12 00:55:49.643757 | debian-trixie | changed: "docs" 2026-09-12 00:55:49.659487 | 2026-09-12 00:55:49.659678 | PLAY RECAP 2026-09-12 00:55:49.659803 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-12 00:55:49.659871 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 00:55:49.659917 | 2026-09-12 00:55:49.804650 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-12 00:55:49.805717 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-12 00:55:50.380605 | 2026-09-12 00:55:50.380772 | PLAY [all] 2026-09-12 00:55:50.390939 | 2026-09-12 00:55:50.391018 | TASK [setup-uv : Extract archive] 2026-09-12 00:55:52.819354 | debian-trixie | changed 2026-09-12 00:55:52.825988 | 2026-09-12 00:55:52.826097 | TASK [setup-uv : Print version] 2026-09-12 00:55:53.218374 | debian-trixie | uv 0.8.13 2026-09-12 00:55:53.354798 | debian-trixie | ok: Runtime: 0:00:00.017074 2026-09-12 00:55:53.369832 | 2026-09-12 00:55:53.369984 | TASK [Install Ansible collection siblings] 2026-09-12 00:55:53.819481 | debian-trixie | ok: 2026-09-12 00:55:53.819734 | debian-trixie | Skipping ansible.posix: no checked-out sibling 2026-09-12 00:55:53.819790 | debian-trixie | Skipping community.general: no checked-out sibling 2026-09-12 00:55:53.822845 | 2026-09-12 00:55:53.822936 | PLAY RECAP 2026-09-12 00:55:53.823016 | debian-trixie | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 00:55:53.823057 | 2026-09-12 00:55:53.953778 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-12 00:55:53.955981 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-12 00:55:54.510186 | 2026-09-12 00:55:54.510338 | PLAY [all] 2026-09-12 00:55:54.519914 | 2026-09-12 00:55:54.519993 | LOOP [Check inventory directories] 2026-09-12 00:55:54.866943 | debian-trixie | ok: "src/github.com/vexxhost/ansible-collection-containers" 2026-09-12 00:55:55.043290 | debian-trixie | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/forget-package/inventory" 2026-09-12 00:55:55.215878 | debian-trixie | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/inventory" 2026-09-12 00:55:55.222348 | 2026-09-12 00:55:55.222537 | LOOP [Copy inventory file for Zuul] 2026-09-12 00:55:56.210148 | debian-trixie | changed: 2026-09-12 00:55:56.210469 | debian-trixie | { 2026-09-12 00:55:56.210526 | debian-trixie | "ansible_loop_var": "item", 2026-09-12 00:55:56.210571 | debian-trixie | "changed": false, 2026-09-12 00:55:56.210609 | debian-trixie | "failed": false, 2026-09-12 00:55:56.210652 | debian-trixie | "invocation": { 2026-09-12 00:55:56.210689 | debian-trixie | "module_args": { 2026-09-12 00:55:56.210724 | debian-trixie | "checksum_algorithm": "sha1", 2026-09-12 00:55:56.210758 | debian-trixie | "follow": true, 2026-09-12 00:55:56.210793 | debian-trixie | "get_attributes": true, 2026-09-12 00:55:56.210829 | debian-trixie | "get_checksum": true, 2026-09-12 00:55:56.210863 | debian-trixie | "get_mime": true, 2026-09-12 00:55:56.210897 | debian-trixie | "path": "src/github.com/vexxhost/ansible-collection-containers" 2026-09-12 00:55:56.210934 | debian-trixie | } 2026-09-12 00:55:56.210968 | debian-trixie | }, 2026-09-12 00:55:56.211022 | debian-trixie | "item": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-12 00:55:56.211058 | debian-trixie | "stat": { 2026-09-12 00:55:56.211092 | debian-trixie | "atime": 1789174548.0457368, 2026-09-12 00:55:56.211126 | debian-trixie | "attr_flags": "e", 2026-09-12 00:55:56.211160 | debian-trixie | "attributes": [ 2026-09-12 00:55:56.211192 | debian-trixie | "extents" 2026-09-12 00:55:56.211243 | debian-trixie | ], 2026-09-12 00:55:56.211279 | debian-trixie | "block_size": 4096, 2026-09-12 00:55:56.211312 | debian-trixie | "blocks": 8, 2026-09-12 00:55:56.211345 | debian-trixie | "charset": "unknown", 2026-09-12 00:55:56.211379 | debian-trixie | "ctime": 1789174548.061738, 2026-09-12 00:55:56.211412 | debian-trixie | "dev": 65025, 2026-09-12 00:55:56.211444 | debian-trixie | "device_type": 0, 2026-09-12 00:55:56.211476 | debian-trixie | "executable": true, 2026-09-12 00:55:56.211507 | debian-trixie | "exists": true, 2026-09-12 00:55:56.211538 | debian-trixie | "gid": 1000, 2026-09-12 00:55:56.211570 | debian-trixie | "gr_name": "zuul", 2026-09-12 00:55:56.211603 | debian-trixie | "inode": 521495, 2026-09-12 00:55:56.211636 | debian-trixie | "isblk": false, 2026-09-12 00:55:56.211669 | debian-trixie | "ischr": false, 2026-09-12 00:55:56.211701 | debian-trixie | "isdir": true, 2026-09-12 00:55:56.211733 | debian-trixie | "isfifo": false, 2026-09-12 00:55:56.211765 | debian-trixie | "isgid": false, 2026-09-12 00:55:56.211797 | debian-trixie | "islnk": false, 2026-09-12 00:55:56.211829 | debian-trixie | "isreg": false, 2026-09-12 00:55:56.211861 | debian-trixie | "issock": false, 2026-09-12 00:55:56.211893 | debian-trixie | "isuid": false, 2026-09-12 00:55:56.211925 | debian-trixie | "mimetype": "unknown", 2026-09-12 00:55:56.211956 | debian-trixie | "mode": "0755", 2026-09-12 00:55:56.211987 | debian-trixie | "mtime": 1789174532.916864, 2026-09-12 00:55:56.212019 | debian-trixie | "nlink": 11, 2026-09-12 00:55:56.212051 | debian-trixie | "path": "src/github.com/vexxhost/ansible-collection-containers", 2026-09-12 00:55:56.212084 | debian-trixie | "pw_name": "zuul", 2026-09-12 00:55:56.212122 | debian-trixie | "readable": true, 2026-09-12 00:55:56.212155 | debian-trixie | "rgrp": true, 2026-09-12 00:55:56.212188 | debian-trixie | "roth": true, 2026-09-12 00:55:56.212240 | debian-trixie | "rusr": true, 2026-09-12 00:55:56.212277 | debian-trixie | "size": 4096, 2026-09-12 00:55:56.212311 | debian-trixie | "uid": 1000, 2026-09-12 00:55:56.212343 | debian-trixie | "version": "2769499897", 2026-09-12 00:55:56.212377 | debian-trixie | "wgrp": false, 2026-09-12 00:55:56.212413 | debian-trixie | "woth": false, 2026-09-12 00:55:56.212447 | debian-trixie | "writeable": true, 2026-09-12 00:55:56.212480 | debian-trixie | "wusr": true, 2026-09-12 00:55:56.212547 | debian-trixie | "xgrp": true, 2026-09-12 00:55:56.212583 | debian-trixie | "xoth": true, 2026-09-12 00:55:56.212616 | debian-trixie | "xusr": true 2026-09-12 00:55:56.212649 | debian-trixie | } 2026-09-12 00:55:56.212683 | debian-trixie | } 2026-09-12 00:55:56.212746 | debian-trixie | ok: All items complete 2026-09-12 00:55:56.212789 | 2026-09-12 00:55:56.215131 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:56.217603 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:56.229909 | 2026-09-12 00:55:56.230046 | LOOP [Switch "ansible_host" to private IP] 2026-09-12 00:55:56.622915 | debian-trixie | changed: 1 replacements made 2026-09-12 00:55:56.624967 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:56.632368 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:55:56.645609 | 2026-09-12 00:55:56.645683 | TASK [Run Molecule scenario] 2026-09-12 00:55:57.083358 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-09-12 00:55:57.083472 | debian-trixie | Creating virtual environment at: .venv 2026-09-12 00:55:58.306370 | debian-trixie | Downloading cryptography (4.3MiB) 2026-09-12 00:55:58.306702 | debian-trixie | Downloading ansible-core (2.3MiB) 2026-09-12 00:55:58.310564 | debian-trixie | Downloading pygments (1.2MiB) 2026-09-12 00:55:58.492650 | debian-trixie | Downloading cryptography 2026-09-12 00:55:58.549627 | debian-trixie | Downloading pygments 2026-09-12 00:55:58.715707 | debian-trixie | Downloading ansible-core 2026-09-12 00:55:58.766138 | debian-trixie | Installed 36 packages in 49ms 2026-09-12 00:55:59.389947 | debian-trixie | INFO Collection 'vexxhost.containers' detected. 2026-09-12 00:55:59.390030 | debian-trixie | INFO Scenarios will be used from 'extensions/molecule' 2026-09-12 00:56:00.331587 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-09-12 00:56:00.331715 | debian-trixie | INFO default scenario not found, disabling shared state. 2026-09-12 00:56:00.331726 | debian-trixie | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-12 00:56:00.331842 | debian-trixie | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-09-12 00:56:55.328478 | debian-trixie | INFO [forget-package > dependency] Executing 2026-09-12 00:56:55.328585 | debian-trixie | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-09-12 00:56:55.328598 | debian-trixie | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-09-12 00:56:55.328644 | debian-trixie | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-12 00:56:55.338968 | debian-trixie | INFO [forget-package > cleanup] Executing 2026-09-12 00:56:55.339534 | debian-trixie | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-12 00:56:55.351138 | debian-trixie | INFO [forget-package > destroy] Executing 2026-09-12 00:56:55.351314 | debian-trixie | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-09-12 00:56:55.351516 | debian-trixie | INFO [forget-package > destroy] Executed: Successful 2026-09-12 00:56:55.362681 | debian-trixie | INFO [forget-package > syntax] Executing 2026-09-12 00:56:55.898883 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-09-12 00:56:55.899390 | debian-trixie | [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-09-12 00:56:55.899732 | debian-trixie | 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-09-12 00:56:55.900119 | debian-trixie | 2026-09-12 00:56:56.224089 | debian-trixie | 2026-09-12 00:56:56.224233 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-09-12 00:56:56.284641 | debian-trixie | INFO [forget-package > syntax] Executed: Successful 2026-09-12 00:56:56.298163 | debian-trixie | INFO [forget-package > create] Executing 2026-09-12 00:56:56.301447 | debian-trixie | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-12 00:56:56.315027 | debian-trixie | INFO [forget-package > prepare] Executing 2026-09-12 00:56:56.836412 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-09-12 00:56:56.836587 | debian-trixie | [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-09-12 00:56:56.836802 | debian-trixie | 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-09-12 00:56:56.836948 | debian-trixie | 2026-09-12 00:56:57.161050 | debian-trixie | 2026-09-12 00:56:57.161423 | debian-trixie | PLAY [Prepare] ***************************************************************** 2026-09-12 00:56:57.161648 | debian-trixie | 2026-09-12 00:56:57.161891 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-09-12 00:56:57.162152 | debian-trixie | Saturday 12 September 2026 00:56:57 +0000 (0:00:00.028) 0:00:00.028 **** 2026-09-12 00:56:58.495175 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-09-12 00:56:58.498185 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:56:58.498341 | debian-trixie | 2026-09-12 00:56:58.498504 | debian-trixie | TASK [Install NGINX] *********************************************************** 2026-09-12 00:56:58.498677 | debian-trixie | Saturday 12 September 2026 00:56:58 +0000 (0:00:01.337) 0:00:01.365 **** 2026-09-12 00:57:09.544192 | debian-trixie | changed: [debian-trixie] 2026-09-12 00:57:09.544274 | debian-trixie | 2026-09-12 00:57:09.544483 | debian-trixie | TASK [Ensure NGINX is running] ************************************************* 2026-09-12 00:57:09.544655 | debian-trixie | Saturday 12 September 2026 00:57:09 +0000 (0:00:11.044) 0:00:12.410 **** 2026-09-12 00:57:10.331300 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:10.331387 | debian-trixie | 2026-09-12 00:57:10.331581 | debian-trixie | PLAY RECAP ********************************************************************* 2026-09-12 00:57:10.331829 | debian-trixie | debian-trixie : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-12 00:57:10.332022 | debian-trixie | 2026-09-12 00:57:10.332179 | debian-trixie | 2026-09-12 00:57:10.332357 | debian-trixie | TASKS RECAP ******************************************************************** 2026-09-12 00:57:10.332539 | debian-trixie | Saturday 12 September 2026 00:57:10 +0000 (0:00:00.788) 0:00:13.199 **** 2026-09-12 00:57:10.332698 | debian-trixie | =============================================================================== 2026-09-12 00:57:10.332871 | debian-trixie | Install NGINX ---------------------------------------------------------- 11.04s 2026-09-12 00:57:10.333099 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.34s 2026-09-12 00:57:10.333257 | debian-trixie | Ensure NGINX is running ------------------------------------------------- 0.79s 2026-09-12 00:57:10.433158 | debian-trixie | INFO [forget-package > prepare] Executed: Successful 2026-09-12 00:57:10.444777 | debian-trixie | INFO [forget-package > converge] Executing 2026-09-12 00:57:10.995619 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-09-12 00:57:10.995695 | debian-trixie | [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-09-12 00:57:10.995911 | debian-trixie | 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-09-12 00:57:10.996009 | debian-trixie | 2026-09-12 00:57:11.307161 | debian-trixie | 2026-09-12 00:57:11.307249 | debian-trixie | PLAY [Converge] **************************************************************** 2026-09-12 00:57:11.307334 | debian-trixie | 2026-09-12 00:57:11.307457 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-09-12 00:57:11.307579 | debian-trixie | Saturday 12 September 2026 00:57:11 +0000 (0:00:00.008) 0:00:00.008 **** 2026-09-12 00:57:12.455657 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-09-12 00:57:12.460587 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:12.460748 | debian-trixie | 2026-09-12 00:57:12.460935 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-12 00:57:12.461146 | debian-trixie | Saturday 12 September 2026 00:57:12 +0000 (0:00:01.151) 0:00:01.160 **** 2026-09-12 00:57:12.939212 | debian-trixie | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-12 00:57:12.943926 | debian-trixie | changed: [debian-trixie] 2026-09-12 00:57:12.944120 | debian-trixie | 2026-09-12 00:57:12.944302 | debian-trixie | PLAY RECAP ********************************************************************* 2026-09-12 00:57:12.944495 | debian-trixie | debian-trixie : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-12 00:57:12.944653 | debian-trixie | 2026-09-12 00:57:12.944805 | debian-trixie | 2026-09-12 00:57:12.945016 | debian-trixie | TASKS RECAP ******************************************************************** 2026-09-12 00:57:12.945186 | debian-trixie | Saturday 12 September 2026 00:57:12 +0000 (0:00:00.485) 0:00:01.645 **** 2026-09-12 00:57:12.945346 | debian-trixie | =============================================================================== 2026-09-12 00:57:12.945512 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.15s 2026-09-12 00:57:12.945679 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-09-12 00:57:13.071241 | debian-trixie | INFO [forget-package > converge] Executed: Successful 2026-09-12 00:57:13.082369 | debian-trixie | INFO [forget-package > idempotence] Executing 2026-09-12 00:57:13.577237 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-09-12 00:57:13.577318 | debian-trixie | [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-09-12 00:57:13.577506 | debian-trixie | 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-09-12 00:57:13.577619 | debian-trixie | 2026-09-12 00:57:13.862449 | debian-trixie | 2026-09-12 00:57:13.862535 | debian-trixie | PLAY [Converge] **************************************************************** 2026-09-12 00:57:13.862677 | debian-trixie | 2026-09-12 00:57:13.862825 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-09-12 00:57:13.862957 | debian-trixie | Saturday 12 September 2026 00:57:13 +0000 (0:00:00.008) 0:00:00.008 **** 2026-09-12 00:57:14.981483 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-09-12 00:57:14.984950 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:14.985114 | debian-trixie | 2026-09-12 00:57:14.985280 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-12 00:57:14.985429 | debian-trixie | Saturday 12 September 2026 00:57:14 +0000 (0:00:01.122) 0:00:01.130 **** 2026-09-12 00:57:15.464449 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:15.464555 | debian-trixie | 2026-09-12 00:57:15.464761 | debian-trixie | PLAY RECAP ********************************************************************* 2026-09-12 00:57:15.464963 | debian-trixie | debian-trixie : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-12 00:57:15.465143 | debian-trixie | 2026-09-12 00:57:15.465286 | debian-trixie | 2026-09-12 00:57:15.465492 | debian-trixie | TASKS RECAP ******************************************************************** 2026-09-12 00:57:15.465713 | debian-trixie | Saturday 12 September 2026 00:57:15 +0000 (0:00:00.479) 0:00:01.610 **** 2026-09-12 00:57:15.465871 | debian-trixie | =============================================================================== 2026-09-12 00:57:15.466086 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.12s 2026-09-12 00:57:15.466364 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.48s 2026-09-12 00:57:15.607775 | debian-trixie | INFO [forget-package > idempotence] Executed: Successful 2026-09-12 00:57:15.620858 | debian-trixie | INFO [forget-package > side_effect] Executing 2026-09-12 00:57:15.621636 | debian-trixie | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-12 00:57:15.635329 | debian-trixie | INFO [forget-package > verify] Executing 2026-09-12 00:57:16.185010 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-09-12 00:57:16.185065 | debian-trixie | [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-09-12 00:57:16.185162 | debian-trixie | 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-09-12 00:57:16.185236 | debian-trixie | 2026-09-12 00:57:16.489109 | debian-trixie | 2026-09-12 00:57:16.489220 | debian-trixie | PLAY [Verify] ****************************************************************** 2026-09-12 00:57:16.489396 | debian-trixie | 2026-09-12 00:57:16.489600 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-09-12 00:57:16.489740 | debian-trixie | Saturday 12 September 2026 00:57:16 +0000 (0:00:00.008) 0:00:00.008 **** 2026-09-12 00:57:17.665077 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-09-12 00:57:17.669545 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:17.669704 | debian-trixie | 2026-09-12 00:57:17.669888 | debian-trixie | TASK [Populate package facts] ************************************************** 2026-09-12 00:57:17.670099 | debian-trixie | Saturday 12 September 2026 00:57:17 +0000 (0:00:01.179) 0:00:01.187 **** 2026-09-12 00:57:19.420258 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:19.420333 | debian-trixie | 2026-09-12 00:57:19.420363 | debian-trixie | TASK [Populate service facts] ************************************************** 2026-09-12 00:57:19.420415 | debian-trixie | Saturday 12 September 2026 00:57:19 +0000 (0:00:01.750) 0:00:02.937 **** 2026-09-12 00:57:23.732762 | debian-trixie | ok: [debian-trixie] 2026-09-12 00:57:23.733105 | debian-trixie | 2026-09-12 00:57:23.733427 | debian-trixie | TASK [Assert that the NGINX package is not installed] ************************** 2026-09-12 00:57:23.733732 | debian-trixie | Saturday 12 September 2026 00:57:23 +0000 (0:00:04.311) 0:00:07.249 **** 2026-09-12 00:57:23.776324 | debian-trixie | ok: [debian-trixie] => { 2026-09-12 00:57:23.776462 | debian-trixie | "changed": false, 2026-09-12 00:57:23.776637 | debian-trixie | "msg": "All assertions passed" 2026-09-12 00:57:23.776802 | debian-trixie | } 2026-09-12 00:57:23.776961 | debian-trixie | 2026-09-12 00:57:23.777173 | debian-trixie | TASK [Assert that the NGINX service is still up] ******************************* 2026-09-12 00:57:23.777337 | debian-trixie | Saturday 12 September 2026 00:57:23 +0000 (0:00:00.046) 0:00:07.295 **** 2026-09-12 00:57:23.817919 | debian-trixie | ok: [debian-trixie] => { 2026-09-12 00:57:23.817957 | debian-trixie | "changed": false, 2026-09-12 00:57:23.817963 | debian-trixie | "msg": "All assertions passed" 2026-09-12 00:57:23.817968 | debian-trixie | } 2026-09-12 00:57:23.817974 | debian-trixie | 2026-09-12 00:57:23.817980 | debian-trixie | PLAY RECAP ********************************************************************* 2026-09-12 00:57:23.817986 | debian-trixie | debian-trixie : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-09-12 00:57:23.817991 | debian-trixie | 2026-09-12 00:57:23.817995 | debian-trixie | 2026-09-12 00:57:23.818000 | debian-trixie | TASKS RECAP ******************************************************************** 2026-09-12 00:57:23.818005 | debian-trixie | Saturday 12 September 2026 00:57:23 +0000 (0:00:00.040) 0:00:07.335 **** 2026-09-12 00:57:23.818009 | debian-trixie | =============================================================================== 2026-09-12 00:57:23.818014 | debian-trixie | Populate service facts -------------------------------------------------- 4.31s 2026-09-12 00:57:23.818018 | debian-trixie | Populate package facts -------------------------------------------------- 1.75s 2026-09-12 00:57:23.818023 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.18s 2026-09-12 00:57:23.818028 | debian-trixie | Assert that the NGINX package is not installed -------------------------- 0.05s 2026-09-12 00:57:23.818046 | debian-trixie | Assert that the NGINX service is still up ------------------------------- 0.04s 2026-09-12 00:57:23.959915 | debian-trixie | INFO [forget-package > verify] Executed: Successful 2026-09-12 00:57:23.971899 | debian-trixie | INFO [forget-package > cleanup] Executing 2026-09-12 00:57:23.972598 | debian-trixie | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-12 00:57:23.983215 | debian-trixie | INFO [forget-package > destroy] Executing 2026-09-12 00:57:23.983407 | debian-trixie | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-09-12 00:57:23.983582 | debian-trixie | INFO [forget-package > destroy] Executed: Successful 2026-09-12 00:57:23.984160 | debian-trixie | WARNING Molecule executed 1 scenario (1 missing files) 2026-09-12 00:57:24.227794 | debian-trixie | ok: Runtime: 0:01:27.065950 2026-09-12 00:57:24.233760 | 2026-09-12 00:57:24.233856 | PLAY RECAP 2026-09-12 00:57:24.233954 | debian-trixie | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 00:57:24.234017 | 2026-09-12 00:57:24.394653 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-12 00:57:24.397162 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 00:57:24.956564 | 2026-09-12 00:57:24.956682 | PLAY [all] 2026-09-12 00:57:24.965791 | 2026-09-12 00:57:24.965877 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-12 00:57:25.020224 | debian-trixie | skipping: Conditional result was False 2026-09-12 00:57:25.025573 | 2026-09-12 00:57:25.025674 | TASK [fetch-output : Set log path for single node] 2026-09-12 00:57:25.067680 | debian-trixie | ok 2026-09-12 00:57:25.076638 | 2026-09-12 00:57:25.076791 | LOOP [fetch-output : Ensure local output dirs] 2026-09-12 00:57:25.462363 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/logs" 2026-09-12 00:57:25.683118 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/artifacts" 2026-09-12 00:57:25.911408 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/5e71b0c06dc94a5990a9e61dc0ac6e12/work/docs" 2026-09-12 00:57:25.926416 | 2026-09-12 00:57:25.926604 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-12 00:57:26.615710 | debian-trixie | ok 2026-09-12 00:57:26.616022 | debian-trixie | changed: All items complete 2026-09-12 00:57:26.616103 | 2026-09-12 00:57:27.121479 | debian-trixie | changed: .d..t...... ./ 2026-09-12 00:57:27.607804 | debian-trixie | changed: .d..t...... ./ 2026-09-12 00:57:27.629935 | 2026-09-12 00:57:27.630462 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-12 00:57:28.055963 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.007923 2026-09-12 00:57:28.471779 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.162759 2026-09-12 00:57:28.485017 | 2026-09-12 00:57:28.485195 | PLAY [all] 2026-09-12 00:57:28.494451 | 2026-09-12 00:57:28.494586 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-12 00:57:28.962018 | debian-trixie | changed 2026-09-12 00:57:28.976818 | 2026-09-12 00:57:28.977020 | PLAY RECAP 2026-09-12 00:57:28.977145 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-12 00:57:28.977193 | 2026-09-12 00:57:29.108029 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 00:57:29.110225 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-12 00:57:29.665868 | 2026-09-12 00:57:29.665983 | PLAY [localhost] 2026-09-12 00:57:29.675353 | 2026-09-12 00:57:29.675428 | TASK [Generate Zuul manifest] 2026-09-12 00:57:29.691852 | localhost | ok 2026-09-12 00:57:29.706641 | 2026-09-12 00:57:29.706751 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-12 00:57:30.178219 | localhost | changed 2026-09-12 00:57:30.188112 | 2026-09-12 00:57:30.188238 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-12 00:57:30.217575 | localhost | ok 2026-09-12 00:57:30.225859 | 2026-09-12 00:57:30.225939 | TASK [Upload logs] 2026-09-12 00:57:30.244301 | localhost | ok 2026-09-12 00:57:30.300574 | 2026-09-12 00:57:30.300693 | TASK [Set zuul-log-path fact] 2026-09-12 00:57:30.317405 | localhost | ok 2026-09-12 00:57:30.327753 | 2026-09-12 00:57:30.327821 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 00:57:30.354630 | localhost | ok 2026-09-12 00:57:30.361259 | 2026-09-12 00:57:30.361321 | TASK [upload-logs : Create log directories] 2026-09-12 00:57:30.746521 | localhost | changed 2026-09-12 00:57:30.758188 | 2026-09-12 00:57:30.758323 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-12 00:57:31.186606 | localhost -> localhost | ok: Runtime: 0:00:00.005298 2026-09-12 00:57:31.197759 | 2026-09-12 00:57:31.197899 | TASK [upload-logs : Upload logs to log server] 2026-09-12 00:57:31.778418 | localhost | Output suppressed because no_log was given 2026-09-12 00:57:31.785927 | 2026-09-12 00:57:31.786084 | LOOP [upload-logs : Compress console log and json output] 2026-09-12 00:57:31.851362 | localhost | skipping: Conditional result was False 2026-09-12 00:57:31.859126 | localhost | skipping: Conditional result was False 2026-09-12 00:57:31.878731 | 2026-09-12 00:57:31.878912 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-12 00:57:31.935742 | localhost | skipping: Conditional result was False 2026-09-12 00:57:31.936132 | 2026-09-12 00:57:31.941334 | localhost | skipping: Conditional result was False 2026-09-12 00:57:31.955730 | 2026-09-12 00:57:31.955923 | LOOP [upload-logs : Upload console log and json output]