2026-04-26 13:38:23.515720 | Job console starting 2026-04-26 13:38:23.528013 | Updating git repos 2026-04-26 13:38:23.560198 | Cloning repos into workspace 2026-04-26 13:38:23.639593 | Restoring repo states 2026-04-26 13:38:23.647471 | Merging changes 2026-04-26 13:38:23.957202 | Checking out repos 2026-04-26 13:38:23.993722 | Preparing playbooks 2026-04-26 13:38:25.268771 | Running Ansible setup 2026-04-26 13:38:28.783502 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-26 13:38:29.410554 | 2026-04-26 13:38:29.495895 | PLAY [localhost] 2026-04-26 13:38:29.510778 | 2026-04-26 13:38:29.510877 | TASK [Gathering Facts] 2026-04-26 13:38:30.459692 | localhost | ok 2026-04-26 13:38:30.467834 | 2026-04-26 13:38:30.467939 | TASK [Setup log path fact] 2026-04-26 13:38:30.492091 | localhost | ok 2026-04-26 13:38:30.509498 | 2026-04-26 13:38:30.509627 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-26 13:38:30.538709 | localhost | ok 2026-04-26 13:38:30.549400 | 2026-04-26 13:38:30.549547 | TASK [emit-job-header : Print job information] 2026-04-26 13:38:30.593071 | # Job Information 2026-04-26 13:38:30.593280 | Ansible Version: 2.16.16 2026-04-26 13:38:30.593327 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-04-26 13:38:30.593361 | Pipeline: check 2026-04-26 13:38:30.593389 | Executor: 0a8996d2b663 2026-04-26 13:38:30.593419 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/122 2026-04-26 13:38:30.593450 | Event ID: 1b10a210-4175-11f1-9d04-fb4ed4f3c7b1 2026-04-26 13:38:30.597381 | 2026-04-26 13:38:30.597476 | LOOP [emit-job-header : Print node information] 2026-04-26 13:38:30.689900 | localhost | ok: 2026-04-26 13:38:30.690121 | localhost | # Node Information 2026-04-26 13:38:30.690152 | localhost | Inventory Hostname: ubuntu-focal 2026-04-26 13:38:30.690178 | localhost | Hostname: np0000170304 2026-04-26 13:38:30.690199 | localhost | Username: zuul 2026-04-26 13:38:30.690221 | localhost | Distro: Ubuntu 20.04 2026-04-26 13:38:30.690241 | localhost | Provider: yul1 2026-04-26 13:38:30.690260 | localhost | Region: ca-ymq-1 2026-04-26 13:38:30.690278 | localhost | Label: ubuntu-focal 2026-04-26 13:38:30.690296 | localhost | Product Name: OpenStack Nova 2026-04-26 13:38:30.690315 | localhost | Interface IP: 199.204.45.157 2026-04-26 13:38:30.703765 | 2026-04-26 13:38:30.703933 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-26 13:38:31.087347 | localhost -> localhost | changed 2026-04-26 13:38:31.092433 | 2026-04-26 13:38:31.092577 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-26 13:38:32.666292 | localhost -> localhost | changed 2026-04-26 13:38:32.672605 | 2026-04-26 13:38:32.672666 | PLAY [all] 2026-04-26 13:38:32.680533 | 2026-04-26 13:38:32.680604 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-26 13:38:32.948160 | ubuntu-focal -> localhost | ok 2026-04-26 13:38:33.396009 | 2026-04-26 13:38:33.397251 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-26 13:38:33.427911 | ubuntu-focal | ok 2026-04-26 13:38:33.449435 | ubuntu-focal | included: /var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-26 13:38:33.465940 | 2026-04-26 13:38:33.466095 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-26 13:38:34.663602 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-04-26 13:38:34.663827 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/ed9a7f0118ba44d2bacc9189e3ea567a_id_rsa 2026-04-26 13:38:34.663869 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/ed9a7f0118ba44d2bacc9189e3ea567a_id_rsa.pub 2026-04-26 13:38:34.663898 | ubuntu-focal -> localhost | The key fingerprint is: 2026-04-26 13:38:34.663921 | ubuntu-focal -> localhost | SHA256:lK6nM6H7MUDBKeoF7ubhJG0wzecSjZQ9LuL3ZbU9BTQ zuul-build-sshkey 2026-04-26 13:38:34.663964 | ubuntu-focal -> localhost | The key's randomart image is: 2026-04-26 13:38:34.663986 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-04-26 13:38:34.664015 | ubuntu-focal -> localhost | | +.. .E | 2026-04-26 13:38:34.664043 | ubuntu-focal -> localhost | | .+ =. . .. | 2026-04-26 13:38:34.664065 | ubuntu-focal -> localhost | |.=.=.. o . | 2026-04-26 13:38:34.664093 | ubuntu-focal -> localhost | |=.*o+ o . . | 2026-04-26 13:38:34.664118 | ubuntu-focal -> localhost | |+=.=. S o . | 2026-04-26 13:38:34.664152 | ubuntu-focal -> localhost | |.B+....+ . o | 2026-04-26 13:38:34.664173 | ubuntu-focal -> localhost | |*.o...*.. . | 2026-04-26 13:38:34.664213 | ubuntu-focal -> localhost | | o ..o= | 2026-04-26 13:38:34.664237 | ubuntu-focal -> localhost | | .ooo | 2026-04-26 13:38:34.664266 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-04-26 13:38:34.664327 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.521600 2026-04-26 13:38:34.670509 | 2026-04-26 13:38:34.670601 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-26 13:38:34.706788 | ubuntu-focal | ok 2026-04-26 13:38:34.720475 | ubuntu-focal | included: /var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-26 13:38:34.729936 | 2026-04-26 13:38:34.730007 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-26 13:38:34.756038 | ubuntu-focal | skipping: Conditional result was False 2026-04-26 13:38:34.766941 | 2026-04-26 13:38:34.767028 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-26 13:38:35.276639 | ubuntu-focal | changed 2026-04-26 13:38:35.323835 | 2026-04-26 13:38:35.323930 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-26 13:38:35.518246 | ubuntu-focal | ok 2026-04-26 13:38:35.525771 | 2026-04-26 13:38:35.525848 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-26 13:38:36.001417 | ubuntu-focal | changed 2026-04-26 13:38:36.013937 | 2026-04-26 13:38:36.014021 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-26 13:38:36.480008 | ubuntu-focal | changed 2026-04-26 13:38:36.488759 | 2026-04-26 13:38:36.488830 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-26 13:38:36.512219 | ubuntu-focal | skipping: Conditional result was False 2026-04-26 13:38:36.520509 | 2026-04-26 13:38:36.520608 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-26 13:38:37.191324 | ubuntu-focal -> localhost | changed 2026-04-26 13:38:37.208535 | 2026-04-26 13:38:37.208734 | TASK [add-build-sshkey : Add back temp key] 2026-04-26 13:38:37.552628 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/ed9a7f0118ba44d2bacc9189e3ea567a_id_rsa (zuul-build-sshkey) 2026-04-26 13:38:37.552906 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.014557 2026-04-26 13:38:37.560389 | 2026-04-26 13:38:37.560497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-26 13:38:37.904897 | ubuntu-focal | ok 2026-04-26 13:38:37.923289 | 2026-04-26 13:38:37.928260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-26 13:38:37.957908 | ubuntu-focal | skipping: Conditional result was False 2026-04-26 13:38:37.969091 | 2026-04-26 13:38:37.969228 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-26 13:38:38.315483 | ubuntu-focal | ok 2026-04-26 13:38:38.323329 | 2026-04-26 13:38:38.323395 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-26 13:38:39.579477 | ubuntu-focal | Output suppressed because no_log was given 2026-04-26 13:38:39.601424 | 2026-04-26 13:38:39.601572 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-26 13:38:39.793263 | ubuntu-focal | ok: "logs" 2026-04-26 13:38:39.793556 | ubuntu-focal | ok: All items complete 2026-04-26 13:38:39.793595 | 2026-04-26 13:38:39.952887 | ubuntu-focal | ok: "artifacts" 2026-04-26 13:38:40.129157 | ubuntu-focal | ok: "docs" 2026-04-26 13:38:40.210534 | 2026-04-26 13:38:40.210643 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-26 13:38:40.387940 | ubuntu-focal | changed: "logs" 2026-04-26 13:38:40.583929 | ubuntu-focal | changed: "artifacts" 2026-04-26 13:38:40.706018 | ubuntu-focal | changed: "docs" 2026-04-26 13:38:40.737721 | 2026-04-26 13:38:40.737856 | PLAY RECAP 2026-04-26 13:38:40.737979 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-26 13:38:40.738046 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-26 13:38:40.738069 | 2026-04-26 13:38:40.945633 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-26 13:38:40.947318 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-26 13:38:41.616290 | 2026-04-26 13:38:41.616436 | PLAY [all] 2026-04-26 13:38:41.629422 | 2026-04-26 13:38:41.629519 | TASK [setup-uv : Extract archive] 2026-04-26 13:38:43.909928 | ubuntu-focal | changed 2026-04-26 13:38:43.973766 | 2026-04-26 13:38:43.973972 | TASK [setup-uv : Print version] 2026-04-26 13:38:44.405694 | ubuntu-focal | uv 0.8.13 2026-04-26 13:38:44.533791 | ubuntu-focal | ok: Runtime: 0:00:00.008004 2026-04-26 13:38:44.543482 | 2026-04-26 13:38:44.543552 | PLAY RECAP 2026-04-26 13:38:44.543618 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-26 13:38:44.543653 | 2026-04-26 13:38:44.702788 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-26 13:38:44.704123 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-26 13:38:45.324624 | 2026-04-26 13:38:45.324838 | PLAY [all] 2026-04-26 13:38:45.342035 | 2026-04-26 13:38:45.342663 | TASK [Copy inventory file for Zuul] 2026-04-26 13:38:46.189732 | ubuntu-focal | changed 2026-04-26 13:38:46.291139 | 2026-04-26 13:38:46.291319 | TASK [Switch "ansible_host" to private IP] 2026-04-26 13:38:46.550615 | ubuntu-focal | changed: 1 replacements made 2026-04-26 13:38:46.568143 | 2026-04-26 13:38:46.568264 | TASK [Run Molecule scenario] 2026-04-26 13:38:47.261540 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-26 13:38:47.979983 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-26 13:38:48.174938 | ubuntu-focal | Using CPython 3.13.7 2026-04-26 13:38:48.175052 | ubuntu-focal | Creating virtual environment at: .venv 2026-04-26 13:38:48.445186 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-04-26 13:38:48.446313 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-04-26 13:38:48.447765 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-04-26 13:38:48.597511 | ubuntu-focal | Downloading cryptography 2026-04-26 13:38:48.638593 | ubuntu-focal | Downloading pygments 2026-04-26 13:38:48.788110 | ubuntu-focal | Downloading ansible-core 2026-04-26 13:38:48.812076 | ubuntu-focal | Installed 36 packages in 23ms 2026-04-26 13:38:49.961284 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-04-26 13:38:49.961367 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-04-26 13:38:50.757315 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-26 13:38:50.757401 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-04-26 13:38:50.757744 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-26 13:38:50.757880 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-26 13:39:00.149891 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-04-26 13:39:00.150087 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-26 13:39:00.150366 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-26 13:39:00.150468 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-26 13:39:00.156603 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-26 13:39:00.156894 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-26 13:39:00.162672 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-26 13:39:00.162728 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-26 13:39:00.162739 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-26 13:39:00.168327 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-04-26 13:39:00.655041 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-26 13:39:00.655336 | 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-04-26 13:39:00.655620 | 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-04-26 13:39:00.655929 | ubuntu-focal | 2026-04-26 13:39:00.999407 | ubuntu-focal | 2026-04-26 13:39:00.999578 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-26 13:39:01.091673 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-04-26 13:39:01.102965 | ubuntu-focal | INFO [forget-package > create] Executing 2026-04-26 13:39:01.104283 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-26 13:39:01.109322 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-04-26 13:39:01.632077 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-26 13:39:01.632299 | 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-04-26 13:39:01.632531 | 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-04-26 13:39:01.632728 | ubuntu-focal | 2026-04-26 13:39:01.980793 | ubuntu-focal | 2026-04-26 13:39:01.980933 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-04-26 13:39:01.981139 | ubuntu-focal | 2026-04-26 13:39:01.981391 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-26 13:39:01.981590 | ubuntu-focal | Sunday 26 April 2026 13:39:01 +0000 (0:00:00.029) 0:00:00.029 ********** 2026-04-26 13:39:03.168701 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', 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-04-26 13:39:03.171787 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:03.171989 | ubuntu-focal | 2026-04-26 13:39:03.172192 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-04-26 13:39:03.172386 | ubuntu-focal | Sunday 26 April 2026 13:39:03 +0000 (0:00:01.191) 0:00:01.221 ********** 2026-04-26 13:39:33.693157 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-26 13:39:33.693408 | ubuntu-focal | 2026-04-26 13:39:33.693633 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-04-26 13:39:33.693978 | ubuntu-focal | Sunday 26 April 2026 13:39:33 +0000 (0:00:30.520) 0:00:31.741 ********** 2026-04-26 13:39:34.402268 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:34.402496 | ubuntu-focal | 2026-04-26 13:39:34.402794 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-26 13:39:34.403089 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-26 13:39:34.403347 | ubuntu-focal | 2026-04-26 13:39:34.403591 | ubuntu-focal | 2026-04-26 13:39:34.403880 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-26 13:39:34.404137 | ubuntu-focal | Sunday 26 April 2026 13:39:34 +0000 (0:00:00.710) 0:00:32.452 ********** 2026-04-26 13:39:34.404368 | ubuntu-focal | =============================================================================== 2026-04-26 13:39:34.404602 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 30.52s 2026-04-26 13:39:34.404836 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.19s 2026-04-26 13:39:34.405074 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.71s 2026-04-26 13:39:34.530670 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-04-26 13:39:35.157158 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-04-26 13:39:35.637102 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-26 13:39:35.637290 | 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-04-26 13:39:35.637550 | 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-04-26 13:39:35.637791 | ubuntu-focal | 2026-04-26 13:39:35.945563 | ubuntu-focal | 2026-04-26 13:39:35.945740 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-26 13:39:35.945914 | ubuntu-focal | 2026-04-26 13:39:35.946125 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-26 13:39:35.946290 | ubuntu-focal | Sunday 26 April 2026 13:39:35 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-04-26 13:39:37.011477 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', 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-04-26 13:39:37.014508 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:37.014639 | ubuntu-focal | 2026-04-26 13:39:37.014881 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-26 13:39:37.014977 | ubuntu-focal | Sunday 26 April 2026 13:39:37 +0000 (0:00:01.068) 0:00:01.076 ********** 2026-04-26 13:39:37.384783 | ubuntu-focal | [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-04-26 13:39:37.387483 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-26 13:39:37.387597 | ubuntu-focal | 2026-04-26 13:39:37.387749 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-26 13:39:37.387867 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-26 13:39:37.387970 | ubuntu-focal | 2026-04-26 13:39:37.388063 | ubuntu-focal | 2026-04-26 13:39:37.388188 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-26 13:39:37.388297 | ubuntu-focal | Sunday 26 April 2026 13:39:37 +0000 (0:00:00.374) 0:00:01.450 ********** 2026-04-26 13:39:37.388401 | ubuntu-focal | =============================================================================== 2026-04-26 13:39:37.388512 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.07s 2026-04-26 13:39:37.388640 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.37s 2026-04-26 13:39:37.523455 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-04-26 13:39:37.532694 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-04-26 13:39:38.117507 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-26 13:39:38.117697 | 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-04-26 13:39:38.117906 | 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-04-26 13:39:38.118106 | ubuntu-focal | 2026-04-26 13:39:38.421911 | ubuntu-focal | 2026-04-26 13:39:38.422005 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-26 13:39:38.422089 | ubuntu-focal | 2026-04-26 13:39:38.422177 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-26 13:39:38.422266 | ubuntu-focal | Sunday 26 April 2026 13:39:38 +0000 (0:00:00.008) 0:00:00.008 ********** 2026-04-26 13:39:39.496488 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', 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-04-26 13:39:39.499044 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:39.499157 | ubuntu-focal | 2026-04-26 13:39:39.499286 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-26 13:39:39.499420 | ubuntu-focal | Sunday 26 April 2026 13:39:39 +0000 (0:00:01.077) 0:00:01.086 ********** 2026-04-26 13:39:39.877203 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:39.877280 | ubuntu-focal | 2026-04-26 13:39:39.877393 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-26 13:39:39.877523 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-26 13:39:39.877628 | ubuntu-focal | 2026-04-26 13:39:39.877729 | ubuntu-focal | 2026-04-26 13:39:39.877844 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-26 13:39:39.877953 | ubuntu-focal | Sunday 26 April 2026 13:39:39 +0000 (0:00:00.378) 0:00:01.464 ********** 2026-04-26 13:39:39.878093 | ubuntu-focal | =============================================================================== 2026-04-26 13:39:39.878206 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-26 13:39:39.878319 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.38s 2026-04-26 13:39:40.007000 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-04-26 13:39:40.018428 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-04-26 13:39:40.018868 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-26 13:39:40.025365 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-04-26 13:39:40.552432 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-26 13:39:40.552643 | 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-04-26 13:39:40.552844 | 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-04-26 13:39:40.553008 | ubuntu-focal | 2026-04-26 13:39:40.855747 | ubuntu-focal | 2026-04-26 13:39:40.855871 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-04-26 13:39:40.856056 | ubuntu-focal | 2026-04-26 13:39:40.856301 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-26 13:39:40.856673 | ubuntu-focal | Sunday 26 April 2026 13:39:40 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-04-26 13:39:41.942658 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', 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-04-26 13:39:41.946324 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:41.946495 | ubuntu-focal | 2026-04-26 13:39:41.946690 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-04-26 13:39:41.946878 | ubuntu-focal | Sunday 26 April 2026 13:39:41 +0000 (0:00:01.090) 0:00:01.098 ********** 2026-04-26 13:39:44.369559 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:44.369658 | ubuntu-focal | 2026-04-26 13:39:44.369726 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-04-26 13:39:44.369851 | ubuntu-focal | Sunday 26 April 2026 13:39:44 +0000 (0:00:02.423) 0:00:03.521 ********** 2026-04-26 13:39:46.674975 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-26 13:39:46.675031 | ubuntu-focal | 2026-04-26 13:39:46.675042 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-26 13:39:46.675051 | ubuntu-focal | Sunday 26 April 2026 13:39:46 +0000 (0:00:02.304) 0:00:05.826 ********** 2026-04-26 13:39:46.700031 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-26 13:39:46.700800 | ubuntu-focal | "changed": false, 2026-04-26 13:39:46.700862 | ubuntu-focal | "msg": "All assertions passed" 2026-04-26 13:39:46.700870 | ubuntu-focal | } 2026-04-26 13:39:46.700876 | ubuntu-focal | 2026-04-26 13:39:46.700882 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-26 13:39:46.700888 | ubuntu-focal | Sunday 26 April 2026 13:39:46 +0000 (0:00:00.025) 0:00:05.852 ********** 2026-04-26 13:39:46.729324 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-26 13:39:46.729544 | ubuntu-focal | "changed": false, 2026-04-26 13:39:46.729853 | ubuntu-focal | "msg": "All assertions passed" 2026-04-26 13:39:46.730110 | ubuntu-focal | } 2026-04-26 13:39:46.730392 | ubuntu-focal | 2026-04-26 13:39:46.730661 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-26 13:39:46.730920 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-26 13:39:46.731139 | ubuntu-focal | 2026-04-26 13:39:46.731351 | ubuntu-focal | 2026-04-26 13:39:46.731579 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-26 13:39:46.731847 | ubuntu-focal | Sunday 26 April 2026 13:39:46 +0000 (0:00:00.029) 0:00:05.881 ********** 2026-04-26 13:39:46.732135 | ubuntu-focal | =============================================================================== 2026-04-26 13:39:46.732374 | ubuntu-focal | Populate package facts -------------------------------------------------- 2.42s 2026-04-26 13:39:46.732601 | ubuntu-focal | Populate service facts -------------------------------------------------- 2.30s 2026-04-26 13:39:46.732837 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.09s 2026-04-26 13:39:46.733087 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-04-26 13:39:46.733259 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-26 13:39:46.861602 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-04-26 13:39:46.870145 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-26 13:39:46.870620 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-26 13:39:46.892739 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-26 13:39:46.892949 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-26 13:39:46.893136 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-26 13:39:46.893781 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-26 13:39:47.222085 | ubuntu-focal | ok: Runtime: 0:00:59.996868 2026-04-26 13:39:47.224948 | 2026-04-26 13:39:47.225011 | PLAY RECAP 2026-04-26 13:39:47.225059 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-26 13:39:47.225081 | 2026-04-26 13:39:47.334385 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-26 13:39:47.336606 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-26 13:39:47.957429 | 2026-04-26 13:39:47.957568 | PLAY [all] 2026-04-26 13:39:47.968539 | 2026-04-26 13:39:47.968639 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-26 13:39:48.014125 | ubuntu-focal | skipping: Conditional result was False 2026-04-26 13:39:48.023241 | 2026-04-26 13:39:48.023353 | TASK [fetch-output : Set log path for single node] 2026-04-26 13:39:48.068902 | ubuntu-focal | ok 2026-04-26 13:39:48.075497 | 2026-04-26 13:39:48.075601 | LOOP [fetch-output : Ensure local output dirs] 2026-04-26 13:39:48.513554 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/logs" 2026-04-26 13:39:48.718285 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/artifacts" 2026-04-26 13:39:48.922037 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/ed9a7f0118ba44d2bacc9189e3ea567a/work/docs" 2026-04-26 13:39:48.941992 | 2026-04-26 13:39:48.942157 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-26 13:39:49.551636 | ubuntu-focal | ok 2026-04-26 13:39:49.551861 | ubuntu-focal | changed: All items complete 2026-04-26 13:39:49.551888 | 2026-04-26 13:39:49.975152 | ubuntu-focal | changed: .d..t...... ./ 2026-04-26 13:39:50.388599 | ubuntu-focal | changed: .d..t...... ./ 2026-04-26 13:39:50.417537 | 2026-04-26 13:39:50.417704 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-26 13:39:50.858439 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.007407 2026-04-26 13:39:51.082977 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007116 2026-04-26 13:39:51.100126 | 2026-04-26 13:39:51.100284 | PLAY [all] 2026-04-26 13:39:51.108402 | 2026-04-26 13:39:51.108500 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-26 13:39:51.539942 | ubuntu-focal | changed 2026-04-26 13:39:51.545720 | 2026-04-26 13:39:51.545773 | PLAY RECAP 2026-04-26 13:39:51.545821 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-26 13:39:51.545843 | 2026-04-26 13:39:51.714908 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-26 13:39:51.717037 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-26 13:39:52.335805 | 2026-04-26 13:39:52.335940 | PLAY [localhost] 2026-04-26 13:39:52.345865 | 2026-04-26 13:39:52.345940 | TASK [Generate Zuul manifest] 2026-04-26 13:39:52.365655 | localhost | ok 2026-04-26 13:39:52.382974 | 2026-04-26 13:39:52.383052 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-26 13:39:52.701094 | localhost | changed 2026-04-26 13:39:52.715384 | 2026-04-26 13:39:52.715467 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-26 13:39:52.747566 | localhost | ok 2026-04-26 13:39:52.756394 | 2026-04-26 13:39:52.756484 | TASK [Upload logs] 2026-04-26 13:39:52.776434 | localhost | ok 2026-04-26 13:39:52.842281 | 2026-04-26 13:39:52.842413 | TASK [Set zuul-log-path fact] 2026-04-26 13:39:52.864431 | localhost | ok 2026-04-26 13:39:52.878831 | 2026-04-26 13:39:52.878932 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-26 13:39:52.907901 | localhost | ok 2026-04-26 13:39:52.915058 | 2026-04-26 13:39:52.915121 | TASK [upload-logs : Create log directories] 2026-04-26 13:39:53.364044 | localhost | changed 2026-04-26 13:39:53.370390 | 2026-04-26 13:39:53.370480 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-26 13:39:53.841403 | localhost -> localhost | ok: Runtime: 0:00:00.004648 2026-04-26 13:39:53.848249 | 2026-04-26 13:39:53.848335 | TASK [upload-logs : Upload logs to log server] 2026-04-26 13:39:54.355313 | localhost | Output suppressed because no_log was given 2026-04-26 13:39:54.360383 | 2026-04-26 13:39:54.360494 | LOOP [upload-logs : Compress console log and json output] 2026-04-26 13:39:54.410594 | localhost | skipping: Conditional result was False 2026-04-26 13:39:54.417153 | localhost | skipping: Conditional result was False 2026-04-26 13:39:54.435907 | 2026-04-26 13:39:54.436042 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-26 13:39:54.482716 | localhost | skipping: Conditional result was False 2026-04-26 13:39:54.483313 | 2026-04-26 13:39:54.488997 | localhost | skipping: Conditional result was False 2026-04-26 13:39:54.501773 | 2026-04-26 13:39:54.501916 | LOOP [upload-logs : Upload console log and json output]