2026-06-16 01:26:33.319086 | Job console starting 2026-06-16 01:26:33.355096 | Updating git repos 2026-06-16 01:26:33.415009 | Cloning repos into workspace 2026-06-16 01:26:33.503269 | Restoring repo states 2026-06-16 01:26:33.512635 | Merging changes 2026-06-16 01:26:33.925274 | Checking out repos 2026-06-16 01:26:33.963902 | Preparing playbooks 2026-06-16 01:26:35.027009 | Running Ansible setup 2026-06-16 01:26:40.717670 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-16 01:26:41.424678 | 2026-06-16 01:26:41.424821 | PLAY [localhost] 2026-06-16 01:26:41.432806 | 2026-06-16 01:26:41.432910 | TASK [Gathering Facts] 2026-06-16 01:26:42.405668 | localhost | ok 2026-06-16 01:26:42.415228 | 2026-06-16 01:26:42.415427 | TASK [Setup log path fact] 2026-06-16 01:26:42.436755 | localhost | ok 2026-06-16 01:26:42.451240 | 2026-06-16 01:26:42.451386 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 01:26:42.497623 | localhost | ok 2026-06-16 01:26:42.513456 | 2026-06-16 01:26:42.513648 | TASK [emit-job-header : Print job information] 2026-06-16 01:26:42.571802 | # Job Information 2026-06-16 01:26:42.572013 | Ansible Version: 2.16.18 2026-06-16 01:26:42.572063 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-06-16 01:26:42.572098 | Pipeline: check 2026-06-16 01:26:42.572129 | Executor: 2d72f0692154 2026-06-16 01:26:42.572158 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/128 2026-06-16 01:26:42.572194 | Event ID: 47734fe0-6922-11f1-98d4-030505987156 2026-06-16 01:26:42.575867 | 2026-06-16 01:26:42.575938 | LOOP [emit-job-header : Print node information] 2026-06-16 01:26:42.686348 | localhost | ok: 2026-06-16 01:26:42.686536 | localhost | # Node Information 2026-06-16 01:26:42.686571 | localhost | Inventory Hostname: ubuntu-focal 2026-06-16 01:26:42.686594 | localhost | Hostname: np0000180655 2026-06-16 01:26:42.686614 | localhost | Username: zuul 2026-06-16 01:26:42.686654 | localhost | Distro: Ubuntu 20.04 2026-06-16 01:26:42.686693 | localhost | Provider: yul1 2026-06-16 01:26:42.686720 | localhost | Region: ca-ymq-1 2026-06-16 01:26:42.686749 | localhost | Label: ubuntu-focal 2026-06-16 01:26:42.686776 | localhost | Product Name: OpenStack Nova 2026-06-16 01:26:42.686796 | localhost | Interface IP: 199.204.45.223 2026-06-16 01:26:42.701804 | 2026-06-16 01:26:42.701981 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-16 01:26:43.274148 | localhost -> localhost | changed 2026-06-16 01:26:43.280283 | 2026-06-16 01:26:43.280366 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-16 01:26:44.242319 | localhost -> localhost | changed 2026-06-16 01:26:44.259685 | 2026-06-16 01:26:44.259850 | PLAY [all] 2026-06-16 01:26:44.268947 | 2026-06-16 01:26:44.269110 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-16 01:26:44.526538 | ubuntu-focal -> localhost | ok 2026-06-16 01:26:44.532859 | 2026-06-16 01:26:44.532975 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-16 01:26:44.565587 | ubuntu-focal | ok 2026-06-16 01:26:44.581561 | ubuntu-focal | included: /var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-16 01:26:44.587118 | 2026-06-16 01:26:44.587182 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-16 01:26:45.707227 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-06-16 01:26:45.707458 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/20873b5754b9426c82a31437f4f2b3b9_id_rsa 2026-06-16 01:26:45.707504 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/20873b5754b9426c82a31437f4f2b3b9_id_rsa.pub 2026-06-16 01:26:45.707538 | ubuntu-focal -> localhost | The key fingerprint is: 2026-06-16 01:26:45.707571 | ubuntu-focal -> localhost | SHA256:StpCW2UR498KoEZqm/SRNgI+gCeNrnBSmKXNk7qP9PU zuul-build-sshkey 2026-06-16 01:26:45.707625 | ubuntu-focal -> localhost | The key's randomart image is: 2026-06-16 01:26:45.707658 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-06-16 01:26:45.707693 | ubuntu-focal -> localhost | | . +. | 2026-06-16 01:26:45.707725 | ubuntu-focal -> localhost | |.X . . o | 2026-06-16 01:26:45.707756 | ubuntu-focal -> localhost | |X O . . + | 2026-06-16 01:26:45.707786 | ubuntu-focal -> localhost | |+* + o + . . | 2026-06-16 01:26:45.707816 | ubuntu-focal -> localhost | |++* O o S . . | 2026-06-16 01:26:45.707845 | ubuntu-focal -> localhost | |o*.O O . . . | 2026-06-16 01:26:45.707875 | ubuntu-focal -> localhost | |o.o =.o . | 2026-06-16 01:26:45.707904 | ubuntu-focal -> localhost | |.o. ... | 2026-06-16 01:26:45.707938 | ubuntu-focal -> localhost | |. .. E | 2026-06-16 01:26:45.707968 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-06-16 01:26:45.708044 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.624488 2026-06-16 01:26:45.715791 | 2026-06-16 01:26:45.715910 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-16 01:26:45.748039 | ubuntu-focal | ok 2026-06-16 01:26:45.759197 | ubuntu-focal | included: /var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-16 01:26:45.767838 | 2026-06-16 01:26:45.767931 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-16 01:26:45.793200 | ubuntu-focal | skipping: Conditional result was False 2026-06-16 01:26:45.805824 | 2026-06-16 01:26:45.805921 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-16 01:26:46.282647 | ubuntu-focal | changed 2026-06-16 01:26:46.290796 | 2026-06-16 01:26:46.290882 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-16 01:26:46.468701 | ubuntu-focal | ok 2026-06-16 01:26:46.477966 | 2026-06-16 01:26:46.478044 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-16 01:26:46.963121 | ubuntu-focal | changed 2026-06-16 01:26:47.127532 | 2026-06-16 01:26:47.127635 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-16 01:26:47.572283 | ubuntu-focal | changed 2026-06-16 01:26:47.581230 | 2026-06-16 01:26:47.581375 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-16 01:26:47.598826 | ubuntu-focal | skipping: Conditional result was False 2026-06-16 01:26:47.606693 | 2026-06-16 01:26:47.606789 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-16 01:26:48.054168 | ubuntu-focal -> localhost | changed 2026-06-16 01:26:48.067285 | 2026-06-16 01:26:48.067397 | TASK [add-build-sshkey : Add back temp key] 2026-06-16 01:26:48.397338 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/20873b5754b9426c82a31437f4f2b3b9_id_rsa (zuul-build-sshkey) 2026-06-16 01:26:48.397543 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.011602 2026-06-16 01:26:48.402454 | 2026-06-16 01:26:48.402524 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-16 01:26:48.744299 | ubuntu-focal | ok 2026-06-16 01:26:48.750134 | 2026-06-16 01:26:48.750220 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-16 01:26:48.776652 | ubuntu-focal | skipping: Conditional result was False 2026-06-16 01:26:48.798652 | 2026-06-16 01:26:48.798910 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-16 01:26:49.136568 | ubuntu-focal | ok 2026-06-16 01:26:49.145888 | 2026-06-16 01:26:49.145980 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-16 01:26:50.025325 | ubuntu-focal | Output suppressed because no_log was given 2026-06-16 01:26:50.035406 | 2026-06-16 01:26:50.035514 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-16 01:26:50.284865 | ubuntu-focal | ok: "logs" 2026-06-16 01:26:50.285132 | ubuntu-focal | ok: All items complete 2026-06-16 01:26:50.285173 | 2026-06-16 01:26:50.371705 | ubuntu-focal | ok: "artifacts" 2026-06-16 01:26:50.542648 | ubuntu-focal | ok: "docs" 2026-06-16 01:26:50.551056 | 2026-06-16 01:26:50.551207 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-16 01:26:50.722787 | ubuntu-focal | changed: "logs" 2026-06-16 01:26:50.869403 | ubuntu-focal | changed: "artifacts" 2026-06-16 01:26:51.018836 | ubuntu-focal | changed: "docs" 2026-06-16 01:26:51.037006 | 2026-06-16 01:26:51.037154 | PLAY RECAP 2026-06-16 01:26:51.037217 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 01:26:51.037258 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-16 01:26:51.037289 | 2026-06-16 01:26:51.208466 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-16 01:26:51.257589 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-16 01:26:51.923799 | 2026-06-16 01:26:51.923997 | PLAY [all] 2026-06-16 01:26:51.937117 | 2026-06-16 01:26:52.065632 | TASK [setup-uv : Extract archive] 2026-06-16 01:26:54.232762 | ubuntu-focal | changed 2026-06-16 01:26:54.238717 | 2026-06-16 01:26:54.238823 | TASK [setup-uv : Print version] 2026-06-16 01:26:54.613312 | ubuntu-focal | uv 0.8.13 2026-06-16 01:26:54.780314 | ubuntu-focal | ok: Runtime: 0:00:00.009469 2026-06-16 01:26:54.791307 | 2026-06-16 01:26:54.791392 | TASK [Install Ansible collection siblings] 2026-06-16 01:26:55.179077 | ubuntu-focal | ok: 2026-06-16 01:26:55.179333 | ubuntu-focal | Skipping ansible.posix: no checked-out sibling 2026-06-16 01:26:55.179377 | ubuntu-focal | Skipping community.general: no checked-out sibling 2026-06-16 01:26:55.181574 | 2026-06-16 01:26:55.181637 | PLAY RECAP 2026-06-16 01:26:55.181698 | ubuntu-focal | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 01:26:55.181727 | 2026-06-16 01:26:55.373024 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-16 01:26:55.374210 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-16 01:26:56.069342 | 2026-06-16 01:26:56.101845 | PLAY [all] 2026-06-16 01:26:56.120839 | 2026-06-16 01:26:56.121052 | TASK [Copy inventory file for Zuul] 2026-06-16 01:26:56.973697 | ubuntu-focal | changed 2026-06-16 01:26:56.979702 | 2026-06-16 01:26:56.979788 | TASK [Switch "ansible_host" to private IP] 2026-06-16 01:26:57.332408 | ubuntu-focal | changed: 1 replacements made 2026-06-16 01:26:57.403616 | 2026-06-16 01:26:57.403907 | TASK [Run Molecule scenario] 2026-06-16 01:26:58.009733 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-06-16 01:26:58.888925 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-06-16 01:26:59.064365 | ubuntu-focal | Using CPython 3.13.7 2026-06-16 01:26:59.064431 | ubuntu-focal | Creating virtual environment at: .venv 2026-06-16 01:26:59.308170 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-06-16 01:26:59.308552 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-06-16 01:26:59.310077 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-06-16 01:26:59.467934 | ubuntu-focal | Downloading cryptography 2026-06-16 01:26:59.519821 | ubuntu-focal | Downloading pygments 2026-06-16 01:26:59.673064 | ubuntu-focal | Downloading ansible-core 2026-06-16 01:26:59.698299 | ubuntu-focal | Installed 36 packages in 24ms 2026-06-16 01:27:00.781695 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-06-16 01:27:00.781790 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-06-16 01:27:01.594626 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-06-16 01:27:01.594726 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-06-16 01:27:01.594750 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-06-16 01:27:01.594765 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-06-16 01:27:10.103812 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-06-16 01:27:10.104027 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-06-16 01:27:10.104271 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-06-16 01:27:10.104415 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-06-16 01:27:10.110481 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-06-16 01:27:10.110778 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-16 01:27:10.115704 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-06-16 01:27:10.115739 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-06-16 01:27:10.115811 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-06-16 01:27:10.120704 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-06-16 01:27:10.643366 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-06-16 01:27:10.643489 | 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-06-16 01:27:10.643547 | 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-06-16 01:27:10.643657 | ubuntu-focal | 2026-06-16 01:27:11.046861 | ubuntu-focal | 2026-06-16 01:27:11.047027 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-06-16 01:27:11.164866 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-06-16 01:27:11.174569 | ubuntu-focal | INFO [forget-package > create] Executing 2026-06-16 01:27:11.177096 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-16 01:27:11.182203 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-06-16 01:27:11.735608 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-06-16 01:27:11.735737 | 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-06-16 01:27:11.735893 | 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-06-16 01:27:11.736058 | ubuntu-focal | 2026-06-16 01:27:12.118952 | ubuntu-focal | 2026-06-16 01:27:12.119133 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-06-16 01:27:12.119312 | ubuntu-focal | 2026-06-16 01:27:12.119507 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-06-16 01:27:12.119725 | ubuntu-focal | Tuesday 16 June 2026 01:27:12 +0000 (0:00:00.031) 0:00:00.031 ********** 2026-06-16 01:27:13.322654 | 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-06-16 01:27:13.324330 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:13.324646 | ubuntu-focal | 2026-06-16 01:27:13.324867 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-06-16 01:27:13.325127 | ubuntu-focal | Tuesday 16 June 2026 01:27:13 +0000 (0:00:01.206) 0:00:01.237 ********** 2026-06-16 01:27:30.017087 | ubuntu-focal | changed: [ubuntu-focal] 2026-06-16 01:27:30.017250 | ubuntu-focal | 2026-06-16 01:27:30.017456 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-06-16 01:27:30.017705 | ubuntu-focal | Tuesday 16 June 2026 01:27:30 +0000 (0:00:16.691) 0:00:17.929 ********** 2026-06-16 01:27:30.661387 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:30.661533 | ubuntu-focal | 2026-06-16 01:27:30.661741 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-06-16 01:27:30.661956 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-16 01:27:30.662121 | ubuntu-focal | 2026-06-16 01:27:30.662277 | ubuntu-focal | 2026-06-16 01:27:30.662479 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-06-16 01:27:30.662652 | ubuntu-focal | Tuesday 16 June 2026 01:27:30 +0000 (0:00:00.645) 0:00:18.574 ********** 2026-06-16 01:27:30.662812 | ubuntu-focal | =============================================================================== 2026-06-16 01:27:30.662981 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 16.69s 2026-06-16 01:27:30.663192 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.21s 2026-06-16 01:27:30.663365 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.64s 2026-06-16 01:27:30.785994 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-06-16 01:27:30.797588 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-06-16 01:27:31.251181 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-06-16 01:27:31.251471 | 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-06-16 01:27:31.251724 | 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-06-16 01:27:31.251930 | ubuntu-focal | 2026-06-16 01:27:31.548947 | ubuntu-focal | 2026-06-16 01:27:31.549112 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-06-16 01:27:31.549283 | ubuntu-focal | 2026-06-16 01:27:31.549489 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-06-16 01:27:31.549693 | ubuntu-focal | Tuesday 16 June 2026 01:27:31 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-06-16 01:27:32.549878 | 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-06-16 01:27:32.552917 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:32.553101 | ubuntu-focal | 2026-06-16 01:27:32.553295 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-06-16 01:27:32.553477 | ubuntu-focal | Tuesday 16 June 2026 01:27:32 +0000 (0:00:01.003) 0:00:01.011 ********** 2026-06-16 01:27:32.897552 | 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-06-16 01:27:32.901176 | ubuntu-focal | changed: [ubuntu-focal] 2026-06-16 01:27:32.901243 | ubuntu-focal | 2026-06-16 01:27:32.901330 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-06-16 01:27:32.901424 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-16 01:27:32.901505 | ubuntu-focal | 2026-06-16 01:27:32.901576 | ubuntu-focal | 2026-06-16 01:27:32.901662 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-06-16 01:27:32.901744 | ubuntu-focal | Tuesday 16 June 2026 01:27:32 +0000 (0:00:00.348) 0:00:01.360 ********** 2026-06-16 01:27:32.901819 | ubuntu-focal | =============================================================================== 2026-06-16 01:27:32.901897 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.00s 2026-06-16 01:27:32.901976 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.35s 2026-06-16 01:27:33.015649 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-06-16 01:27:33.042045 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-06-16 01:27:33.517630 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-06-16 01:27:33.517750 | 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-06-16 01:27:33.517971 | 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-06-16 01:27:33.518137 | ubuntu-focal | 2026-06-16 01:27:33.823605 | ubuntu-focal | 2026-06-16 01:27:33.823776 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-06-16 01:27:33.823918 | ubuntu-focal | 2026-06-16 01:27:33.824118 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-06-16 01:27:33.824280 | ubuntu-focal | Tuesday 16 June 2026 01:27:33 +0000 (0:00:00.007) 0:00:00.007 ********** 2026-06-16 01:27:34.870349 | 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-06-16 01:27:34.872896 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:34.873078 | ubuntu-focal | 2026-06-16 01:27:34.873383 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-06-16 01:27:34.873590 | ubuntu-focal | Tuesday 16 June 2026 01:27:34 +0000 (0:00:01.049) 0:00:01.057 ********** 2026-06-16 01:27:35.208537 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:35.208737 | ubuntu-focal | 2026-06-16 01:27:35.209047 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-06-16 01:27:35.209265 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-16 01:27:35.209428 | ubuntu-focal | 2026-06-16 01:27:35.209580 | ubuntu-focal | 2026-06-16 01:27:35.209751 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-06-16 01:27:35.209859 | ubuntu-focal | Tuesday 16 June 2026 01:27:35 +0000 (0:00:00.335) 0:00:01.392 ********** 2026-06-16 01:27:35.209959 | ubuntu-focal | =============================================================================== 2026-06-16 01:27:35.210061 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.05s 2026-06-16 01:27:35.210194 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.34s 2026-06-16 01:27:35.321943 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-06-16 01:27:35.332739 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-06-16 01:27:35.333018 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-16 01:27:35.338061 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-06-16 01:27:35.823691 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-06-16 01:27:35.823803 | 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-06-16 01:27:35.824001 | 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-06-16 01:27:35.824153 | ubuntu-focal | 2026-06-16 01:27:36.130816 | ubuntu-focal | 2026-06-16 01:27:36.131028 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-06-16 01:27:36.131211 | ubuntu-focal | 2026-06-16 01:27:36.131395 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-06-16 01:27:36.131578 | ubuntu-focal | Tuesday 16 June 2026 01:27:36 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-06-16 01:27:37.153607 | 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-06-16 01:27:37.155659 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:37.155818 | ubuntu-focal | 2026-06-16 01:27:37.155999 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-06-16 01:27:37.156171 | ubuntu-focal | Tuesday 16 June 2026 01:27:37 +0000 (0:00:01.025) 0:00:01.035 ********** 2026-06-16 01:27:39.089839 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:39.090188 | ubuntu-focal | 2026-06-16 01:27:39.090518 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-06-16 01:27:39.090828 | ubuntu-focal | Tuesday 16 June 2026 01:27:39 +0000 (0:00:01.933) 0:00:02.969 ********** 2026-06-16 01:27:40.863704 | ubuntu-focal | ok: [ubuntu-focal] 2026-06-16 01:27:40.864001 | ubuntu-focal | 2026-06-16 01:27:40.864265 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-06-16 01:27:40.864503 | ubuntu-focal | Tuesday 16 June 2026 01:27:40 +0000 (0:00:01.772) 0:00:04.741 ********** 2026-06-16 01:27:40.890602 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-06-16 01:27:40.890772 | ubuntu-focal | "changed": false, 2026-06-16 01:27:40.890887 | ubuntu-focal | "msg": "All assertions passed" 2026-06-16 01:27:40.891005 | ubuntu-focal | } 2026-06-16 01:27:40.891131 | ubuntu-focal | 2026-06-16 01:27:40.891254 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-06-16 01:27:40.891365 | ubuntu-focal | Tuesday 16 June 2026 01:27:40 +0000 (0:00:00.025) 0:00:04.767 ********** 2026-06-16 01:27:40.912099 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-06-16 01:27:40.912377 | ubuntu-focal | "changed": false, 2026-06-16 01:27:40.912629 | ubuntu-focal | "msg": "All assertions passed" 2026-06-16 01:27:40.912870 | ubuntu-focal | } 2026-06-16 01:27:40.913112 | ubuntu-focal | 2026-06-16 01:27:40.913359 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-06-16 01:27:40.913624 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-06-16 01:27:40.913852 | ubuntu-focal | 2026-06-16 01:27:40.914120 | ubuntu-focal | 2026-06-16 01:27:40.914378 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-06-16 01:27:40.914654 | ubuntu-focal | Tuesday 16 June 2026 01:27:40 +0000 (0:00:00.024) 0:00:04.792 ********** 2026-06-16 01:27:40.914891 | ubuntu-focal | =============================================================================== 2026-06-16 01:27:40.915185 | ubuntu-focal | Populate package facts -------------------------------------------------- 1.93s 2026-06-16 01:27:40.915432 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.77s 2026-06-16 01:27:40.915675 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.03s 2026-06-16 01:27:40.916021 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-06-16 01:27:40.916292 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.02s 2026-06-16 01:27:41.015078 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-06-16 01:27:41.015313 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-06-16 01:27:41.015319 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-06-16 01:27:41.019894 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-06-16 01:27:41.020001 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-06-16 01:27:41.020085 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-06-16 01:27:41.020439 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-06-16 01:27:41.547340 | ubuntu-focal | ok: Runtime: 0:00:43.287547 2026-06-16 01:27:41.550680 | 2026-06-16 01:27:41.550730 | PLAY RECAP 2026-06-16 01:27:41.550796 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-16 01:27:41.550820 | 2026-06-16 01:27:41.692498 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-16 01:27:41.695277 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 01:27:42.304739 | 2026-06-16 01:27:42.304901 | PLAY [all] 2026-06-16 01:27:42.317139 | 2026-06-16 01:27:42.317250 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-16 01:27:42.363324 | ubuntu-focal | skipping: Conditional result was False 2026-06-16 01:27:42.372849 | 2026-06-16 01:27:42.372945 | TASK [fetch-output : Set log path for single node] 2026-06-16 01:27:42.419381 | ubuntu-focal | ok 2026-06-16 01:27:42.424732 | 2026-06-16 01:27:42.424873 | LOOP [fetch-output : Ensure local output dirs] 2026-06-16 01:27:42.870341 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/logs" 2026-06-16 01:27:43.113396 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/artifacts" 2026-06-16 01:27:43.348843 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/20873b5754b9426c82a31437f4f2b3b9/work/docs" 2026-06-16 01:27:43.368069 | 2026-06-16 01:27:43.368199 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-16 01:27:43.996703 | ubuntu-focal | changed: .d..t...... ./ 2026-06-16 01:27:43.996934 | ubuntu-focal | changed: All items complete 2026-06-16 01:27:43.996995 | 2026-06-16 01:27:44.428776 | ubuntu-focal | changed: .d..t...... ./ 2026-06-16 01:27:44.841367 | ubuntu-focal | changed: .d..t...... ./ 2026-06-16 01:27:44.859152 | 2026-06-16 01:27:44.859315 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-16 01:27:45.269871 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.009125 2026-06-16 01:27:45.523826 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.012822 2026-06-16 01:27:45.544715 | 2026-06-16 01:27:45.544983 | PLAY [all] 2026-06-16 01:27:45.555481 | 2026-06-16 01:27:45.555561 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-16 01:27:46.007506 | ubuntu-focal | changed 2026-06-16 01:27:46.013890 | 2026-06-16 01:27:46.013966 | PLAY RECAP 2026-06-16 01:27:46.014014 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-16 01:27:46.014035 | 2026-06-16 01:27:46.182662 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-16 01:27:46.185404 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-16 01:27:46.792002 | 2026-06-16 01:27:46.792171 | PLAY [localhost] 2026-06-16 01:27:46.803009 | 2026-06-16 01:27:46.803083 | TASK [Generate Zuul manifest] 2026-06-16 01:27:46.824439 | localhost | ok 2026-06-16 01:27:46.839052 | 2026-06-16 01:27:46.839142 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-16 01:27:47.207804 | localhost | changed 2026-06-16 01:27:47.223502 | 2026-06-16 01:27:47.223756 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-16 01:27:47.259352 | localhost | ok 2026-06-16 01:27:47.269548 | 2026-06-16 01:27:47.269828 | TASK [Upload logs] 2026-06-16 01:27:47.289742 | localhost | ok 2026-06-16 01:27:47.379788 | 2026-06-16 01:27:47.380006 | TASK [Set zuul-log-path fact] 2026-06-16 01:27:47.404061 | localhost | ok 2026-06-16 01:27:47.420166 | 2026-06-16 01:27:47.420438 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-16 01:27:47.454778 | localhost | ok 2026-06-16 01:27:47.464065 | 2026-06-16 01:27:47.464133 | TASK [upload-logs : Create log directories] 2026-06-16 01:27:47.873996 | localhost | changed 2026-06-16 01:27:47.883350 | 2026-06-16 01:27:47.883511 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-16 01:27:48.403691 | localhost -> localhost | ok: Runtime: 0:00:00.005500 2026-06-16 01:27:48.409801 | 2026-06-16 01:27:48.409876 | TASK [upload-logs : Upload logs to log server] 2026-06-16 01:27:48.903333 | localhost | Output suppressed because no_log was given 2026-06-16 01:27:48.908870 | 2026-06-16 01:27:48.909017 | LOOP [upload-logs : Compress console log and json output] 2026-06-16 01:27:48.954830 | localhost | skipping: Conditional result was False 2026-06-16 01:27:48.962165 | localhost | skipping: Conditional result was False 2026-06-16 01:27:48.975007 | 2026-06-16 01:27:48.975156 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-16 01:27:49.022688 | localhost | skipping: Conditional result was False 2026-06-16 01:27:49.023133 | 2026-06-16 01:27:49.026754 | localhost | skipping: Conditional result was False 2026-06-16 01:27:49.042564 | 2026-06-16 01:27:49.042683 | LOOP [upload-logs : Upload console log and json output]