2026-04-27 11:43:09.867954 | Job console starting 2026-04-27 11:43:09.903553 | Updating git repos 2026-04-27 11:43:09.928281 | Cloning repos into workspace 2026-04-27 11:43:09.992255 | Restoring repo states 2026-04-27 11:43:10.019154 | Merging changes 2026-04-27 11:43:10.385513 | Checking out repos 2026-04-27 11:43:10.425458 | Preparing playbooks 2026-04-27 11:43:11.807165 | Running Ansible setup 2026-04-27 11:43:16.472042 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-27 11:43:17.137375 | 2026-04-27 11:43:17.204310 | PLAY [localhost] 2026-04-27 11:43:17.217012 | 2026-04-27 11:43:17.217125 | TASK [Gathering Facts] 2026-04-27 11:43:18.388507 | localhost | ok 2026-04-27 11:43:18.396751 | 2026-04-27 11:43:18.407716 | TASK [Setup log path fact] 2026-04-27 11:43:18.427403 | localhost | ok 2026-04-27 11:43:18.439936 | 2026-04-27 11:43:18.440072 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-27 11:43:18.468841 | localhost | ok 2026-04-27 11:43:18.480136 | 2026-04-27 11:43:18.480320 | TASK [emit-job-header : Print job information] 2026-04-27 11:43:18.529545 | # Job Information 2026-04-27 11:43:18.529727 | Ansible Version: 2.16.16 2026-04-27 11:43:18.529772 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-04-27 11:43:18.529799 | Pipeline: check 2026-04-27 11:43:18.529821 | Executor: 0a8996d2b663 2026-04-27 11:43:18.529842 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/124 2026-04-27 11:43:18.529865 | Event ID: cd948420-422d-11f1-9e04-109c29d93f2e 2026-04-27 11:43:18.533990 | 2026-04-27 11:43:18.534096 | LOOP [emit-job-header : Print node information] 2026-04-27 11:43:18.646770 | localhost | ok: 2026-04-27 11:43:18.647215 | localhost | # Node Information 2026-04-27 11:43:18.647267 | localhost | Inventory Hostname: ubuntu-focal 2026-04-27 11:43:18.647341 | localhost | Hostname: np0000170502 2026-04-27 11:43:18.647433 | localhost | Username: zuul 2026-04-27 11:43:18.647735 | localhost | Distro: Ubuntu 20.04 2026-04-27 11:43:18.647794 | localhost | Provider: yul1 2026-04-27 11:43:18.647835 | localhost | Region: ca-ymq-1 2026-04-27 11:43:18.647870 | localhost | Label: ubuntu-focal 2026-04-27 11:43:18.647904 | localhost | Product Name: OpenStack Nova 2026-04-27 11:43:18.647937 | localhost | Interface IP: 199.19.213.11 2026-04-27 11:43:18.662223 | 2026-04-27 11:43:18.662424 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-27 11:43:19.266116 | localhost -> localhost | changed 2026-04-27 11:43:19.272694 | 2026-04-27 11:43:19.272838 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-27 11:43:20.349901 | localhost -> localhost | changed 2026-04-27 11:43:20.361685 | 2026-04-27 11:43:20.361795 | PLAY [all] 2026-04-27 11:43:20.377283 | 2026-04-27 11:43:20.377378 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-27 11:43:20.706932 | ubuntu-focal -> localhost | ok 2026-04-27 11:43:20.716683 | 2026-04-27 11:43:20.716840 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-27 11:43:20.752559 | ubuntu-focal | ok 2026-04-27 11:43:20.772294 | ubuntu-focal | included: /var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-27 11:43:20.781096 | 2026-04-27 11:43:20.781256 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-27 11:43:21.693723 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-04-27 11:43:21.693941 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/1ad372ef64614e70978b8cbb5d262ab5_id_rsa 2026-04-27 11:43:21.693990 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/1ad372ef64614e70978b8cbb5d262ab5_id_rsa.pub 2026-04-27 11:43:21.694026 | ubuntu-focal -> localhost | The key fingerprint is: 2026-04-27 11:43:21.694058 | ubuntu-focal -> localhost | SHA256:LlxxZNlLUu2TR9imQbQ/ImTzklzY3vPaT5YdghV3TVs zuul-build-sshkey 2026-04-27 11:43:21.694105 | ubuntu-focal -> localhost | The key's randomart image is: 2026-04-27 11:43:21.694138 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-04-27 11:43:21.694176 | ubuntu-focal -> localhost | | o+.=o=E| 2026-04-27 11:43:21.694209 | ubuntu-focal -> localhost | | oo = *.O| 2026-04-27 11:43:21.694240 | ubuntu-focal -> localhost | | . .B *.B | 2026-04-27 11:43:21.694269 | ubuntu-focal -> localhost | | o+ X *..| 2026-04-27 11:43:21.694299 | ubuntu-focal -> localhost | | S * = B.| 2026-04-27 11:43:21.694328 | ubuntu-focal -> localhost | | . o o o B| 2026-04-27 11:43:21.694358 | ubuntu-focal -> localhost | | o . .=| 2026-04-27 11:43:21.694387 | ubuntu-focal -> localhost | | . = | 2026-04-27 11:43:21.694419 | ubuntu-focal -> localhost | | . +| 2026-04-27 11:43:21.694449 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-04-27 11:43:21.694519 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.397445 2026-04-27 11:43:21.701445 | 2026-04-27 11:43:21.701543 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-27 11:43:21.737990 | ubuntu-focal | ok 2026-04-27 11:43:21.763424 | ubuntu-focal | included: /var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-27 11:43:21.774342 | 2026-04-27 11:43:21.774491 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-27 11:43:21.811979 | ubuntu-focal | skipping: Conditional result was False 2026-04-27 11:43:21.819382 | 2026-04-27 11:43:21.819691 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-27 11:43:22.472803 | ubuntu-focal | changed 2026-04-27 11:43:22.479625 | 2026-04-27 11:43:22.479761 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-27 11:43:22.713132 | ubuntu-focal | ok 2026-04-27 11:43:22.721478 | 2026-04-27 11:43:22.721589 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-27 11:43:23.245944 | ubuntu-focal | changed 2026-04-27 11:43:23.251706 | 2026-04-27 11:43:23.251780 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-27 11:43:23.740709 | ubuntu-focal | changed 2026-04-27 11:43:23.748428 | 2026-04-27 11:43:23.748528 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-27 11:43:23.772363 | ubuntu-focal | skipping: Conditional result was False 2026-04-27 11:43:23.788493 | 2026-04-27 11:43:23.788633 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-27 11:43:24.276676 | ubuntu-focal -> localhost | changed 2026-04-27 11:43:24.299881 | 2026-04-27 11:43:24.300066 | TASK [add-build-sshkey : Add back temp key] 2026-04-27 11:43:24.659512 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/1ad372ef64614e70978b8cbb5d262ab5_id_rsa (zuul-build-sshkey) 2026-04-27 11:43:24.659753 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.021175 2026-04-27 11:43:24.665782 | 2026-04-27 11:43:24.665917 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-27 11:43:25.030590 | ubuntu-focal | ok 2026-04-27 11:43:25.046928 | 2026-04-27 11:43:25.047025 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-27 11:43:25.077451 | ubuntu-focal | skipping: Conditional result was False 2026-04-27 11:43:25.091367 | 2026-04-27 11:43:25.091523 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-27 11:43:25.425784 | ubuntu-focal | ok 2026-04-27 11:43:25.434287 | 2026-04-27 11:43:25.434435 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-27 11:43:26.389975 | ubuntu-focal | Output suppressed because no_log was given 2026-04-27 11:43:26.409267 | 2026-04-27 11:43:26.409393 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-27 11:43:26.592834 | ubuntu-focal | ok: "logs" 2026-04-27 11:43:26.593173 | ubuntu-focal | ok: All items complete 2026-04-27 11:43:26.593213 | 2026-04-27 11:43:26.742823 | ubuntu-focal | ok: "artifacts" 2026-04-27 11:43:26.893298 | ubuntu-focal | ok: "docs" 2026-04-27 11:43:26.911661 | 2026-04-27 11:43:26.911834 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-27 11:43:27.093122 | ubuntu-focal | changed: "logs" 2026-04-27 11:43:27.296086 | ubuntu-focal | changed: "artifacts" 2026-04-27 11:43:27.390980 | ubuntu-focal | changed: "docs" 2026-04-27 11:43:27.412459 | 2026-04-27 11:43:27.412604 | PLAY RECAP 2026-04-27 11:43:27.412673 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-27 11:43:27.412723 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-27 11:43:27.412757 | 2026-04-27 11:43:27.642518 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-27 11:43:27.643837 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-27 11:43:28.395217 | 2026-04-27 11:43:28.395377 | PLAY [all] 2026-04-27 11:43:28.407460 | 2026-04-27 11:43:28.407610 | TASK [setup-uv : Extract archive] 2026-04-27 11:43:30.710285 | ubuntu-focal | changed 2026-04-27 11:43:30.717270 | 2026-04-27 11:43:30.717426 | TASK [setup-uv : Print version] 2026-04-27 11:43:30.278838 | ubuntu-focal | uv 0.8.13 2026-04-27 11:43:31.285086 | ubuntu-focal | ok: Runtime: 0:00:00.006984 2026-04-27 11:43:31.293054 | 2026-04-27 11:43:31.293103 | PLAY RECAP 2026-04-27 11:43:31.293146 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-27 11:43:31.293172 | 2026-04-27 11:43:31.399941 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-27 11:43:31.401578 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-27 11:43:32.134053 | 2026-04-27 11:43:32.134222 | PLAY [all] 2026-04-27 11:43:32.146780 | 2026-04-27 11:43:32.146940 | TASK [Copy inventory file for Zuul] 2026-04-27 11:43:33.071045 | ubuntu-focal | changed 2026-04-27 11:43:33.079672 | 2026-04-27 11:43:33.079809 | TASK [Switch "ansible_host" to private IP] 2026-04-27 11:43:33.395749 | ubuntu-focal | changed: 1 replacements made 2026-04-27 11:43:33.403034 | 2026-04-27 11:43:33.403148 | TASK [Run Molecule scenario] 2026-04-27 11:43:33.126831 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-27 11:43:34.815200 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-27 11:43:35.025552 | ubuntu-focal | Using CPython 3.13.7 2026-04-27 11:43:35.025650 | ubuntu-focal | Creating virtual environment at: .venv 2026-04-27 11:43:35.297115 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-04-27 11:43:35.299359 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-04-27 11:43:35.299816 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-04-27 11:43:35.475721 | ubuntu-focal | Downloading cryptography 2026-04-27 11:43:35.519083 | ubuntu-focal | Downloading pygments 2026-04-27 11:43:35.667598 | ubuntu-focal | Downloading ansible-core 2026-04-27 11:43:35.694788 | ubuntu-focal | Installed 36 packages in 26ms 2026-04-27 11:43:36.944530 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-04-27 11:43:36.944642 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-04-27 11:43:37.882322 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-27 11:43:37.882396 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-04-27 11:43:37.882468 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-27 11:43:37.882540 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-27 11:43:47.333240 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-04-27 11:43:47.333431 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-27 11:43:47.333702 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-27 11:43:47.333854 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-27 11:43:47.341246 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-27 11:43:47.341501 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-27 11:43:47.346423 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-27 11:43:47.346459 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-27 11:43:47.346516 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-27 11:43:47.351544 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-04-27 11:43:47.896000 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-27 11:43:47.896182 | 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-27 11:43:47.896336 | 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-27 11:43:47.896453 | ubuntu-focal | 2026-04-27 11:43:48.300463 | ubuntu-focal | 2026-04-27 11:43:48.300549 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-27 11:43:48.425000 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-04-27 11:43:48.434231 | ubuntu-focal | INFO [forget-package > create] Executing 2026-04-27 11:43:48.435722 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-27 11:43:48.440822 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-04-27 11:43:49.002336 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-27 11:43:49.002570 | 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-27 11:43:49.002883 | 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-27 11:43:49.003206 | ubuntu-focal | 2026-04-27 11:43:49.406618 | ubuntu-focal | 2026-04-27 11:43:49.406821 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-04-27 11:43:49.406998 | ubuntu-focal | 2026-04-27 11:43:49.407261 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-27 11:43:49.407544 | ubuntu-focal | Monday 27 April 2026 11:43:49 +0000 (0:00:00.045) 0:00:00.045 ********** 2026-04-27 11:43:50.645741 | 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-27 11:43:50.647662 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:43:50.647834 | ubuntu-focal | 2026-04-27 11:43:50.648022 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-04-27 11:43:50.648192 | ubuntu-focal | Monday 27 April 2026 11:43:50 +0000 (0:00:01.242) 0:00:01.287 ********** 2026-04-27 11:44:34.666440 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-27 11:44:34.666663 | ubuntu-focal | 2026-04-27 11:44:34.666888 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-04-27 11:44:34.667217 | ubuntu-focal | Monday 27 April 2026 11:44:34 +0000 (0:00:44.018) 0:00:45.306 ********** 2026-04-27 11:44:35.368386 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:35.368549 | ubuntu-focal | 2026-04-27 11:44:35.368835 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-27 11:44:35.369072 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-27 11:44:35.369304 | ubuntu-focal | 2026-04-27 11:44:35.369518 | ubuntu-focal | 2026-04-27 11:44:35.369784 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-27 11:44:35.370040 | ubuntu-focal | Monday 27 April 2026 11:44:35 +0000 (0:00:00.702) 0:00:46.008 ********** 2026-04-27 11:44:35.370225 | ubuntu-focal | =============================================================================== 2026-04-27 11:44:35.370401 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 44.02s 2026-04-27 11:44:35.370594 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.24s 2026-04-27 11:44:35.370805 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.70s 2026-04-27 11:44:35.494386 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-04-27 11:44:35.503468 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-04-27 11:44:36.022294 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-27 11:44:36.022585 | 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-27 11:44:36.022848 | 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-27 11:44:36.023131 | ubuntu-focal | 2026-04-27 11:44:36.342101 | ubuntu-focal | 2026-04-27 11:44:36.342273 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-27 11:44:36.342451 | ubuntu-focal | 2026-04-27 11:44:36.342645 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-27 11:44:36.342817 | ubuntu-focal | Monday 27 April 2026 11:44:36 +0000 (0:00:00.008) 0:00:00.008 ********** 2026-04-27 11:44:37.388151 | 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-27 11:44:37.389919 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:37.390009 | ubuntu-focal | 2026-04-27 11:44:37.390128 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-27 11:44:37.390231 | ubuntu-focal | Monday 27 April 2026 11:44:37 +0000 (0:00:01.048) 0:00:01.056 ********** 2026-04-27 11:44:37.739138 | 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-27 11:44:37.742812 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-27 11:44:37.742922 | ubuntu-focal | 2026-04-27 11:44:37.743071 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-27 11:44:37.743216 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-27 11:44:37.743332 | ubuntu-focal | 2026-04-27 11:44:37.743445 | ubuntu-focal | 2026-04-27 11:44:37.743570 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-27 11:44:37.743741 | ubuntu-focal | Monday 27 April 2026 11:44:37 +0000 (0:00:00.353) 0:00:01.409 ********** 2026-04-27 11:44:37.743856 | ubuntu-focal | =============================================================================== 2026-04-27 11:44:37.743980 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.05s 2026-04-27 11:44:37.744097 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.35s 2026-04-27 11:44:37.836796 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-04-27 11:44:37.845944 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-04-27 11:44:38.413403 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-27 11:44:38.413596 | 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-27 11:44:38.413802 | 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-27 11:44:38.414038 | ubuntu-focal | 2026-04-27 11:44:38.723899 | ubuntu-focal | 2026-04-27 11:44:38.723955 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-27 11:44:38.724018 | ubuntu-focal | 2026-04-27 11:44:38.724108 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-27 11:44:38.724204 | ubuntu-focal | Monday 27 April 2026 11:44:38 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-04-27 11:44:39.805733 | 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-27 11:44:39.807731 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:39.807923 | ubuntu-focal | 2026-04-27 11:44:39.808136 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-27 11:44:39.808318 | ubuntu-focal | Monday 27 April 2026 11:44:39 +0000 (0:00:01.083) 0:00:01.091 ********** 2026-04-27 11:44:40.176728 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:40.176792 | ubuntu-focal | 2026-04-27 11:44:40.176942 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-27 11:44:40.177075 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-27 11:44:40.177187 | ubuntu-focal | 2026-04-27 11:44:40.177304 | ubuntu-focal | 2026-04-27 11:44:40.177421 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-27 11:44:40.177551 | ubuntu-focal | Monday 27 April 2026 11:44:40 +0000 (0:00:00.369) 0:00:01.460 ********** 2026-04-27 11:44:40.177658 | ubuntu-focal | =============================================================================== 2026-04-27 11:44:40.177775 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-27 11:44:40.177899 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.37s 2026-04-27 11:44:40.283104 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-04-27 11:44:40.293175 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-04-27 11:44:40.293864 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-27 11:44:40.302139 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-04-27 11:44:40.853372 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-27 11:44:40.853528 | 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-27 11:44:40.853705 | 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-27 11:44:40.853843 | ubuntu-focal | 2026-04-27 11:44:41.188817 | ubuntu-focal | 2026-04-27 11:44:41.189151 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-04-27 11:44:41.189419 | ubuntu-focal | 2026-04-27 11:44:41.189749 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-27 11:44:41.190037 | ubuntu-focal | Monday 27 April 2026 11:44:41 +0000 (0:00:00.008) 0:00:00.008 ********** 2026-04-27 11:44:42.239661 | 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-27 11:44:42.241229 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:42.241610 | ubuntu-focal | 2026-04-27 11:44:42.242015 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-04-27 11:44:42.242310 | ubuntu-focal | Monday 27 April 2026 11:44:42 +0000 (0:00:01.053) 0:00:01.061 ********** 2026-04-27 11:44:44.192287 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:44.192435 | ubuntu-focal | 2026-04-27 11:44:44.192694 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-04-27 11:44:44.192894 | ubuntu-focal | Monday 27 April 2026 11:44:44 +0000 (0:00:01.950) 0:00:03.011 ********** 2026-04-27 11:44:46.054456 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-27 11:44:46.054597 | ubuntu-focal | 2026-04-27 11:44:46.054826 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-27 11:44:46.055057 | ubuntu-focal | Monday 27 April 2026 11:44:46 +0000 (0:00:01.862) 0:00:04.874 ********** 2026-04-27 11:44:46.081315 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-27 11:44:46.081438 | ubuntu-focal | "changed": false, 2026-04-27 11:44:46.081640 | ubuntu-focal | "msg": "All assertions passed" 2026-04-27 11:44:46.081818 | ubuntu-focal | } 2026-04-27 11:44:46.081982 | ubuntu-focal | 2026-04-27 11:44:46.082169 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-27 11:44:46.082420 | ubuntu-focal | Monday 27 April 2026 11:44:46 +0000 (0:00:00.026) 0:00:04.900 ********** 2026-04-27 11:44:46.106921 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-27 11:44:46.107066 | ubuntu-focal | "changed": false, 2026-04-27 11:44:46.107301 | ubuntu-focal | "msg": "All assertions passed" 2026-04-27 11:44:46.107455 | ubuntu-focal | } 2026-04-27 11:44:46.107619 | ubuntu-focal | 2026-04-27 11:44:46.107791 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-27 11:44:46.107981 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-27 11:44:46.108134 | ubuntu-focal | 2026-04-27 11:44:46.108279 | ubuntu-focal | 2026-04-27 11:44:46.108509 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-27 11:44:46.108686 | ubuntu-focal | Monday 27 April 2026 11:44:46 +0000 (0:00:00.026) 0:00:04.927 ********** 2026-04-27 11:44:46.108864 | ubuntu-focal | =============================================================================== 2026-04-27 11:44:46.109071 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.95s 2026-04-27 11:44:46.109232 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.86s 2026-04-27 11:44:46.109538 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.05s 2026-04-27 11:44:46.109750 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-27 11:44:46.109922 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-04-27 11:44:46.196916 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-04-27 11:44:46.207982 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-27 11:44:46.208244 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-27 11:44:46.213725 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-27 11:44:46.213761 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-27 11:44:46.213843 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-27 11:44:46.214121 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-27 11:44:46.554507 | ubuntu-focal | ok: Runtime: 0:01:13.368359 2026-04-27 11:44:46.563870 | 2026-04-27 11:44:46.564146 | PLAY RECAP 2026-04-27 11:44:46.564667 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-27 11:44:46.564761 | 2026-04-27 11:44:46.733352 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-27 11:44:46.735171 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-27 11:44:47.384535 | 2026-04-27 11:44:47.384930 | PLAY [all] 2026-04-27 11:44:47.407699 | 2026-04-27 11:44:47.407918 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-27 11:44:47.455074 | ubuntu-focal | skipping: Conditional result was False 2026-04-27 11:44:47.466906 | 2026-04-27 11:44:47.467176 | TASK [fetch-output : Set log path for single node] 2026-04-27 11:44:47.514344 | ubuntu-focal | ok 2026-04-27 11:44:47.519979 | 2026-04-27 11:44:47.520118 | LOOP [fetch-output : Ensure local output dirs] 2026-04-27 11:44:47.965885 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/logs" 2026-04-27 11:44:48.189340 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/artifacts" 2026-04-27 11:44:48.461931 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/1ad372ef64614e70978b8cbb5d262ab5/work/docs" 2026-04-27 11:44:48.483013 | 2026-04-27 11:44:48.483172 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-27 11:44:49.076920 | ubuntu-focal | changed: .d..t...... ./ 2026-04-27 11:44:49.077202 | ubuntu-focal | changed: All items complete 2026-04-27 11:44:49.077245 | 2026-04-27 11:44:49.480397 | ubuntu-focal | changed: .d..t...... ./ 2026-04-27 11:44:49.907443 | ubuntu-focal | changed: .d..t...... ./ 2026-04-27 11:44:49.929772 | 2026-04-27 11:44:49.929942 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-27 11:44:50.416507 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.006451 2026-04-27 11:44:50.688007 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.008141 2026-04-27 11:44:50.705089 | 2026-04-27 11:44:50.705203 | PLAY [all] 2026-04-27 11:44:50.711793 | 2026-04-27 11:44:50.711869 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-27 11:44:51.216843 | ubuntu-focal | changed 2026-04-27 11:44:51.223298 | 2026-04-27 11:44:51.223387 | PLAY RECAP 2026-04-27 11:44:51.223436 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-27 11:44:51.223458 | 2026-04-27 11:44:51.412535 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-27 11:44:51.413969 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-27 11:44:52.037464 | 2026-04-27 11:44:52.037598 | PLAY [localhost] 2026-04-27 11:44:52.048907 | 2026-04-27 11:44:52.049008 | TASK [Generate Zuul manifest] 2026-04-27 11:44:52.069208 | localhost | ok 2026-04-27 11:44:52.086159 | 2026-04-27 11:44:52.086285 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-27 11:44:52.447399 | localhost | changed 2026-04-27 11:44:52.461009 | 2026-04-27 11:44:52.461229 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-27 11:44:52.570181 | localhost | ok 2026-04-27 11:44:52.577692 | 2026-04-27 11:44:52.577912 | TASK [Upload logs] 2026-04-27 11:44:52.600665 | localhost | ok 2026-04-27 11:44:52.664135 | 2026-04-27 11:44:52.664286 | TASK [Set zuul-log-path fact] 2026-04-27 11:44:52.682735 | localhost | ok 2026-04-27 11:44:52.695590 | 2026-04-27 11:44:52.695659 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-27 11:44:52.726635 | localhost | ok 2026-04-27 11:44:52.737495 | 2026-04-27 11:44:52.737571 | TASK [upload-logs : Create log directories] 2026-04-27 11:44:53.232690 | localhost | changed 2026-04-27 11:44:53.237594 | 2026-04-27 11:44:53.237665 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-27 11:44:54.575051 | localhost -> localhost | ok: Runtime: 0:00:00.007835 2026-04-27 11:44:54.583200 | 2026-04-27 11:44:54.583331 | TASK [upload-logs : Upload logs to log server] 2026-04-27 11:44:55.137873 | localhost | Output suppressed because no_log was given 2026-04-27 11:44:55.142621 | 2026-04-27 11:44:55.142802 | LOOP [upload-logs : Compress console log and json output] 2026-04-27 11:44:55.197260 | localhost | skipping: Conditional result was False 2026-04-27 11:44:55.205934 | localhost | skipping: Conditional result was False 2026-04-27 11:44:55.218274 | 2026-04-27 11:44:55.218477 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-27 11:44:55.270284 | localhost | skipping: Conditional result was False 2026-04-27 11:44:55.270673 | 2026-04-27 11:44:55.271741 | localhost | skipping: Conditional result was False 2026-04-27 11:44:55.289941 | 2026-04-27 11:44:55.290099 | LOOP [upload-logs : Upload console log and json output]