2026-05-21 04:27:41.510683 | Job console starting 2026-05-21 04:27:41.522431 | Updating git repos 2026-05-21 04:27:41.549588 | Cloning repos into workspace 2026-05-21 04:28:02.764064 | Restoring repo states 2026-05-21 04:28:02.769457 | Merging changes 2026-05-21 04:28:04.816168 | Checking out repos 2026-05-21 04:28:06.878776 | Preparing playbooks 2026-05-21 04:29:55.115361 | Running Ansible setup 2026-05-21 04:30:00.262331 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 04:30:00.961305 | 2026-05-21 04:30:00.961497 | PLAY [localhost] 2026-05-21 04:30:00.969730 | 2026-05-21 04:30:00.969803 | TASK [Gathering Facts] 2026-05-21 04:30:03.420720 | localhost | ok 2026-05-21 04:30:03.428349 | 2026-05-21 04:30:03.428430 | TASK [Setup log path fact] 2026-05-21 04:30:03.452068 | localhost | ok 2026-05-21 04:30:03.465894 | 2026-05-21 04:30:03.465999 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 04:30:03.496611 | localhost | ok 2026-05-21 04:30:03.506013 | 2026-05-21 04:30:03.506165 | TASK [emit-job-header : Print job information] 2026-05-21 04:30:03.548923 | # Job Information 2026-05-21 04:30:03.549116 | Ansible Version: 2.16.18 2026-05-21 04:30:03.549164 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-05-21 04:30:03.549198 | Pipeline: check 2026-05-21 04:30:03.549228 | Executor: 2d72f0692154 2026-05-21 04:30:03.549256 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/126 2026-05-21 04:30:03.549290 | Event ID: 29d96d20-54cd-11f1-9691-babf9ae811a4 2026-05-21 04:30:03.553514 | 2026-05-21 04:30:03.553638 | LOOP [emit-job-header : Print node information] 2026-05-21 04:30:03.657512 | localhost | ok: 2026-05-21 04:30:03.658046 | localhost | # Node Information 2026-05-21 04:30:03.658096 | localhost | Inventory Hostname: ubuntu-focal 2026-05-21 04:30:03.658131 | localhost | Hostname: np0000175810 2026-05-21 04:30:03.658163 | localhost | Username: zuul 2026-05-21 04:30:03.658198 | localhost | Distro: Ubuntu 20.04 2026-05-21 04:30:03.658230 | localhost | Provider: yul1 2026-05-21 04:30:03.658259 | localhost | Region: ca-ymq-1 2026-05-21 04:30:03.658288 | localhost | Label: ubuntu-focal 2026-05-21 04:30:03.658316 | localhost | Product Name: OpenStack Nova 2026-05-21 04:30:03.658346 | localhost | Interface IP: 199.204.45.162 2026-05-21 04:30:03.666892 | 2026-05-21 04:30:03.666986 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 04:30:04.938824 | localhost -> localhost | changed 2026-05-21 04:30:04.945984 | 2026-05-21 04:30:04.946079 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 04:30:08.820051 | localhost -> localhost | changed 2026-05-21 04:30:08.832118 | 2026-05-21 04:30:08.832201 | PLAY [all] 2026-05-21 04:30:08.843106 | 2026-05-21 04:30:08.843179 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 04:30:09.094453 | ubuntu-focal -> localhost | ok 2026-05-21 04:30:09.110550 | 2026-05-21 04:30:09.110661 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 04:30:09.155195 | ubuntu-focal | ok 2026-05-21 04:30:09.173551 | ubuntu-focal | included: /var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 04:30:09.180428 | 2026-05-21 04:30:09.180534 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 04:30:13.535251 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-05-21 04:30:13.535482 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/67a3e8aed5b94ac1807ab27d3a0b199d_id_rsa 2026-05-21 04:30:13.535521 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/67a3e8aed5b94ac1807ab27d3a0b199d_id_rsa.pub 2026-05-21 04:30:13.535550 | ubuntu-focal -> localhost | The key fingerprint is: 2026-05-21 04:30:13.535577 | ubuntu-focal -> localhost | SHA256:FPrpzJymf9H4azSwaASnYHP8y4yvOAvYfm84gH28/+g zuul-build-sshkey 2026-05-21 04:30:13.535624 | ubuntu-focal -> localhost | The key's randomart image is: 2026-05-21 04:30:13.535652 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-05-21 04:30:13.535685 | ubuntu-focal -> localhost | | . . | 2026-05-21 04:30:13.535712 | ubuntu-focal -> localhost | | + +... | 2026-05-21 04:30:13.535738 | ubuntu-focal -> localhost | | . +.=. | 2026-05-21 04:30:13.535764 | ubuntu-focal -> localhost | | .oo.. | 2026-05-21 04:30:13.535789 | ubuntu-focal -> localhost | | o . =So = | 2026-05-21 04:30:13.535814 | ubuntu-focal -> localhost | |.oo o .=*.+ + | 2026-05-21 04:30:13.535839 | ubuntu-focal -> localhost | |. oo o oB + . | 2026-05-21 04:30:13.535864 | ubuntu-focal -> localhost | | . .*..+. . o | 2026-05-21 04:30:13.535892 | ubuntu-focal -> localhost | | ..oOE+o. ... | 2026-05-21 04:30:13.535918 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-05-21 04:30:13.535987 | ubuntu-focal -> localhost | ok: Runtime: 0:00:01.874128 2026-05-21 04:30:13.543945 | 2026-05-21 04:30:13.544044 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 04:30:13.577089 | ubuntu-focal | ok 2026-05-21 04:30:13.588806 | ubuntu-focal | included: /var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 04:30:13.597083 | 2026-05-21 04:30:13.597180 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 04:30:13.613075 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:30:13.621591 | 2026-05-21 04:30:13.621754 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 04:30:14.038925 | ubuntu-focal | changed 2026-05-21 04:30:14.045903 | 2026-05-21 04:30:14.045978 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 04:30:14.228504 | ubuntu-focal | ok 2026-05-21 04:30:14.234650 | 2026-05-21 04:30:14.234752 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 04:30:14.675102 | ubuntu-focal | changed 2026-05-21 04:30:15.081311 | 2026-05-21 04:30:15.081462 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 04:30:15.509613 | ubuntu-focal | changed 2026-05-21 04:30:15.854536 | 2026-05-21 04:30:15.854682 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 04:30:15.880999 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:30:15.893928 | 2026-05-21 04:30:15.894050 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 04:30:16.324584 | ubuntu-focal -> localhost | changed 2026-05-21 04:30:16.340214 | 2026-05-21 04:30:16.340291 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 04:30:16.665596 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/67a3e8aed5b94ac1807ab27d3a0b199d_id_rsa (zuul-build-sshkey) 2026-05-21 04:30:16.665835 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.016626 2026-05-21 04:30:16.673387 | 2026-05-21 04:30:16.673472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 04:30:17.017712 | ubuntu-focal | ok 2026-05-21 04:30:17.082891 | 2026-05-21 04:30:17.083047 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 04:30:17.109032 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:30:17.131230 | 2026-05-21 04:30:17.131394 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-21 04:30:17.465593 | ubuntu-focal | ok 2026-05-21 04:30:17.473811 | 2026-05-21 04:30:17.473911 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-21 04:30:18.437913 | ubuntu-focal | Output suppressed because no_log was given 2026-05-21 04:30:18.604090 | 2026-05-21 04:30:18.604363 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-21 04:30:18.871910 | ubuntu-focal | ok: "logs" 2026-05-21 04:30:19.276289 | ubuntu-focal | ok: All items complete 2026-05-21 04:30:19.276503 | 2026-05-21 04:30:19.286862 | ubuntu-focal | ok: "artifacts" 2026-05-21 04:30:19.291347 | ubuntu-focal | ok: "docs" 2026-05-21 04:30:19.310322 | 2026-05-21 04:30:19.310455 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-21 04:30:19.482624 | ubuntu-focal | changed: "logs" 2026-05-21 04:30:19.726875 | ubuntu-focal | changed: "artifacts" 2026-05-21 04:30:19.780983 | ubuntu-focal | changed: "docs" 2026-05-21 04:30:19.794025 | 2026-05-21 04:30:19.794356 | PLAY RECAP 2026-05-21 04:30:19.794416 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:30:19.794449 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-21 04:30:19.794473 | 2026-05-21 04:30:19.944824 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 04:30:19.948707 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 04:30:20.597818 | 2026-05-21 04:30:20.598336 | PLAY [all] 2026-05-21 04:30:20.611697 | 2026-05-21 04:30:20.611892 | TASK [setup-uv : Extract archive] 2026-05-21 04:30:22.825454 | ubuntu-focal | changed 2026-05-21 04:30:22.834333 | 2026-05-21 04:30:22.834443 | TASK [setup-uv : Print version] 2026-05-21 04:30:23.184899 | ubuntu-focal | uv 0.8.13 2026-05-21 04:30:23.685694 | ubuntu-focal | ok: Runtime: 0:00:00.008969 2026-05-21 04:30:23.699397 | 2026-05-21 04:30:23.699499 | TASK [Install Ansible collection siblings] 2026-05-21 04:30:24.115446 | ubuntu-focal | ok: 2026-05-21 04:30:24.527805 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling 2026-05-21 04:30:24.527928 | ubuntu-focal | Skipping community.general: no checked-out sibling 2026-05-21 04:30:24.530222 | 2026-05-21 04:30:24.530279 | PLAY RECAP 2026-05-21 04:30:24.530339 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:30:24.530503 | 2026-05-21 04:30:24.739694 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 04:30:24.741945 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 04:30:25.352504 | 2026-05-21 04:30:25.352686 | PLAY [all] 2026-05-21 04:30:25.366955 | 2026-05-21 04:30:25.367115 | TASK [Copy inventory file for Zuul] 2026-05-21 04:30:26.212975 | ubuntu-focal | changed 2026-05-21 04:30:26.219137 | 2026-05-21 04:30:26.219263 | TASK [Switch "ansible_host" to private IP] 2026-05-21 04:30:26.562538 | ubuntu-focal | changed: 1 replacements made 2026-05-21 04:30:26.567673 | 2026-05-21 04:30:26.567746 | TASK [Run Molecule scenario] 2026-05-21 04:30:27.137005 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-05-21 04:30:27.811564 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-05-21 04:30:27.993466 | ubuntu-focal | Using CPython 3.13.7 2026-05-21 04:30:27.993521 | ubuntu-focal | Creating virtual environment at: .venv 2026-05-21 04:30:28.220484 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-05-21 04:30:28.220861 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-05-21 04:30:28.221595 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-05-21 04:30:28.370919 | ubuntu-focal | Downloading cryptography 2026-05-21 04:30:28.411666 | ubuntu-focal | Downloading pygments 2026-05-21 04:30:28.556019 | ubuntu-focal | Downloading ansible-core 2026-05-21 04:30:28.582347 | ubuntu-focal | Installed 36 packages in 25ms 2026-05-21 04:30:29.715188 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-05-21 04:30:29.715283 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-05-21 04:30:30.514920 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-21 04:30:30.515002 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-05-21 04:30:30.515023 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-21 04:30:30.515115 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-05-21 04:30:48.764956 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-05-21 04:30:48.765193 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-05-21 04:30:48.765453 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-05-21 04:30:48.765605 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-21 04:30:48.772825 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-05-21 04:30:48.773089 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:30:48.778957 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-05-21 04:30:48.778994 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-05-21 04:30:48.779095 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-05-21 04:30:48.784884 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-05-21 04:30:49.314065 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:30:49.314303 | 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-05-21 04:30:49.314535 | 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-05-21 04:30:49.314707 | ubuntu-focal | 2026-05-21 04:30:49.660677 | ubuntu-focal | 2026-05-21 04:30:49.660875 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-05-21 04:30:49.721847 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-05-21 04:30:49.734276 | ubuntu-focal | INFO [forget-package > create] Executing 2026-05-21 04:30:49.736161 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:30:49.741457 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-05-21 04:30:50.210766 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:30:50.210914 | 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-05-21 04:30:50.211102 | 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-05-21 04:30:50.211261 | ubuntu-focal | 2026-05-21 04:30:50.603305 | ubuntu-focal | 2026-05-21 04:30:50.603519 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-05-21 04:30:50.603733 | ubuntu-focal | 2026-05-21 04:30:50.603942 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:30:50.604190 | ubuntu-focal | Thursday 21 May 2026 04:30:50 +0000 (0:00:00.033) 0:00:00.033 ********** 2026-05-21 04:30:51.789176 | 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-05-21 04:30:51.791530 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:30:51.791698 | ubuntu-focal | 2026-05-21 04:30:51.791878 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-05-21 04:30:51.792055 | ubuntu-focal | Thursday 21 May 2026 04:30:51 +0000 (0:00:01.189) 0:00:01.223 ********** 2026-05-21 04:31:04.539040 | ubuntu-focal | changed: [ubuntu-focal] 2026-05-21 04:31:04.539196 | ubuntu-focal | 2026-05-21 04:31:04.539439 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-05-21 04:31:04.539681 | ubuntu-focal | Thursday 21 May 2026 04:31:04 +0000 (0:00:12.747) 0:00:13.970 ********** 2026-05-21 04:31:05.248565 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:05.248698 | ubuntu-focal | 2026-05-21 04:31:05.248905 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:31:05.249123 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:31:05.249293 | ubuntu-focal | 2026-05-21 04:31:05.249459 | ubuntu-focal | 2026-05-21 04:31:05.249695 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:31:05.249945 | ubuntu-focal | Thursday 21 May 2026 04:31:05 +0000 (0:00:00.709) 0:00:14.679 ********** 2026-05-21 04:31:05.250125 | ubuntu-focal | =============================================================================== 2026-05-21 04:31:05.250340 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 12.75s 2026-05-21 04:31:05.250515 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.19s 2026-05-21 04:31:05.250957 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.71s 2026-05-21 04:31:05.358766 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-05-21 04:31:05.367370 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-05-21 04:31:05.853448 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:31:05.853643 | 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-05-21 04:31:05.853842 | 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-05-21 04:31:05.854009 | ubuntu-focal | 2026-05-21 04:31:06.151604 | ubuntu-focal | 2026-05-21 04:31:06.151778 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-05-21 04:31:06.151948 | ubuntu-focal | 2026-05-21 04:31:06.152139 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:31:06.152325 | ubuntu-focal | Thursday 21 May 2026 04:31:06 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-05-21 04:31:07.241695 | 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-05-21 04:31:07.244210 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:07.244397 | ubuntu-focal | 2026-05-21 04:31:07.244610 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 04:31:07.244835 | ubuntu-focal | Thursday 21 May 2026 04:31:07 +0000 (0:00:01.092) 0:00:01.100 ********** 2026-05-21 04:31:07.628741 | 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-05-21 04:31:07.632499 | ubuntu-focal | changed: [ubuntu-focal] 2026-05-21 04:31:07.632687 | ubuntu-focal | 2026-05-21 04:31:07.632889 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:31:07.633085 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:31:07.633250 | ubuntu-focal | 2026-05-21 04:31:07.633408 | ubuntu-focal | 2026-05-21 04:31:07.633592 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:31:07.633768 | ubuntu-focal | Thursday 21 May 2026 04:31:07 +0000 (0:00:00.388) 0:00:01.489 ********** 2026-05-21 04:31:07.633929 | ubuntu-focal | =============================================================================== 2026-05-21 04:31:07.634100 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.09s 2026-05-21 04:31:07.634373 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.39s 2026-05-21 04:31:07.732790 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-05-21 04:31:07.741776 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-05-21 04:31:08.241284 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:31:08.241492 | 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-05-21 04:31:08.241692 | 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-05-21 04:31:08.241855 | ubuntu-focal | 2026-05-21 04:31:08.560219 | ubuntu-focal | 2026-05-21 04:31:08.560324 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-05-21 04:31:08.560434 | ubuntu-focal | 2026-05-21 04:31:08.560556 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:31:08.560677 | ubuntu-focal | Thursday 21 May 2026 04:31:08 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-05-21 04:31:09.656328 | 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-05-21 04:31:09.658564 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:09.658739 | ubuntu-focal | 2026-05-21 04:31:09.658930 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 04:31:09.659111 | ubuntu-focal | Thursday 21 May 2026 04:31:09 +0000 (0:00:01.098) 0:00:01.107 ********** 2026-05-21 04:31:10.117894 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:10.117971 | ubuntu-focal | 2026-05-21 04:31:10.118087 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:31:10.118294 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:31:10.118440 | ubuntu-focal | 2026-05-21 04:31:10.118534 | ubuntu-focal | 2026-05-21 04:31:10.118691 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:31:10.118820 | ubuntu-focal | Thursday 21 May 2026 04:31:10 +0000 (0:00:00.459) 0:00:01.566 ********** 2026-05-21 04:31:10.118983 | ubuntu-focal | =============================================================================== 2026-05-21 04:31:10.119192 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.10s 2026-05-21 04:31:10.119326 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-05-21 04:31:10.245998 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-05-21 04:31:10.256275 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-05-21 04:31:10.256717 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:31:10.263797 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-05-21 04:31:10.829076 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:31:10.829287 | 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-05-21 04:31:10.829488 | 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-05-21 04:31:10.829649 | ubuntu-focal | 2026-05-21 04:31:11.167218 | ubuntu-focal | 2026-05-21 04:31:11.167399 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-05-21 04:31:11.167565 | ubuntu-focal | 2026-05-21 04:31:11.167748 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:31:11.167929 | ubuntu-focal | Thursday 21 May 2026 04:31:11 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-05-21 04:31:12.258260 | 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-05-21 04:31:12.260597 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:12.260753 | ubuntu-focal | 2026-05-21 04:31:12.260851 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-05-21 04:31:12.260969 | ubuntu-focal | Thursday 21 May 2026 04:31:12 +0000 (0:00:01.093) 0:00:01.102 ********** 2026-05-21 04:31:14.239690 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:14.239798 | ubuntu-focal | 2026-05-21 04:31:14.240037 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-05-21 04:31:14.240267 | ubuntu-focal | Thursday 21 May 2026 04:31:14 +0000 (0:00:01.978) 0:00:03.081 ********** 2026-05-21 04:31:16.053019 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:31:16.053084 | ubuntu-focal | 2026-05-21 04:31:16.053095 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-05-21 04:31:16.053105 | ubuntu-focal | Thursday 21 May 2026 04:31:16 +0000 (0:00:01.812) 0:00:04.894 ********** 2026-05-21 04:31:16.078911 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-05-21 04:31:16.078969 | ubuntu-focal | "changed": false, 2026-05-21 04:31:16.079502 | ubuntu-focal | "msg": "All assertions passed" 2026-05-21 04:31:16.079563 | ubuntu-focal | } 2026-05-21 04:31:16.079570 | ubuntu-focal | 2026-05-21 04:31:16.079575 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-05-21 04:31:16.079581 | ubuntu-focal | Thursday 21 May 2026 04:31:16 +0000 (0:00:00.026) 0:00:04.921 ********** 2026-05-21 04:31:16.100327 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-05-21 04:31:16.100524 | ubuntu-focal | "changed": false, 2026-05-21 04:31:16.100831 | ubuntu-focal | "msg": "All assertions passed" 2026-05-21 04:31:16.101087 | ubuntu-focal | } 2026-05-21 04:31:16.101343 | ubuntu-focal | 2026-05-21 04:31:16.101592 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:31:16.101847 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:31:16.102068 | ubuntu-focal | 2026-05-21 04:31:16.102342 | ubuntu-focal | 2026-05-21 04:31:16.102721 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:31:16.103036 | ubuntu-focal | Thursday 21 May 2026 04:31:16 +0000 (0:00:00.021) 0:00:04.942 ********** 2026-05-21 04:31:16.103389 | ubuntu-focal | =============================================================================== 2026-05-21 04:31:16.103662 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.98s 2026-05-21 04:31:16.103900 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.81s 2026-05-21 04:31:16.104132 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.09s 2026-05-21 04:31:16.104398 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-05-21 04:31:16.104641 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.02s 2026-05-21 04:31:16.203625 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-05-21 04:31:16.212011 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-05-21 04:31:16.212451 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:31:16.243325 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-05-21 04:31:16.243511 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-05-21 04:31:16.243636 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-05-21 04:31:16.244051 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-21 04:31:16.683771 | ubuntu-focal | ok: Runtime: 0:00:49.380998 2026-05-21 04:31:16.703280 | 2026-05-21 04:31:16.703414 | PLAY RECAP 2026-05-21 04:31:16.703491 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:31:16.703525 | 2026-05-21 04:31:16.828317 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 04:31:16.830109 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 04:31:17.449341 | 2026-05-21 04:31:17.449486 | PLAY [all] 2026-05-21 04:31:17.461007 | 2026-05-21 04:31:17.461132 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-21 04:31:17.507561 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:31:17.517742 | 2026-05-21 04:31:17.517897 | TASK [fetch-output : Set log path for single node] 2026-05-21 04:31:17.561993 | ubuntu-focal | ok 2026-05-21 04:31:17.567000 | 2026-05-21 04:31:17.567067 | LOOP [fetch-output : Ensure local output dirs] 2026-05-21 04:31:17.955540 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/logs" 2026-05-21 04:31:18.227540 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/artifacts" 2026-05-21 04:31:18.450656 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/67a3e8aed5b94ac1807ab27d3a0b199d/work/docs" 2026-05-21 04:31:18.470622 | 2026-05-21 04:31:18.470751 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 04:31:19.070845 | ubuntu-focal | ok 2026-05-21 04:31:19.071101 | ubuntu-focal | changed: All items complete 2026-05-21 04:31:19.071139 | 2026-05-21 04:31:19.480053 | ubuntu-focal | changed: .d..t...... ./ 2026-05-21 04:31:19.888063 | ubuntu-focal | changed: .d..t...... ./ 2026-05-21 04:31:19.908488 | 2026-05-21 04:31:19.908647 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 04:31:20.316423 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.007601 2026-05-21 04:31:20.557367 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007927 2026-05-21 04:31:20.574299 | 2026-05-21 04:31:20.574426 | PLAY [all] 2026-05-21 04:31:20.580221 | 2026-05-21 04:31:20.580303 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 04:31:20.995409 | ubuntu-focal | changed 2026-05-21 04:31:21.002454 | 2026-05-21 04:31:21.002519 | PLAY RECAP 2026-05-21 04:31:21.002567 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-21 04:31:21.002591 | 2026-05-21 04:31:21.151058 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 04:31:21.152697 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 04:31:21.784406 | 2026-05-21 04:31:21.784551 | PLAY [localhost] 2026-05-21 04:31:21.795771 | 2026-05-21 04:31:21.795918 | TASK [Generate Zuul manifest] 2026-05-21 04:31:21.826643 | localhost | ok 2026-05-21 04:31:21.843771 | 2026-05-21 04:31:21.843913 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 04:31:22.312501 | localhost | changed 2026-05-21 04:31:22.326631 | 2026-05-21 04:31:22.326714 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 04:31:22.368725 | localhost | ok 2026-05-21 04:31:22.379622 | 2026-05-21 04:31:22.379792 | TASK [Upload logs] 2026-05-21 04:31:22.400681 | localhost | ok 2026-05-21 04:31:22.469297 | 2026-05-21 04:31:22.469463 | TASK [Set zuul-log-path fact] 2026-05-21 04:31:22.491544 | localhost | ok 2026-05-21 04:31:22.507320 | 2026-05-21 04:31:22.507586 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 04:31:22.542250 | localhost | ok 2026-05-21 04:31:22.550340 | 2026-05-21 04:31:22.550425 | TASK [upload-logs : Create log directories] 2026-05-21 04:31:22.993252 | localhost | changed 2026-05-21 04:31:23.001551 | 2026-05-21 04:31:23.001733 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 04:31:23.472753 | localhost -> localhost | ok: Runtime: 0:00:00.005913 2026-05-21 04:31:23.480196 | 2026-05-21 04:31:23.480345 | TASK [upload-logs : Upload logs to log server] 2026-05-21 04:31:24.044003 | localhost | Output suppressed because no_log was given 2026-05-21 04:31:24.049421 | 2026-05-21 04:31:24.049492 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 04:31:24.096112 | localhost | skipping: Conditional result was False 2026-05-21 04:31:24.103528 | localhost | skipping: Conditional result was False 2026-05-21 04:31:24.114813 | 2026-05-21 04:31:24.114941 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 04:31:24.165105 | localhost | skipping: Conditional result was False 2026-05-21 04:31:24.165593 | 2026-05-21 04:31:24.169201 | localhost | skipping: Conditional result was False 2026-05-21 04:31:24.179223 | 2026-05-21 04:31:24.179330 | LOOP [upload-logs : Upload console log and json output]