2026-04-15 01:00:18.755493 | Job console starting 2026-04-15 01:00:18.768035 | Updating git repos 2026-04-15 01:00:18.807849 | Cloning repos into workspace 2026-04-15 01:00:18.856290 | Restoring repo states 2026-04-15 01:00:18.868588 | Merging changes 2026-04-15 01:00:19.271636 | Checking out repos 2026-04-15 01:00:19.298929 | Preparing playbooks 2026-04-15 01:00:21.138950 | Running Ansible setup 2026-04-15 01:00:24.515883 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:00:25.123647 | 2026-04-15 01:00:25.123766 | PLAY [localhost] 2026-04-15 01:00:25.131310 | 2026-04-15 01:00:25.131377 | TASK [Gathering Facts] 2026-04-15 01:00:25.994449 | localhost | ok 2026-04-15 01:00:26.003513 | 2026-04-15 01:00:26.003626 | TASK [Setup log path fact] 2026-04-15 01:00:26.022335 | localhost | ok 2026-04-15 01:00:26.038593 | 2026-04-15 01:00:26.038755 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:00:26.067664 | localhost | ok 2026-04-15 01:00:26.073570 | 2026-04-15 01:00:26.073636 | TASK [emit-job-header : Print job information] 2026-04-15 01:00:26.110805 | # Job Information 2026-04-15 01:00:26.148800 | Ansible Version: 2.16.16 2026-04-15 01:00:26.148916 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-04-15 01:00:26.149043 | Pipeline: check 2026-04-15 01:00:26.149094 | Executor: 0a8996d2b663 2026-04-15 01:00:26.149137 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109 2026-04-15 01:00:26.149185 | Event ID: 276b5040-3866-11f1-87ec-4c6fd3e486d6 2026-04-15 01:00:26.155202 | 2026-04-15 01:00:26.155338 | LOOP [emit-job-header : Print node information] 2026-04-15 01:00:26.249390 | localhost | ok: 2026-04-15 01:00:26.249715 | localhost | # Node Information 2026-04-15 01:00:26.249827 | localhost | Inventory Hostname: ubuntu-focal 2026-04-15 01:00:26.249872 | localhost | Hostname: np0000166328 2026-04-15 01:00:26.249903 | localhost | Username: zuul 2026-04-15 01:00:26.249936 | localhost | Distro: Ubuntu 20.04 2026-04-15 01:00:26.249965 | localhost | Provider: yul1 2026-04-15 01:00:26.249993 | localhost | Region: ca-ymq-1 2026-04-15 01:00:26.250019 | localhost | Label: ubuntu-focal 2026-04-15 01:00:26.250047 | localhost | Product Name: OpenStack Nova 2026-04-15 01:00:26.250074 | localhost | Interface IP: 199.19.213.180 2026-04-15 01:00:26.260558 | 2026-04-15 01:00:26.260945 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-15 01:00:26.668601 | localhost -> localhost | changed 2026-04-15 01:00:26.673485 | 2026-04-15 01:00:26.673557 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-15 01:00:27.501674 | localhost -> localhost | changed 2026-04-15 01:00:27.514780 | 2026-04-15 01:00:27.514933 | PLAY [all] 2026-04-15 01:00:27.525769 | 2026-04-15 01:00:27.525833 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-15 01:00:27.884053 | ubuntu-focal -> localhost | ok 2026-04-15 01:00:27.891971 | 2026-04-15 01:00:27.892078 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-15 01:00:27.923070 | ubuntu-focal | ok 2026-04-15 01:00:27.940931 | ubuntu-focal | included: /var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-15 01:00:27.947310 | 2026-04-15 01:00:27.947374 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-15 01:00:29.097994 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-04-15 01:00:29.098287 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/37694095d08d4c3db5df8086b766dd60_id_rsa 2026-04-15 01:00:29.098319 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/37694095d08d4c3db5df8086b766dd60_id_rsa.pub 2026-04-15 01:00:29.098342 | ubuntu-focal -> localhost | The key fingerprint is: 2026-04-15 01:00:29.098363 | ubuntu-focal -> localhost | SHA256:M9n1j6ADwJ2XX2pJ2McqE5HSepeodQ8fW3ntWmZ/4YQ zuul-build-sshkey 2026-04-15 01:00:29.098393 | ubuntu-focal -> localhost | The key's randomart image is: 2026-04-15 01:00:29.098415 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-04-15 01:00:29.098442 | ubuntu-focal -> localhost | | ... | 2026-04-15 01:00:29.098465 | ubuntu-focal -> localhost | | . ...o= . | 2026-04-15 01:00:29.098485 | ubuntu-focal -> localhost | | o oo=.+.+ o| 2026-04-15 01:00:29.098505 | ubuntu-focal -> localhost | | ..++==B..+| 2026-04-15 01:00:29.098525 | ubuntu-focal -> localhost | | S++oB+o=.| 2026-04-15 01:00:29.098544 | ubuntu-focal -> localhost | | .+ = E+==| 2026-04-15 01:00:29.098564 | ubuntu-focal -> localhost | | o +=+| 2026-04-15 01:00:29.098583 | ubuntu-focal -> localhost | | . ..o| 2026-04-15 01:00:29.098605 | ubuntu-focal -> localhost | | .| 2026-04-15 01:00:29.098626 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-04-15 01:00:29.098671 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.569161 2026-04-15 01:00:29.103559 | 2026-04-15 01:00:29.103624 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-15 01:00:29.132228 | ubuntu-focal | ok 2026-04-15 01:00:29.141151 | ubuntu-focal | included: /var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-15 01:00:29.148281 | 2026-04-15 01:00:29.148342 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-15 01:00:29.181953 | ubuntu-focal | skipping: Conditional result was False 2026-04-15 01:00:29.187553 | 2026-04-15 01:00:29.187622 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-15 01:00:29.663107 | ubuntu-focal | changed 2026-04-15 01:00:29.670026 | 2026-04-15 01:00:29.670163 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-15 01:00:29.847518 | ubuntu-focal | ok 2026-04-15 01:00:29.854584 | 2026-04-15 01:00:29.854729 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-15 01:00:30.433478 | ubuntu-focal | changed 2026-04-15 01:00:30.440814 | 2026-04-15 01:00:30.440912 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-15 01:00:30.891464 | ubuntu-focal | changed 2026-04-15 01:00:30.899513 | 2026-04-15 01:00:30.899617 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-15 01:00:30.926340 | ubuntu-focal | skipping: Conditional result was False 2026-04-15 01:00:30.937555 | 2026-04-15 01:00:30.937666 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-15 01:00:31.310284 | ubuntu-focal -> localhost | changed 2026-04-15 01:00:31.326464 | 2026-04-15 01:00:31.326560 | TASK [add-build-sshkey : Add back temp key] 2026-04-15 01:00:31.603066 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/37694095d08d4c3db5df8086b766dd60_id_rsa (zuul-build-sshkey) 2026-04-15 01:00:31.603337 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.013194 2026-04-15 01:00:31.608809 | 2026-04-15 01:00:31.608869 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-15 01:00:31.924671 | ubuntu-focal | ok 2026-04-15 01:00:31.932083 | 2026-04-15 01:00:31.932201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-15 01:00:31.958373 | ubuntu-focal | skipping: Conditional result was False 2026-04-15 01:00:31.974877 | 2026-04-15 01:00:31.974992 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-15 01:00:32.315701 | ubuntu-focal | ok 2026-04-15 01:00:32.323726 | 2026-04-15 01:00:32.323814 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-15 01:00:33.037702 | ubuntu-focal | Output suppressed because no_log was given 2026-04-15 01:00:33.054671 | 2026-04-15 01:00:33.054749 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-15 01:00:33.233464 | ubuntu-focal | ok: "logs" 2026-04-15 01:00:33.233689 | ubuntu-focal | ok: All items complete 2026-04-15 01:00:33.233718 | 2026-04-15 01:00:33.384652 | ubuntu-focal | ok: "artifacts" 2026-04-15 01:00:33.524348 | ubuntu-focal | ok: "docs" 2026-04-15 01:00:33.538894 | 2026-04-15 01:00:33.539043 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-15 01:00:33.720388 | ubuntu-focal | changed: "logs" 2026-04-15 01:00:33.902949 | ubuntu-focal | changed: "artifacts" 2026-04-15 01:00:34.005507 | ubuntu-focal | changed: "docs" 2026-04-15 01:00:34.015120 | 2026-04-15 01:00:34.015217 | PLAY RECAP 2026-04-15 01:00:34.015260 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:00:34.015290 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-15 01:00:34.015310 | 2026-04-15 01:00:34.137674 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:00:34.139019 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:00:34.724674 | 2026-04-15 01:00:34.724811 | PLAY [all] 2026-04-15 01:00:34.736945 | 2026-04-15 01:00:34.737067 | TASK [setup-uv : Extract archive] 2026-04-15 01:00:36.900036 | ubuntu-focal | changed 2026-04-15 01:00:36.906005 | 2026-04-15 01:00:36.906081 | TASK [setup-uv : Print version] 2026-04-15 01:00:37.281264 | ubuntu-focal | uv 0.8.13 2026-04-15 01:00:37.440694 | ubuntu-focal | ok: Runtime: 0:00:00.008972 2026-04-15 01:00:37.447921 | 2026-04-15 01:00:37.447974 | PLAY RECAP 2026-04-15 01:00:37.448021 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:00:37.448045 | 2026-04-15 01:00:37.591171 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:00:37.592945 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:00:38.157893 | 2026-04-15 01:00:38.158029 | PLAY [all] 2026-04-15 01:00:38.169393 | 2026-04-15 01:00:38.169511 | TASK [Copy inventory file for Zuul] 2026-04-15 01:00:38.979066 | ubuntu-focal | changed 2026-04-15 01:00:38.986708 | 2026-04-15 01:00:38.987025 | TASK [Switch "ansible_host" to private IP] 2026-04-15 01:00:39.255497 | ubuntu-focal | changed: 1 replacements made 2026-04-15 01:00:39.261788 | 2026-04-15 01:00:39.261854 | TASK [Run Molecule scenario] 2026-04-15 01:00:39.809277 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-15 01:00:40.490435 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-15 01:00:40.676974 | ubuntu-focal | Using CPython 3.13.7 2026-04-15 01:00:40.677052 | ubuntu-focal | Creating virtual environment at: .venv 2026-04-15 01:00:41.474962 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-04-15 01:00:41.475787 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-04-15 01:00:41.476654 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-04-15 01:00:41.767945 | ubuntu-focal | Downloading pygments 2026-04-15 01:00:41.816946 | ubuntu-focal | Downloading cryptography 2026-04-15 01:00:41.911143 | ubuntu-focal | Downloading ansible-core 2026-04-15 01:00:41.938142 | ubuntu-focal | Installed 36 packages in 26ms 2026-04-15 01:00:43.036731 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-04-15 01:00:43.036814 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-04-15 01:00:43.831664 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-15 01:00:43.831745 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-04-15 01:00:43.831825 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-15 01:00:43.831901 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-15 01:01:36.946060 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-04-15 01:01:36.946341 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-15 01:01:36.946614 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-15 01:01:36.946786 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-15 01:01:36.953983 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-15 01:01:36.954363 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:36.959348 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-15 01:01:36.959416 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-15 01:01:36.959481 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-15 01:01:36.965044 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-04-15 01:01:37.488902 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:37.489010 | 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-15 01:01:37.489062 | 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-15 01:01:37.489185 | ubuntu-focal | 2026-04-15 01:01:37.873696 | ubuntu-focal | 2026-04-15 01:01:37.873858 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-15 01:01:37.969205 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-04-15 01:01:37.978431 | ubuntu-focal | INFO [forget-package > create] Executing 2026-04-15 01:01:37.982621 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:37.987778 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-04-15 01:01:38.490341 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:38.490529 | 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-15 01:01:38.490742 | 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-15 01:01:38.490916 | ubuntu-focal | 2026-04-15 01:01:38.882756 | ubuntu-focal | 2026-04-15 01:01:38.882988 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-04-15 01:01:38.883155 | ubuntu-focal | 2026-04-15 01:01:38.883335 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:01:38.883512 | ubuntu-focal | Wednesday 15 April 2026 01:01:38 +0000 (0:00:00.031) 0:00:00.031 ******* 2026-04-15 01:01:40.036322 | 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-15 01:01:40.038952 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:01:40.039120 | ubuntu-focal | 2026-04-15 01:01:40.039301 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-04-15 01:01:40.039475 | ubuntu-focal | Wednesday 15 April 2026 01:01:40 +0000 (0:00:01.156) 0:00:01.188 ******* 2026-04-15 01:02:17.959276 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-15 01:02:17.959426 | ubuntu-focal | 2026-04-15 01:02:17.959622 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-04-15 01:02:17.959811 | ubuntu-focal | Wednesday 15 April 2026 01:02:17 +0000 (0:00:37.919) 0:00:39.107 ******* 2026-04-15 01:02:18.601451 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:18.601600 | ubuntu-focal | 2026-04-15 01:02:18.601785 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-15 01:02:18.602034 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:02:18.602150 | ubuntu-focal | 2026-04-15 01:02:18.602299 | ubuntu-focal | 2026-04-15 01:02:18.602540 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-15 01:02:18.602793 | ubuntu-focal | Wednesday 15 April 2026 01:02:18 +0000 (0:00:00.642) 0:00:39.750 ******* 2026-04-15 01:02:18.602984 | ubuntu-focal | =============================================================================== 2026-04-15 01:02:18.603192 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 37.92s 2026-04-15 01:02:18.603324 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.16s 2026-04-15 01:02:18.603488 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.64s 2026-04-15 01:02:18.684282 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-04-15 01:02:18.693508 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-04-15 01:02:19.135119 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:02:19.135370 | 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-15 01:02:19.135568 | 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-15 01:02:19.135688 | ubuntu-focal | 2026-04-15 01:02:19.421398 | ubuntu-focal | 2026-04-15 01:02:19.421576 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-15 01:02:19.421790 | ubuntu-focal | 2026-04-15 01:02:19.422033 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:02:19.422194 | ubuntu-focal | Wednesday 15 April 2026 01:02:19 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-04-15 01:02:20.421535 | 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-15 01:02:20.423615 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:20.423810 | ubuntu-focal | 2026-04-15 01:02:20.424062 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:20.424225 | ubuntu-focal | Wednesday 15 April 2026 01:02:20 +0000 (0:00:01.002) 0:00:01.009 ******* 2026-04-15 01:02:20.764083 | 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-15 01:02:20.766903 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-15 01:02:20.766988 | ubuntu-focal | 2026-04-15 01:02:20.767073 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-15 01:02:20.767168 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:02:20.767241 | ubuntu-focal | 2026-04-15 01:02:20.767312 | ubuntu-focal | 2026-04-15 01:02:20.767409 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-15 01:02:20.767489 | ubuntu-focal | Wednesday 15 April 2026 01:02:20 +0000 (0:00:00.343) 0:00:01.353 ******* 2026-04-15 01:02:20.767559 | ubuntu-focal | =============================================================================== 2026-04-15 01:02:20.767665 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.00s 2026-04-15 01:02:20.767749 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.34s 2026-04-15 01:02:20.856944 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-04-15 01:02:20.866101 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-04-15 01:02:21.336576 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:02:21.336696 | 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-15 01:02:21.336859 | 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-15 01:02:21.336999 | ubuntu-focal | 2026-04-15 01:02:21.634303 | ubuntu-focal | 2026-04-15 01:02:21.634415 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-15 01:02:21.634539 | ubuntu-focal | 2026-04-15 01:02:21.634813 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:02:21.634895 | ubuntu-focal | Wednesday 15 April 2026 01:02:21 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-04-15 01:02:22.601897 | 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-15 01:02:22.604102 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:22.604248 | ubuntu-focal | 2026-04-15 01:02:22.604424 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:22.604594 | ubuntu-focal | Wednesday 15 April 2026 01:02:22 +0000 (0:00:00.969) 0:00:00.977 ******* 2026-04-15 01:02:22.948519 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:22.948692 | ubuntu-focal | 2026-04-15 01:02:22.948899 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-15 01:02:22.949124 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:02:22.949306 | ubuntu-focal | 2026-04-15 01:02:22.949479 | ubuntu-focal | 2026-04-15 01:02:22.949674 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-15 01:02:22.949939 | ubuntu-focal | Wednesday 15 April 2026 01:02:22 +0000 (0:00:00.344) 0:00:01.321 ******* 2026-04-15 01:02:22.950109 | ubuntu-focal | =============================================================================== 2026-04-15 01:02:22.950296 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 0.97s 2026-04-15 01:02:22.950477 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.34s 2026-04-15 01:02:23.074622 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-04-15 01:02:23.084018 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-04-15 01:02:23.084393 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:02:23.090230 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-04-15 01:02:23.558220 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:02:23.558475 | 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-15 01:02:23.558660 | 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-15 01:02:23.558815 | ubuntu-focal | 2026-04-15 01:02:23.856142 | ubuntu-focal | 2026-04-15 01:02:23.856205 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-04-15 01:02:23.856327 | ubuntu-focal | 2026-04-15 01:02:23.856431 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:02:23.856541 | ubuntu-focal | Wednesday 15 April 2026 01:02:23 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-04-15 01:02:24.887311 | 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-15 01:02:24.889869 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:24.890045 | ubuntu-focal | 2026-04-15 01:02:24.890226 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-04-15 01:02:24.890400 | ubuntu-focal | Wednesday 15 April 2026 01:02:24 +0000 (0:00:01.033) 0:00:01.041 ******* 2026-04-15 01:02:26.658214 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:26.658386 | ubuntu-focal | 2026-04-15 01:02:26.658574 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-04-15 01:02:26.658758 | ubuntu-focal | Wednesday 15 April 2026 01:02:26 +0000 (0:00:01.768) 0:00:02.809 ******* 2026-04-15 01:02:28.358358 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-15 01:02:28.358660 | ubuntu-focal | 2026-04-15 01:02:28.358925 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-15 01:02:28.359178 | ubuntu-focal | Wednesday 15 April 2026 01:02:28 +0000 (0:00:01.700) 0:00:04.509 ******* 2026-04-15 01:02:28.390165 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-15 01:02:28.390439 | ubuntu-focal | "changed": false, 2026-04-15 01:02:28.390677 | ubuntu-focal | "msg": "All assertions passed" 2026-04-15 01:02:28.390905 | ubuntu-focal | } 2026-04-15 01:02:28.391117 | ubuntu-focal | 2026-04-15 01:02:28.391349 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-15 01:02:28.391580 | ubuntu-focal | Wednesday 15 April 2026 01:02:28 +0000 (0:00:00.031) 0:00:04.541 ******* 2026-04-15 01:02:28.426174 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-15 01:02:28.426451 | ubuntu-focal | "changed": false, 2026-04-15 01:02:28.426693 | ubuntu-focal | "msg": "All assertions passed" 2026-04-15 01:02:28.426920 | ubuntu-focal | } 2026-04-15 01:02:28.427144 | ubuntu-focal | 2026-04-15 01:02:28.427375 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-15 01:02:28.427627 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:02:28.427842 | ubuntu-focal | 2026-04-15 01:02:28.428109 | ubuntu-focal | 2026-04-15 01:02:28.428342 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-15 01:02:28.428576 | ubuntu-focal | Wednesday 15 April 2026 01:02:28 +0000 (0:00:00.029) 0:00:04.570 ******* 2026-04-15 01:02:28.428797 | ubuntu-focal | =============================================================================== 2026-04-15 01:02:28.429025 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.77s 2026-04-15 01:02:28.429254 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.70s 2026-04-15 01:02:28.429485 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.03s 2026-04-15 01:02:28.429719 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-15 01:02:28.430003 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-04-15 01:02:28.538409 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-04-15 01:02:28.548210 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-15 01:02:28.548647 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:02:28.555432 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-15 01:02:28.555561 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-15 01:02:28.555674 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-15 01:02:28.556080 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-15 01:02:28.971388 | ubuntu-focal | ok: Runtime: 0:01:49.027132 2026-04-15 01:02:28.975289 | 2026-04-15 01:02:28.975352 | PLAY RECAP 2026-04-15 01:02:28.975413 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:02:28.975442 | 2026-04-15 01:02:29.068255 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:02:29.070384 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:29.649942 | 2026-04-15 01:02:29.650056 | PLAY [all] 2026-04-15 01:02:29.661159 | 2026-04-15 01:02:29.661247 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-15 01:02:29.705953 | ubuntu-focal | skipping: Conditional result was False 2026-04-15 01:02:29.714338 | 2026-04-15 01:02:29.714446 | TASK [fetch-output : Set log path for single node] 2026-04-15 01:02:29.757885 | ubuntu-focal | ok 2026-04-15 01:02:29.764085 | 2026-04-15 01:02:29.764173 | LOOP [fetch-output : Ensure local output dirs] 2026-04-15 01:02:30.121715 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/logs" 2026-04-15 01:02:30.327080 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/artifacts" 2026-04-15 01:02:30.588145 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/37694095d08d4c3db5df8086b766dd60/work/docs" 2026-04-15 01:02:30.612038 | 2026-04-15 01:02:30.612194 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-15 01:02:31.184816 | ubuntu-focal | changed: .d..t...... ./ 2026-04-15 01:02:31.185159 | ubuntu-focal | changed: All items complete 2026-04-15 01:02:31.185198 | 2026-04-15 01:02:31.572968 | ubuntu-focal | changed: .d..t...... ./ 2026-04-15 01:02:31.960368 | ubuntu-focal | changed: .d..t...... ./ 2026-04-15 01:02:31.986250 | 2026-04-15 01:02:31.986397 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-15 01:02:32.394381 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.007166 2026-04-15 01:02:32.603758 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007299 2026-04-15 01:02:32.616752 | 2026-04-15 01:02:32.616931 | PLAY [all] 2026-04-15 01:02:32.625671 | 2026-04-15 01:02:32.625758 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-15 01:02:32.995929 | ubuntu-focal | changed 2026-04-15 01:02:33.001536 | 2026-04-15 01:02:33.001586 | PLAY RECAP 2026-04-15 01:02:33.001632 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-15 01:02:33.001654 | 2026-04-15 01:02:33.110048 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:33.111089 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-15 01:02:33.628440 | 2026-04-15 01:02:33.628543 | PLAY [localhost] 2026-04-15 01:02:33.637799 | 2026-04-15 01:02:33.637868 | TASK [Generate Zuul manifest] 2026-04-15 01:02:33.658497 | localhost | ok 2026-04-15 01:02:33.679257 | 2026-04-15 01:02:33.679350 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-15 01:02:33.979974 | localhost | changed 2026-04-15 01:02:33.990278 | 2026-04-15 01:02:33.990350 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-15 01:02:34.018033 | localhost | ok 2026-04-15 01:02:34.024239 | 2026-04-15 01:02:34.024303 | TASK [Upload logs] 2026-04-15 01:02:34.042003 | localhost | ok 2026-04-15 01:02:34.105303 | 2026-04-15 01:02:34.105445 | TASK [Set zuul-log-path fact] 2026-04-15 01:02:34.126171 | localhost | ok 2026-04-15 01:02:34.140017 | 2026-04-15 01:02:34.140130 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:02:34.171060 | localhost | ok 2026-04-15 01:02:34.181829 | 2026-04-15 01:02:34.181947 | TASK [upload-logs : Create log directories] 2026-04-15 01:02:34.597966 | localhost | changed 2026-04-15 01:02:34.604795 | 2026-04-15 01:02:34.604889 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-15 01:02:34.980813 | localhost -> localhost | ok: Runtime: 0:00:00.004537 2026-04-15 01:02:34.987210 | 2026-04-15 01:02:34.987272 | TASK [upload-logs : Upload logs to log server] 2026-04-15 01:02:35.464221 | localhost | Output suppressed because no_log was given 2026-04-15 01:02:35.469147 | 2026-04-15 01:02:35.469215 | LOOP [upload-logs : Compress console log and json output] 2026-04-15 01:02:35.515153 | localhost | skipping: Conditional result was False 2026-04-15 01:02:35.522041 | localhost | skipping: Conditional result was False 2026-04-15 01:02:35.533094 | 2026-04-15 01:02:35.556367 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-15 01:02:35.602169 | localhost | skipping: Conditional result was False 2026-04-15 01:02:35.602566 | 2026-04-15 01:02:35.606341 | localhost | skipping: Conditional result was False 2026-04-15 01:02:35.621229 | 2026-04-15 01:02:35.621361 | LOOP [upload-logs : Upload console log and json output]