2026-05-21 04:27:07.290448 | Job console starting 2026-05-21 04:27:07.302235 | Updating git repos 2026-05-21 04:27:07.334180 | Cloning repos into workspace 2026-05-21 04:27:10.109456 | Restoring repo states 2026-05-21 04:27:10.120175 | Merging changes 2026-05-21 04:27:10.823005 | Checking out repos 2026-05-21 04:27:11.189661 | Preparing playbooks 2026-05-21 04:27:14.659275 | Running Ansible setup 2026-05-21 04:27:18.908583 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 04:27:19.634199 | 2026-05-21 04:27:19.634418 | PLAY [localhost] 2026-05-21 04:27:19.644602 | 2026-05-21 04:27:19.644765 | TASK [Gathering Facts] 2026-05-21 04:27:20.719639 | localhost | ok 2026-05-21 04:27:20.733149 | 2026-05-21 04:27:20.733274 | TASK [Setup log path fact] 2026-05-21 04:27:20.759942 | localhost | ok 2026-05-21 04:27:20.773045 | 2026-05-21 04:27:20.773155 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 04:27:20.817797 | localhost | ok 2026-05-21 04:27:20.830619 | 2026-05-21 04:27:20.830716 | TASK [emit-job-header : Print job information] 2026-05-21 04:27:20.875130 | # Job Information 2026-05-21 04:27:20.875454 | Ansible Version: 2.16.18 2026-05-21 04:27:20.875505 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-05-21 04:27:20.875540 | Pipeline: check 2026-05-21 04:27:20.875570 | Executor: 2d72f0692154 2026-05-21 04:27:20.875599 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/124 2026-05-21 04:27:20.875644 | Event ID: 2550b0b0-54cd-11f1-825c-3bf074c91116 2026-05-21 04:27:20.879731 | 2026-05-21 04:27:20.879827 | LOOP [emit-job-header : Print node information] 2026-05-21 04:27:20.972117 | localhost | ok: 2026-05-21 04:27:20.972379 | localhost | # Node Information 2026-05-21 04:27:20.972420 | localhost | Inventory Hostname: ubuntu-focal 2026-05-21 04:27:20.972443 | localhost | Hostname: np0000175788 2026-05-21 04:27:20.972463 | localhost | Username: zuul 2026-05-21 04:27:20.972486 | localhost | Distro: Ubuntu 20.04 2026-05-21 04:27:20.972506 | localhost | Provider: yul1 2026-05-21 04:27:20.972532 | localhost | Region: ca-ymq-1 2026-05-21 04:27:20.972555 | localhost | Label: ubuntu-focal 2026-05-21 04:27:20.972574 | localhost | Product Name: OpenStack Nova 2026-05-21 04:27:20.972597 | localhost | Interface IP: 199.204.45.235 2026-05-21 04:27:20.997929 | 2026-05-21 04:27:20.998249 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 04:27:21.668114 | localhost -> localhost | changed 2026-05-21 04:27:21.676102 | 2026-05-21 04:27:21.676335 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 04:27:23.506214 | localhost -> localhost | changed 2026-05-21 04:27:23.516820 | 2026-05-21 04:27:23.516914 | PLAY [all] 2026-05-21 04:27:23.525245 | 2026-05-21 04:27:23.525330 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 04:27:23.783071 | ubuntu-focal -> localhost | ok 2026-05-21 04:27:23.792625 | 2026-05-21 04:27:23.792939 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 04:27:23.829763 | ubuntu-focal | ok 2026-05-21 04:27:23.847447 | ubuntu-focal | included: /var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 04:27:23.854973 | 2026-05-21 04:27:23.855049 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 04:27:25.302166 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-05-21 04:27:25.302857 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/8785cde4ec2f4aea88a670077c2edc69_id_rsa 2026-05-21 04:27:25.302914 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/8785cde4ec2f4aea88a670077c2edc69_id_rsa.pub 2026-05-21 04:27:25.302960 | ubuntu-focal -> localhost | The key fingerprint is: 2026-05-21 04:27:25.303003 | ubuntu-focal -> localhost | SHA256:2XpFN6DLeMPmZmIa3iwe7aPIj1DRgl8DA1WqmvcAV30 zuul-build-sshkey 2026-05-21 04:27:25.303089 | ubuntu-focal -> localhost | The key's randomart image is: 2026-05-21 04:27:25.303136 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-05-21 04:27:25.303174 | ubuntu-focal -> localhost | | .o+.. . | 2026-05-21 04:27:25.303207 | ubuntu-focal -> localhost | | . * . . | 2026-05-21 04:27:25.303239 | ubuntu-focal -> localhost | | . = = E . . o | 2026-05-21 04:27:25.303270 | ubuntu-focal -> localhost | | + + o * o . . | 2026-05-21 04:27:25.303302 | ubuntu-focal -> localhost | |. o o S O . | 2026-05-21 04:27:25.303344 | ubuntu-focal -> localhost | | = . . = o | 2026-05-21 04:27:25.303380 | ubuntu-focal -> localhost | |o + o = = | 2026-05-21 04:27:25.303415 | ubuntu-focal -> localhost | | . = +.O.= | 2026-05-21 04:27:25.303452 | ubuntu-focal -> localhost | | =o*o+. | 2026-05-21 04:27:25.303483 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-05-21 04:27:25.303566 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.643227 2026-05-21 04:27:25.314645 | 2026-05-21 04:27:25.314815 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 04:27:25.352333 | ubuntu-focal | ok 2026-05-21 04:27:25.364823 | ubuntu-focal | included: /var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 04:27:25.376023 | 2026-05-21 04:27:25.376149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 04:27:25.401599 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:27:25.409843 | 2026-05-21 04:27:25.410001 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 04:27:25.911030 | ubuntu-focal | changed 2026-05-21 04:27:25.916165 | 2026-05-21 04:27:25.916241 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 04:27:26.090885 | ubuntu-focal | ok 2026-05-21 04:27:26.100652 | 2026-05-21 04:27:26.100835 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 04:27:26.562667 | ubuntu-focal | changed 2026-05-21 04:27:26.699444 | 2026-05-21 04:27:26.699645 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 04:27:27.147073 | ubuntu-focal | changed 2026-05-21 04:27:27.155785 | 2026-05-21 04:27:27.155991 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 04:27:27.181773 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:27:27.190797 | 2026-05-21 04:27:27.190981 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 04:27:28.102668 | ubuntu-focal -> localhost | changed 2026-05-21 04:27:28.135322 | 2026-05-21 04:27:28.135573 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 04:27:29.045772 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/8785cde4ec2f4aea88a670077c2edc69_id_rsa (zuul-build-sshkey) 2026-05-21 04:27:29.046502 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.010564 2026-05-21 04:27:29.057388 | 2026-05-21 04:27:29.058058 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 04:27:29.382426 | ubuntu-focal | ok 2026-05-21 04:27:29.389325 | 2026-05-21 04:27:29.389390 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 04:27:29.417222 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:27:29.815818 | 2026-05-21 04:27:29.815960 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-21 04:27:30.123959 | ubuntu-focal | ok 2026-05-21 04:27:30.136804 | 2026-05-21 04:27:30.136940 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-21 04:27:31.562570 | ubuntu-focal | Output suppressed because no_log was given 2026-05-21 04:27:31.572662 | 2026-05-21 04:27:31.572742 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-21 04:27:31.802314 | ubuntu-focal | ok: "logs" 2026-05-21 04:27:31.802539 | ubuntu-focal | ok: All items complete 2026-05-21 04:27:31.802588 | 2026-05-21 04:27:31.891626 | ubuntu-focal | ok: "artifacts" 2026-05-21 04:27:32.095977 | ubuntu-focal | ok: "docs" 2026-05-21 04:27:32.116748 | 2026-05-21 04:27:32.116885 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-21 04:27:32.289138 | ubuntu-focal | changed: "logs" 2026-05-21 04:27:32.445688 | ubuntu-focal | changed: "artifacts" 2026-05-21 04:27:32.573028 | ubuntu-focal | changed: "docs" 2026-05-21 04:27:32.594941 | 2026-05-21 04:27:32.595084 | PLAY RECAP 2026-05-21 04:27:32.595149 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:27:32.595184 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-21 04:27:32.595208 | 2026-05-21 04:27:32.799677 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 04:27:32.801577 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 04:27:33.404472 | 2026-05-21 04:27:33.404618 | PLAY [all] 2026-05-21 04:27:33.415821 | 2026-05-21 04:27:33.415929 | TASK [setup-uv : Extract archive] 2026-05-21 04:27:35.547604 | ubuntu-focal | changed 2026-05-21 04:27:35.553732 | 2026-05-21 04:27:35.553819 | TASK [setup-uv : Print version] 2026-05-21 04:27:35.890208 | ubuntu-focal | uv 0.8.13 2026-05-21 04:27:37.364738 | ubuntu-focal | ok: Runtime: 0:00:00.008946 2026-05-21 04:27:37.377104 | 2026-05-21 04:27:37.377313 | TASK [Install Ansible collection siblings] 2026-05-21 04:27:37.734911 | ubuntu-focal | ok: 2026-05-21 04:27:37.735133 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling 2026-05-21 04:27:37.735173 | ubuntu-focal | Skipping community.general: no checked-out sibling 2026-05-21 04:27:37.737438 | 2026-05-21 04:27:37.737503 | PLAY RECAP 2026-05-21 04:27:37.737564 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:27:37.737594 | 2026-05-21 04:27:37.869107 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 04:27:37.872732 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 04:27:38.532037 | 2026-05-21 04:27:38.532170 | PLAY [all] 2026-05-21 04:27:38.544582 | 2026-05-21 04:27:38.544660 | TASK [Copy inventory file for Zuul] 2026-05-21 04:27:39.395096 | ubuntu-focal | changed 2026-05-21 04:27:39.403752 | 2026-05-21 04:27:39.403859 | TASK [Switch "ansible_host" to private IP] 2026-05-21 04:27:39.748812 | ubuntu-focal | changed: 1 replacements made 2026-05-21 04:27:39.757196 | 2026-05-21 04:27:39.757304 | TASK [Run Molecule scenario] 2026-05-21 04:27:40.375598 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-05-21 04:27:41.051079 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-05-21 04:27:41.230154 | ubuntu-focal | Using CPython 3.13.7 2026-05-21 04:27:41.230229 | ubuntu-focal | Creating virtual environment at: .venv 2026-05-21 04:27:41.454694 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-05-21 04:27:41.454774 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-05-21 04:27:41.457569 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-05-21 04:27:41.604098 | ubuntu-focal | Downloading cryptography 2026-05-21 04:27:41.643831 | ubuntu-focal | Downloading pygments 2026-05-21 04:27:41.789302 | ubuntu-focal | Downloading ansible-core 2026-05-21 04:27:41.815615 | ubuntu-focal | Installed 36 packages in 25ms 2026-05-21 04:27:42.886405 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-05-21 04:27:42.886503 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-05-21 04:27:43.654942 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-21 04:27:43.655015 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-05-21 04:27:43.655033 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-21 04:27:43.655126 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-05-21 04:27:53.100013 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-05-21 04:27:53.100287 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-05-21 04:27:53.100537 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-05-21 04:27:53.100679 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-21 04:27:53.107206 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-05-21 04:27:53.107477 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:27:53.112419 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-05-21 04:27:53.112451 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-05-21 04:27:53.112528 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-05-21 04:27:53.117441 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-05-21 04:27:53.643207 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:27:53.643439 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-05-21 04:27:53.643640 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-05-21 04:27:53.643802 | ubuntu-focal | 2026-05-21 04:27:54.009151 | ubuntu-focal | 2026-05-21 04:27:54.009436 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-05-21 04:27:54.098527 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-05-21 04:27:54.109267 | ubuntu-focal | INFO [forget-package > create] Executing 2026-05-21 04:27:54.111308 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:27:54.117256 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-05-21 04:27:54.599412 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:27:54.599572 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-05-21 04:27:54.599829 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-05-21 04:27:54.599949 | ubuntu-focal | 2026-05-21 04:27:54.983479 | ubuntu-focal | 2026-05-21 04:27:54.983618 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-05-21 04:27:54.983775 | ubuntu-focal | 2026-05-21 04:27:54.984002 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:27:54.984214 | ubuntu-focal | Thursday 21 May 2026 04:27:54 +0000 (0:00:00.030) 0:00:00.030 ********** 2026-05-21 04:27:56.144574 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-05-21 04:27:56.146839 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:27:56.146893 | ubuntu-focal | 2026-05-21 04:27:56.146982 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-05-21 04:27:56.147063 | ubuntu-focal | Thursday 21 May 2026 04:27:56 +0000 (0:00:01.164) 0:00:01.195 ********** 2026-05-21 04:28:10.374627 | ubuntu-focal | changed: [ubuntu-focal] 2026-05-21 04:28:10.374774 | ubuntu-focal | 2026-05-21 04:28:10.374968 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-05-21 04:28:10.375156 | ubuntu-focal | Thursday 21 May 2026 04:28:10 +0000 (0:00:14.227) 0:00:15.422 ********** 2026-05-21 04:28:11.037948 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:11.038080 | ubuntu-focal | 2026-05-21 04:28:11.038264 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:28:11.038463 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:28:11.038621 | ubuntu-focal | 2026-05-21 04:28:11.038772 | ubuntu-focal | 2026-05-21 04:28:11.038935 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:28:11.039109 | ubuntu-focal | Thursday 21 May 2026 04:28:11 +0000 (0:00:00.663) 0:00:16.086 ********** 2026-05-21 04:28:11.039269 | ubuntu-focal | =============================================================================== 2026-05-21 04:28:11.039436 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 14.23s 2026-05-21 04:28:11.039607 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.16s 2026-05-21 04:28:11.039773 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.66s 2026-05-21 04:28:11.147743 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-05-21 04:28:11.156850 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-05-21 04:28:11.644251 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:28:11.644332 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-05-21 04:28:11.644572 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-05-21 04:28:11.644681 | ubuntu-focal | 2026-05-21 04:28:11.931163 | ubuntu-focal | 2026-05-21 04:28:11.931339 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-05-21 04:28:11.931497 | ubuntu-focal | 2026-05-21 04:28:11.931672 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:28:11.931837 | ubuntu-focal | Thursday 21 May 2026 04:28:11 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-05-21 04:28:12.942862 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-05-21 04:28:12.944496 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:12.944654 | ubuntu-focal | 2026-05-21 04:28:12.944835 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 04:28:12.945040 | ubuntu-focal | Thursday 21 May 2026 04:28:12 +0000 (0:00:01.013) 0:00:01.021 ********** 2026-05-21 04:28:13.303470 | ubuntu-focal | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-05-21 04:28:13.307573 | ubuntu-focal | changed: [ubuntu-focal] 2026-05-21 04:28:13.307698 | ubuntu-focal | 2026-05-21 04:28:13.307868 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:28:13.308076 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:28:13.308280 | ubuntu-focal | 2026-05-21 04:28:13.308373 | ubuntu-focal | 2026-05-21 04:28:13.308596 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:28:13.308711 | ubuntu-focal | Thursday 21 May 2026 04:28:13 +0000 (0:00:00.363) 0:00:01.384 ********** 2026-05-21 04:28:13.308863 | ubuntu-focal | =============================================================================== 2026-05-21 04:28:13.309028 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.01s 2026-05-21 04:28:13.309196 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.36s 2026-05-21 04:28:13.397930 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-05-21 04:28:13.405521 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-05-21 04:28:13.864319 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:28:13.864396 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-05-21 04:28:13.864608 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-05-21 04:28:13.864759 | ubuntu-focal | 2026-05-21 04:28:14.181939 | ubuntu-focal | 2026-05-21 04:28:14.182120 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-05-21 04:28:14.182277 | ubuntu-focal | 2026-05-21 04:28:14.182457 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:28:14.182638 | ubuntu-focal | Thursday 21 May 2026 04:28:14 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-05-21 04:28:15.188708 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-05-21 04:28:15.190987 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:15.191154 | ubuntu-focal | 2026-05-21 04:28:15.191334 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 04:28:15.191511 | ubuntu-focal | Thursday 21 May 2026 04:28:15 +0000 (0:00:01.009) 0:00:01.018 ********** 2026-05-21 04:28:15.531187 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:15.531256 | ubuntu-focal | 2026-05-21 04:28:15.531398 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:28:15.531536 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:28:15.531705 | ubuntu-focal | 2026-05-21 04:28:15.531865 | ubuntu-focal | 2026-05-21 04:28:15.532076 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:28:15.532304 | ubuntu-focal | Thursday 21 May 2026 04:28:15 +0000 (0:00:00.340) 0:00:01.358 ********** 2026-05-21 04:28:15.532469 | ubuntu-focal | =============================================================================== 2026-05-21 04:28:15.532652 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.01s 2026-05-21 04:28:15.532858 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.34s 2026-05-21 04:28:15.642184 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-05-21 04:28:15.781541 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-05-21 04:28:15.782228 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:28:15.971892 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-05-21 04:28:16.497729 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-05-21 04:28:16.497914 | ubuntu-focal | [DEPRECATION WARNING]: DEFAULT_MANAGED_STR option. Reason: The `ansible_managed` variable can be set just like any other variable, or a different variable can be used. 2026-05-21 04:28:16.498150 | ubuntu-focal | Alternatives: Set the `ansible_managed` variable, or use any custom variable in templates. This feature will be removed from ansible-core version 2.23. 2026-05-21 04:28:16.498304 | ubuntu-focal | 2026-05-21 04:28:16.806325 | ubuntu-focal | 2026-05-21 04:28:16.806411 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-05-21 04:28:16.806628 | ubuntu-focal | 2026-05-21 04:28:16.806755 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-05-21 04:28:16.806977 | ubuntu-focal | Thursday 21 May 2026 04:28:16 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-05-21 04:28:17.855936 | ubuntu-focal | [WARNING]: Host 'ubuntu-focal' is using the discovered Python interpreter at '/usr/bin/python3.8', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.19/reference_appendices/interpreter_discovery.html for more information. 2026-05-21 04:28:17.858934 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:17.859082 | ubuntu-focal | 2026-05-21 04:28:17.859314 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-05-21 04:28:17.859456 | ubuntu-focal | Thursday 21 May 2026 04:28:17 +0000 (0:00:01.052) 0:00:01.060 ********** 2026-05-21 04:28:19.707162 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:19.707344 | ubuntu-focal | 2026-05-21 04:28:19.707568 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-05-21 04:28:19.707785 | ubuntu-focal | Thursday 21 May 2026 04:28:19 +0000 (0:00:01.848) 0:00:02.908 ********** 2026-05-21 04:28:21.569345 | ubuntu-focal | ok: [ubuntu-focal] 2026-05-21 04:28:21.569451 | ubuntu-focal | 2026-05-21 04:28:21.569702 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-05-21 04:28:21.569888 | ubuntu-focal | Thursday 21 May 2026 04:28:21 +0000 (0:00:01.862) 0:00:04.770 ********** 2026-05-21 04:28:21.597961 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-05-21 04:28:21.598076 | ubuntu-focal | "changed": false, 2026-05-21 04:28:21.598302 | ubuntu-focal | "msg": "All assertions passed" 2026-05-21 04:28:21.598420 | ubuntu-focal | } 2026-05-21 04:28:21.598627 | ubuntu-focal | 2026-05-21 04:28:21.598742 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-05-21 04:28:21.598961 | ubuntu-focal | Thursday 21 May 2026 04:28:21 +0000 (0:00:00.029) 0:00:04.799 ********** 2026-05-21 04:28:21.624618 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-05-21 04:28:21.624729 | ubuntu-focal | "changed": false, 2026-05-21 04:28:21.624954 | ubuntu-focal | "msg": "All assertions passed" 2026-05-21 04:28:21.625067 | ubuntu-focal | } 2026-05-21 04:28:21.625222 | ubuntu-focal | 2026-05-21 04:28:21.625402 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-05-21 04:28:21.625576 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 04:28:21.625731 | ubuntu-focal | 2026-05-21 04:28:21.625881 | ubuntu-focal | 2026-05-21 04:28:21.626046 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-05-21 04:28:21.626216 | ubuntu-focal | Thursday 21 May 2026 04:28:21 +0000 (0:00:00.026) 0:00:04.826 ********** 2026-05-21 04:28:21.626372 | ubuntu-focal | =============================================================================== 2026-05-21 04:28:21.626539 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.86s 2026-05-21 04:28:21.626710 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.85s 2026-05-21 04:28:21.626933 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.05s 2026-05-21 04:28:21.627086 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-05-21 04:28:21.627252 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-05-21 04:28:21.741166 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-05-21 04:28:21.751177 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-05-21 04:28:21.751553 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 04:28:21.758459 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-05-21 04:28:21.758557 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-05-21 04:28:21.758677 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-05-21 04:28:21.759249 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-21 04:28:22.116862 | ubuntu-focal | ok: Runtime: 0:00:41.722094 2026-05-21 04:28:22.121172 | 2026-05-21 04:28:22.121240 | PLAY RECAP 2026-05-21 04:28:22.121300 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 04:28:22.121335 | 2026-05-21 04:28:22.270314 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 04:28:22.276667 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 04:28:22.989484 | 2026-05-21 04:28:24.654745 | PLAY [all] 2026-05-21 04:28:24.681701 | 2026-05-21 04:28:24.681904 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-21 04:28:24.733799 | ubuntu-focal | skipping: Conditional result was False 2026-05-21 04:28:24.745892 | 2026-05-21 04:28:24.746045 | TASK [fetch-output : Set log path for single node] 2026-05-21 04:28:24.781219 | ubuntu-focal | ok 2026-05-21 04:28:24.790841 | 2026-05-21 04:28:24.790963 | LOOP [fetch-output : Ensure local output dirs] 2026-05-21 04:28:25.215741 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/logs" 2026-05-21 04:28:25.439934 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/artifacts" 2026-05-21 04:28:25.690409 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/8785cde4ec2f4aea88a670077c2edc69/work/docs" 2026-05-21 04:28:25.707141 | 2026-05-21 04:28:25.707305 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 04:28:26.398778 | ubuntu-focal | ok 2026-05-21 04:28:26.399008 | ubuntu-focal | changed: All items complete 2026-05-21 04:28:26.399047 | 2026-05-21 04:28:26.849659 | ubuntu-focal | changed: .d..t...... ./ 2026-05-21 04:28:27.277457 | ubuntu-focal | changed: .d..t...... ./ 2026-05-21 04:28:27.295966 | 2026-05-21 04:28:27.296077 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 04:28:27.776404 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.007628 2026-05-21 04:28:28.029354 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.008879 2026-05-21 04:28:28.046039 | 2026-05-21 04:28:28.046166 | PLAY [all] 2026-05-21 04:28:30.262807 | 2026-05-21 04:28:30.263049 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 04:28:30.986288 | ubuntu-focal | changed 2026-05-21 04:28:30.994986 | 2026-05-21 04:28:30.995137 | PLAY RECAP 2026-05-21 04:28:30.995217 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-21 04:28:30.995250 | 2026-05-21 04:28:31.172289 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 04:28:31.178915 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 04:28:31.791954 | 2026-05-21 04:28:33.167323 | PLAY [localhost] 2026-05-21 04:28:33.187262 | 2026-05-21 04:28:33.187527 | TASK [Generate Zuul manifest] 2026-05-21 04:28:33.209700 | localhost | ok 2026-05-21 04:28:33.236607 | 2026-05-21 04:28:33.236837 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 04:28:36.036292 | localhost | changed 2026-05-21 04:28:36.050598 | 2026-05-21 04:28:36.050781 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 04:28:36.164316 | localhost | ok 2026-05-21 04:28:36.170951 | 2026-05-21 04:28:36.171021 | TASK [Upload logs] 2026-05-21 04:28:36.212056 | localhost | ok 2026-05-21 04:28:36.270501 | 2026-05-21 04:28:36.270654 | TASK [Set zuul-log-path fact] 2026-05-21 04:28:36.293101 | localhost | ok 2026-05-21 04:28:36.304738 | 2026-05-21 04:28:36.304813 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 04:28:36.337062 | localhost | ok 2026-05-21 04:28:36.347389 | 2026-05-21 04:28:36.347538 | TASK [upload-logs : Create log directories] 2026-05-21 04:28:36.784243 | localhost | changed 2026-05-21 04:28:36.793781 | 2026-05-21 04:28:36.793881 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 04:28:37.239670 | localhost -> localhost | ok: Runtime: 0:00:00.005450 2026-05-21 04:28:37.247694 | 2026-05-21 04:28:37.247857 | TASK [upload-logs : Upload logs to log server] 2026-05-21 04:28:37.789997 | localhost | Output suppressed because no_log was given 2026-05-21 04:28:37.794727 | 2026-05-21 04:28:37.794805 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 04:28:37.843779 | localhost | skipping: Conditional result was False 2026-05-21 04:28:37.852260 | localhost | skipping: Conditional result was False 2026-05-21 04:28:37.873498 | 2026-05-21 04:28:37.873797 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 04:28:37.914640 | localhost | skipping: Conditional result was False 2026-05-21 04:28:37.915006 | 2026-05-21 04:28:37.918806 | localhost | skipping: Conditional result was False 2026-05-21 04:28:37.925581 | 2026-05-21 04:28:37.925777 | LOOP [upload-logs : Upload console log and json output]