2026-03-11 00:44:32.686210 | Job console starting 2026-03-11 00:44:33.840142 | Updating git repos 2026-03-11 00:44:33.866940 | Cloning repos into workspace 2026-03-11 00:44:35.693802 | Restoring repo states 2026-03-11 00:44:35.702443 | Merging changes 2026-03-11 00:44:36.068408 | Checking out repos 2026-03-11 00:44:36.454170 | Preparing playbooks 2026-03-11 00:44:39.662371 | Running Ansible setup 2026-03-11 00:44:43.576788 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-11 00:44:44.164071 | 2026-03-11 00:44:44.192642 | PLAY [localhost] 2026-03-11 00:44:44.200243 | 2026-03-11 00:44:44.200312 | TASK [Gathering Facts] 2026-03-11 00:44:45.115832 | localhost | ok 2026-03-11 00:44:45.129459 | 2026-03-11 00:44:45.129664 | TASK [Setup log path fact] 2026-03-11 00:44:45.159230 | localhost | ok 2026-03-11 00:44:45.244827 | 2026-03-11 00:44:45.244926 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 00:44:45.275666 | localhost | ok 2026-03-11 00:44:45.282837 | 2026-03-11 00:44:45.282901 | TASK [emit-job-header : Print job information] 2026-03-11 00:44:45.313130 | # Job Information 2026-03-11 00:44:45.313367 | Ansible Version: 2.16.16 2026-03-11 00:44:45.313432 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-03-11 00:44:45.313467 | Pipeline: check 2026-03-11 00:44:45.313495 | Executor: 0a8996d2b663 2026-03-11 00:44:45.313523 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/99 2026-03-11 00:44:45.313554 | Event ID: 53b91b30-1ce3-11f1-884c-c2e8535f96e3 2026-03-11 00:44:45.317604 | 2026-03-11 00:44:45.317698 | LOOP [emit-job-header : Print node information] 2026-03-11 00:44:45.447897 | localhost | ok: 2026-03-11 00:44:45.448146 | localhost | # Node Information 2026-03-11 00:44:45.448184 | localhost | Inventory Hostname: ubuntu-focal 2026-03-11 00:44:45.448219 | localhost | Hostname: np0000158300 2026-03-11 00:44:45.448247 | localhost | Username: zuul 2026-03-11 00:44:45.448278 | localhost | Distro: Ubuntu 20.04 2026-03-11 00:44:45.448305 | localhost | Provider: yul1 2026-03-11 00:44:45.448331 | localhost | Region: ca-ymq-1 2026-03-11 00:44:45.448357 | localhost | Label: ubuntu-focal 2026-03-11 00:44:45.448382 | localhost | Product Name: OpenStack Nova 2026-03-11 00:44:45.448408 | localhost | Interface IP: 199.204.45.141 2026-03-11 00:44:45.466646 | 2026-03-11 00:44:45.466826 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-11 00:44:46.060162 | localhost -> localhost | changed 2026-03-11 00:44:46.069002 | 2026-03-11 00:44:46.069103 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-11 00:44:46.928001 | localhost -> localhost | changed 2026-03-11 00:44:46.939548 | 2026-03-11 00:44:46.939606 | PLAY [all] 2026-03-11 00:44:46.947591 | 2026-03-11 00:44:46.947659 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-11 00:44:47.279122 | ubuntu-focal -> localhost | ok 2026-03-11 00:44:47.291606 | 2026-03-11 00:44:47.291706 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-11 00:44:47.327346 | ubuntu-focal | ok 2026-03-11 00:44:47.345469 | ubuntu-focal | included: /var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-11 00:44:47.350851 | 2026-03-11 00:44:47.350913 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-11 00:44:48.485805 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-03-11 00:44:48.486026 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/bf2a887150a843dcb12e553100ad29b6_id_rsa 2026-03-11 00:44:48.486069 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/bf2a887150a843dcb12e553100ad29b6_id_rsa.pub 2026-03-11 00:44:48.486100 | ubuntu-focal -> localhost | The key fingerprint is: 2026-03-11 00:44:48.486129 | ubuntu-focal -> localhost | SHA256:NfCDaq7Pmju/saUQuaKzqYSgFqoL0btDxMfmgjb+Cy0 zuul-build-sshkey 2026-03-11 00:44:48.486172 | ubuntu-focal -> localhost | The key's randomart image is: 2026-03-11 00:44:48.486200 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-03-11 00:44:48.486238 | ubuntu-focal -> localhost | | . | 2026-03-11 00:44:48.486267 | ubuntu-focal -> localhost | | + | 2026-03-11 00:44:48.486294 | ubuntu-focal -> localhost | | . . . = | 2026-03-11 00:44:48.486321 | ubuntu-focal -> localhost | | .o +. . . o | 2026-03-11 00:44:48.486348 | ubuntu-focal -> localhost | |o+.+o o S | 2026-03-11 00:44:48.486374 | ubuntu-focal -> localhost | |*+=..= | 2026-03-11 00:44:48.486401 | ubuntu-focal -> localhost | |BE+oo o . | 2026-03-11 00:44:48.486427 | ubuntu-focal -> localhost | |*++o.= = | 2026-03-11 00:44:48.486457 | ubuntu-focal -> localhost | |O+o+**B. | 2026-03-11 00:44:48.486484 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-03-11 00:44:48.486550 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.692402 2026-03-11 00:44:48.494992 | 2026-03-11 00:44:48.724287 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-11 00:44:48.766909 | ubuntu-focal | ok 2026-03-11 00:44:48.778432 | ubuntu-focal | included: /var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-11 00:44:48.785519 | 2026-03-11 00:44:48.785584 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-11 00:44:48.816224 | ubuntu-focal | skipping: Conditional result was False 2026-03-11 00:44:48.821596 | 2026-03-11 00:44:48.821660 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-11 00:44:49.227933 | ubuntu-focal | changed 2026-03-11 00:44:49.233859 | 2026-03-11 00:44:49.233928 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-11 00:44:49.411331 | ubuntu-focal | ok 2026-03-11 00:44:49.572577 | 2026-03-11 00:44:49.572690 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-11 00:44:50.020302 | ubuntu-focal | changed 2026-03-11 00:44:50.026274 | 2026-03-11 00:44:50.026344 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-11 00:44:50.467031 | ubuntu-focal | changed 2026-03-11 00:44:50.485679 | 2026-03-11 00:44:50.485836 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-11 00:44:50.510982 | ubuntu-focal | skipping: Conditional result was False 2026-03-11 00:44:50.534313 | 2026-03-11 00:44:50.534459 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-11 00:44:50.907533 | ubuntu-focal -> localhost | changed 2026-03-11 00:44:50.928301 | 2026-03-11 00:44:50.928411 | TASK [add-build-sshkey : Add back temp key] 2026-03-11 00:44:51.258352 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/bf2a887150a843dcb12e553100ad29b6_id_rsa (zuul-build-sshkey) 2026-03-11 00:44:51.269286 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.013428 2026-03-11 00:44:51.279438 | 2026-03-11 00:44:51.305608 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-11 00:44:51.665285 | ubuntu-focal | ok 2026-03-11 00:44:51.672086 | 2026-03-11 00:44:51.682500 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-11 00:44:51.708613 | ubuntu-focal | skipping: Conditional result was False 2026-03-11 00:44:51.729372 | 2026-03-11 00:44:51.729502 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-11 00:44:52.069758 | ubuntu-focal | ok 2026-03-11 00:44:52.109987 | 2026-03-11 00:44:52.110062 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-11 00:44:52.995148 | ubuntu-focal | Output suppressed because no_log was given 2026-03-11 00:44:53.005086 | 2026-03-11 00:44:53.005155 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-11 00:44:53.174844 | ubuntu-focal | ok: "logs" 2026-03-11 00:44:53.280572 | ubuntu-focal | ok: All items complete 2026-03-11 00:44:53.280716 | 2026-03-11 00:44:53.327221 | ubuntu-focal | ok: "artifacts" 2026-03-11 00:44:53.476276 | ubuntu-focal | ok: "docs" 2026-03-11 00:44:53.490581 | 2026-03-11 00:44:53.490723 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-11 00:44:53.667468 | ubuntu-focal | changed: "logs" 2026-03-11 00:44:53.859627 | ubuntu-focal | changed: "artifacts" 2026-03-11 00:44:53.971977 | ubuntu-focal | changed: "docs" 2026-03-11 00:44:53.987581 | 2026-03-11 00:44:53.987675 | PLAY RECAP 2026-03-11 00:44:53.987718 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 00:44:53.987747 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-11 00:44:53.987768 | 2026-03-11 00:44:54.087650 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-11 00:44:54.091292 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-11 00:44:54.706249 | 2026-03-11 00:44:54.758378 | PLAY [all] 2026-03-11 00:44:54.775695 | 2026-03-11 00:44:54.775782 | TASK [setup-uv : Extract archive] 2026-03-11 00:44:57.009661 | ubuntu-focal | changed 2026-03-11 00:44:57.024793 | 2026-03-11 00:44:57.024887 | TASK [setup-uv : Print version] 2026-03-11 00:44:57.416366 | ubuntu-focal | uv 0.8.13 2026-03-11 00:44:57.581024 | ubuntu-focal | ok: Runtime: 0:00:00.009484 2026-03-11 00:44:57.592337 | 2026-03-11 00:44:57.622754 | PLAY RECAP 2026-03-11 00:44:57.622891 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 00:44:57.622951 | 2026-03-11 00:44:57.754241 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-11 00:44:57.756310 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-11 00:44:58.315609 | 2026-03-11 00:44:58.315733 | PLAY [all] 2026-03-11 00:44:58.326614 | 2026-03-11 00:44:58.326698 | TASK [Copy inventory file for Zuul] 2026-03-11 00:44:59.161932 | ubuntu-focal | changed 2026-03-11 00:44:59.167011 | 2026-03-11 00:44:59.167089 | TASK [Switch "ansible_host" to private IP] 2026-03-11 00:44:59.470782 | ubuntu-focal | changed: 1 replacements made 2026-03-11 00:44:59.488014 | 2026-03-11 00:44:59.488255 | TASK [Run Molecule scenario] 2026-03-11 00:45:00.091683 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-03-11 00:45:00.719425 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-03-11 00:45:00.896310 | ubuntu-focal | Using CPython 3.13.7 2026-03-11 00:45:00.896433 | ubuntu-focal | Creating virtual environment at: .venv 2026-03-11 00:45:01.142531 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-03-11 00:45:01.142987 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-03-11 00:45:01.165219 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-03-11 00:45:01.315151 | ubuntu-focal | Downloading cryptography 2026-03-11 00:45:01.346180 | ubuntu-focal | Downloading pygments 2026-03-11 00:45:01.488687 | ubuntu-focal | Downloading ansible-core 2026-03-11 00:45:01.513635 | ubuntu-focal | Installed 36 packages in 24ms 2026-03-11 00:45:02.639629 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-03-11 00:45:02.639749 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-03-11 00:45:03.431110 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-11 00:45:03.431208 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-03-11 00:45:03.431230 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-11 00:45:03.431245 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-03-11 00:45:15.168732 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-03-11 00:45:15.168921 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-03-11 00:45:15.168935 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-03-11 00:45:15.168944 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-11 00:45:15.175609 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-03-11 00:45:15.176006 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-11 00:45:15.181637 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-03-11 00:45:15.181670 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-03-11 00:45:15.181726 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-03-11 00:45:15.186519 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-03-11 00:45:15.694860 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-03-11 00:45:15.695064 | 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-03-11 00:45:15.695422 | 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-03-11 00:45:15.695598 | ubuntu-focal | 2026-03-11 00:45:16.074215 | ubuntu-focal | 2026-03-11 00:45:16.074333 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-03-11 00:45:16.138207 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-03-11 00:45:16.147921 | ubuntu-focal | INFO [forget-package > create] Executing 2026-03-11 00:45:16.149155 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-11 00:45:16.154333 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-03-11 00:45:16.617588 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-03-11 00:45:16.617713 | 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-03-11 00:45:16.617952 | 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-03-11 00:45:16.618175 | ubuntu-focal | 2026-03-11 00:45:16.957778 | ubuntu-focal | 2026-03-11 00:45:16.957879 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-03-11 00:45:16.958049 | ubuntu-focal | 2026-03-11 00:45:16.958226 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-03-11 00:45:16.958411 | ubuntu-focal | Wednesday 11 March 2026 00:45:16 +0000 (0:00:00.029) 0:00:00.029 ******* 2026-03-11 00:45:18.178851 | 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-03-11 00:45:18.181743 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:18.181805 | ubuntu-focal | 2026-03-11 00:45:18.181912 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-03-11 00:45:18.181999 | ubuntu-focal | Wednesday 11 March 2026 00:45:18 +0000 (0:00:01.225) 0:00:01.255 ******* 2026-03-11 00:45:33.484977 | ubuntu-focal | changed: [ubuntu-focal] 2026-03-11 00:45:33.485084 | ubuntu-focal | 2026-03-11 00:45:33.485321 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-03-11 00:45:33.485548 | ubuntu-focal | Wednesday 11 March 2026 00:45:33 +0000 (0:00:15.302) 0:00:16.557 ******* 2026-03-11 00:45:34.137521 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:34.137658 | ubuntu-focal | 2026-03-11 00:45:34.137844 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-03-11 00:45:34.138041 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-11 00:45:34.138197 | ubuntu-focal | 2026-03-11 00:45:34.138345 | ubuntu-focal | 2026-03-11 00:45:34.138503 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-03-11 00:45:34.138676 | ubuntu-focal | Wednesday 11 March 2026 00:45:34 +0000 (0:00:00.652) 0:00:17.210 ******* 2026-03-11 00:45:34.138834 | ubuntu-focal | =============================================================================== 2026-03-11 00:45:34.138999 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 15.30s 2026-03-11 00:45:34.139167 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.23s 2026-03-11 00:45:34.139331 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.65s 2026-03-11 00:45:34.274714 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-03-11 00:45:34.284137 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-03-11 00:45:34.785069 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-03-11 00:45:34.785289 | 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-03-11 00:45:34.785441 | 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-03-11 00:45:34.785673 | ubuntu-focal | 2026-03-11 00:45:35.087346 | ubuntu-focal | 2026-03-11 00:45:35.087503 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-03-11 00:45:35.087662 | ubuntu-focal | 2026-03-11 00:45:35.087842 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-03-11 00:45:35.088012 | ubuntu-focal | Wednesday 11 March 2026 00:45:35 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-03-11 00:45:36.115841 | 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-03-11 00:45:36.117772 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:36.117875 | ubuntu-focal | 2026-03-11 00:45:36.117998 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-11 00:45:36.118117 | ubuntu-focal | Wednesday 11 March 2026 00:45:36 +0000 (0:00:01.030) 0:00:01.038 ******* 2026-03-11 00:45:36.463446 | 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-03-11 00:45:36.467290 | ubuntu-focal | changed: [ubuntu-focal] 2026-03-11 00:45:36.467469 | ubuntu-focal | 2026-03-11 00:45:36.467654 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-03-11 00:45:36.467848 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-11 00:45:36.468045 | ubuntu-focal | 2026-03-11 00:45:36.468228 | ubuntu-focal | 2026-03-11 00:45:36.468439 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-03-11 00:45:36.468681 | ubuntu-focal | Wednesday 11 March 2026 00:45:36 +0000 (0:00:00.349) 0:00:01.388 ******* 2026-03-11 00:45:36.468852 | ubuntu-focal | =============================================================================== 2026-03-11 00:45:36.469035 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.03s 2026-03-11 00:45:36.469290 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.35s 2026-03-11 00:45:36.612060 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-03-11 00:45:36.623686 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-03-11 00:45:37.090521 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-03-11 00:45:37.090634 | 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-03-11 00:45:37.090775 | 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-03-11 00:45:37.090932 | ubuntu-focal | 2026-03-11 00:45:37.375730 | ubuntu-focal | 2026-03-11 00:45:37.375904 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-03-11 00:45:37.376073 | ubuntu-focal | 2026-03-11 00:45:37.376257 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-03-11 00:45:37.376436 | ubuntu-focal | Wednesday 11 March 2026 00:45:37 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-03-11 00:45:38.373953 | 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-03-11 00:45:38.376693 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:38.376730 | ubuntu-focal | 2026-03-11 00:45:38.376805 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-11 00:45:38.376884 | ubuntu-focal | Wednesday 11 March 2026 00:45:38 +0000 (0:00:01.001) 0:00:01.008 ******* 2026-03-11 00:45:38.711953 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:38.712073 | ubuntu-focal | 2026-03-11 00:45:38.712251 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-03-11 00:45:38.712444 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-11 00:45:38.712595 | ubuntu-focal | 2026-03-11 00:45:38.712742 | ubuntu-focal | 2026-03-11 00:45:38.712905 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-03-11 00:45:38.713074 | ubuntu-focal | Wednesday 11 March 2026 00:45:38 +0000 (0:00:00.335) 0:00:01.343 ******* 2026-03-11 00:45:38.713227 | ubuntu-focal | =============================================================================== 2026-03-11 00:45:38.713386 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.00s 2026-03-11 00:45:38.713589 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.34s 2026-03-11 00:45:38.792860 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-03-11 00:45:38.804550 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-03-11 00:45:38.805135 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-11 00:45:38.811595 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-03-11 00:45:39.269042 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-03-11 00:45:39.269234 | 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-03-11 00:45:39.269428 | 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-03-11 00:45:39.269677 | ubuntu-focal | 2026-03-11 00:45:39.552759 | ubuntu-focal | 2026-03-11 00:45:39.552901 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-03-11 00:45:39.553060 | ubuntu-focal | 2026-03-11 00:45:39.553232 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-03-11 00:45:39.553408 | ubuntu-focal | Wednesday 11 March 2026 00:45:39 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-03-11 00:45:40.534719 | 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-03-11 00:45:40.537033 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:40.537201 | ubuntu-focal | 2026-03-11 00:45:40.537389 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-03-11 00:45:40.537631 | ubuntu-focal | Wednesday 11 March 2026 00:45:40 +0000 (0:00:00.984) 0:00:00.991 ******* 2026-03-11 00:45:42.422854 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:42.422924 | ubuntu-focal | 2026-03-11 00:45:42.422935 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-03-11 00:45:42.426206 | ubuntu-focal | Wednesday 11 March 2026 00:45:42 +0000 (0:00:01.886) 0:00:02.877 ******* 2026-03-11 00:45:44.139158 | ubuntu-focal | ok: [ubuntu-focal] 2026-03-11 00:45:44.139312 | ubuntu-focal | 2026-03-11 00:45:44.139583 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-03-11 00:45:44.139796 | ubuntu-focal | Wednesday 11 March 2026 00:45:44 +0000 (0:00:01.715) 0:00:04.593 ******* 2026-03-11 00:45:44.164234 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-03-11 00:45:44.164445 | ubuntu-focal | "changed": false, 2026-03-11 00:45:44.164639 | ubuntu-focal | "msg": "All assertions passed" 2026-03-11 00:45:44.164799 | ubuntu-focal | } 2026-03-11 00:45:44.164955 | ubuntu-focal | 2026-03-11 00:45:44.165136 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-03-11 00:45:44.165313 | ubuntu-focal | Wednesday 11 March 2026 00:45:44 +0000 (0:00:00.025) 0:00:04.618 ******* 2026-03-11 00:45:44.188799 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-03-11 00:45:44.188950 | ubuntu-focal | "changed": false, 2026-03-11 00:45:44.189122 | ubuntu-focal | "msg": "All assertions passed" 2026-03-11 00:45:44.189284 | ubuntu-focal | } 2026-03-11 00:45:44.189495 | ubuntu-focal | 2026-03-11 00:45:44.189698 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-03-11 00:45:44.189889 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-11 00:45:44.190036 | ubuntu-focal | 2026-03-11 00:45:44.190184 | ubuntu-focal | 2026-03-11 00:45:44.190346 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-03-11 00:45:44.190515 | ubuntu-focal | Wednesday 11 March 2026 00:45:44 +0000 (0:00:00.024) 0:00:04.643 ******* 2026-03-11 00:45:44.190671 | ubuntu-focal | =============================================================================== 2026-03-11 00:45:44.190838 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.89s 2026-03-11 00:45:44.191002 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.72s 2026-03-11 00:45:44.191170 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 0.98s 2026-03-11 00:45:44.191338 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-03-11 00:45:44.191506 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-03-11 00:45:44.271490 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-03-11 00:45:44.282556 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-03-11 00:45:44.282817 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-11 00:45:44.288759 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-03-11 00:45:44.288838 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-03-11 00:45:44.288886 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-03-11 00:45:44.289184 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-11 00:45:44.591603 | ubuntu-focal | ok: Runtime: 0:00:44.545596 2026-03-11 00:45:44.595642 | 2026-03-11 00:45:44.595707 | PLAY RECAP 2026-03-11 00:45:44.595773 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 00:45:44.595804 | 2026-03-11 00:45:44.731228 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-11 00:45:44.733373 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-11 00:45:45.311299 | 2026-03-11 00:45:45.311427 | PLAY [all] 2026-03-11 00:45:45.325918 | 2026-03-11 00:45:45.326016 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-11 00:45:45.372197 | ubuntu-focal | skipping: Conditional result was False 2026-03-11 00:45:45.382740 | 2026-03-11 00:45:45.382820 | TASK [fetch-output : Set log path for single node] 2026-03-11 00:45:45.427895 | ubuntu-focal | ok 2026-03-11 00:45:45.432437 | 2026-03-11 00:45:45.432503 | LOOP [fetch-output : Ensure local output dirs] 2026-03-11 00:45:45.840406 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/logs" 2026-03-11 00:45:46.068511 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/artifacts" 2026-03-11 00:45:46.282591 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/bf2a887150a843dcb12e553100ad29b6/work/docs" 2026-03-11 00:45:46.296324 | 2026-03-11 00:45:46.296456 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-11 00:45:47.851726 | ubuntu-focal | ok 2026-03-11 00:45:47.851963 | ubuntu-focal | changed: All items complete 2026-03-11 00:45:47.851991 | 2026-03-11 00:45:48.246924 | ubuntu-focal | changed: .d..t...... ./ 2026-03-11 00:45:48.653494 | ubuntu-focal | changed: .d..t...... ./ 2026-03-11 00:45:48.679026 | 2026-03-11 00:45:48.679145 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-11 00:45:49.083837 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.007748 2026-03-11 00:45:49.311312 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.007506 2026-03-11 00:45:49.331341 | 2026-03-11 00:45:49.331448 | PLAY [all] 2026-03-11 00:45:49.337301 | 2026-03-11 00:45:49.337365 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-11 00:45:49.708401 | ubuntu-focal | changed 2026-03-11 00:45:49.713638 | 2026-03-11 00:45:49.713695 | PLAY RECAP 2026-03-11 00:45:49.713740 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-11 00:45:49.713762 | 2026-03-11 00:45:49.817447 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-11 00:45:49.819451 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-11 00:45:50.384879 | 2026-03-11 00:45:50.385057 | PLAY [localhost] 2026-03-11 00:45:50.394649 | 2026-03-11 00:45:50.394719 | TASK [Generate Zuul manifest] 2026-03-11 00:45:50.413656 | localhost | ok 2026-03-11 00:45:50.427721 | 2026-03-11 00:45:50.427798 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-11 00:45:50.758248 | localhost | changed 2026-03-11 00:45:50.768865 | 2026-03-11 00:45:50.768933 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-11 00:45:50.800854 | localhost | ok 2026-03-11 00:45:50.811560 | 2026-03-11 00:45:50.811631 | TASK [Upload logs] 2026-03-11 00:45:50.833113 | localhost | ok 2026-03-11 00:45:50.891952 | 2026-03-11 00:45:50.892139 | TASK [Set zuul-log-path fact] 2026-03-11 00:45:50.913923 | localhost | ok 2026-03-11 00:45:50.925320 | 2026-03-11 00:45:50.925395 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 00:45:50.956802 | localhost | ok 2026-03-11 00:45:50.966954 | 2026-03-11 00:45:50.967046 | TASK [upload-logs : Create log directories] 2026-03-11 00:45:51.373392 | localhost | changed 2026-03-11 00:45:51.378981 | 2026-03-11 00:45:51.379046 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-11 00:45:51.765494 | localhost -> localhost | ok: Runtime: 0:00:00.004209 2026-03-11 00:45:51.771296 | 2026-03-11 00:45:51.771357 | TASK [upload-logs : Upload logs to log server] 2026-03-11 00:45:52.260211 | localhost | Output suppressed because no_log was given 2026-03-11 00:45:52.265732 | 2026-03-11 00:45:52.265800 | LOOP [upload-logs : Compress console log and json output] 2026-03-11 00:45:52.310943 | localhost | skipping: Conditional result was False 2026-03-11 00:45:52.318014 | localhost | skipping: Conditional result was False 2026-03-11 00:45:52.329788 | 2026-03-11 00:45:52.329888 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-11 00:45:52.370006 | localhost | skipping: Conditional result was False 2026-03-11 00:45:52.370414 | 2026-03-11 00:45:52.374153 | localhost | skipping: Conditional result was False 2026-03-11 00:45:52.392609 | 2026-03-11 00:45:52.392822 | LOOP [upload-logs : Upload console log and json output]