2026-04-18 16:35:01.539900 | Job console starting 2026-04-18 16:35:01.551555 | Updating git repos 2026-04-18 16:35:01.586528 | Cloning repos into workspace 2026-04-18 16:35:01.709998 | Restoring repo states 2026-04-18 16:35:01.725539 | Merging changes 2026-04-18 16:35:02.003970 | Checking out repos 2026-04-18 16:35:02.039440 | Preparing playbooks 2026-04-18 16:35:03.193449 | Running Ansible setup 2026-04-18 16:35:06.575352 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:35:07.270275 | 2026-04-18 16:35:07.270457 | PLAY [localhost] 2026-04-18 16:35:07.279087 | 2026-04-18 16:35:07.279173 | TASK [Gathering Facts] 2026-04-18 16:35:08.144373 | localhost | ok 2026-04-18 16:35:08.151894 | 2026-04-18 16:35:08.151972 | TASK [Setup log path fact] 2026-04-18 16:35:08.180751 | localhost | ok 2026-04-18 16:35:08.192649 | 2026-04-18 16:35:08.192719 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:35:08.223707 | localhost | ok 2026-04-18 16:35:08.231476 | 2026-04-18 16:35:08.231542 | TASK [emit-job-header : Print job information] 2026-04-18 16:35:08.290120 | # Job Information 2026-04-18 16:35:08.290273 | Ansible Version: 2.16.16 2026-04-18 16:35:08.290305 | Job: ansible-collection-containers-molecule-forget-package-ubuntu-focal 2026-04-18 16:35:08.290328 | Pipeline: check 2026-04-18 16:35:08.290349 | Executor: 0a8996d2b663 2026-04-18 16:35:08.290368 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/108 2026-04-18 16:35:08.290390 | Event ID: 36cd11a0-3b44-11f1-896b-295e87a423e5 2026-04-18 16:35:08.293202 | 2026-04-18 16:35:08.293269 | LOOP [emit-job-header : Print node information] 2026-04-18 16:35:08.390291 | localhost | ok: 2026-04-18 16:35:08.390478 | localhost | # Node Information 2026-04-18 16:35:08.390506 | localhost | Inventory Hostname: ubuntu-focal 2026-04-18 16:35:08.390531 | localhost | Hostname: np0000167379 2026-04-18 16:35:08.390551 | localhost | Username: zuul 2026-04-18 16:35:08.390574 | localhost | Distro: Ubuntu 20.04 2026-04-18 16:35:08.390594 | localhost | Provider: yul1 2026-04-18 16:35:08.390613 | localhost | Region: ca-ymq-1 2026-04-18 16:35:08.390683 | localhost | Label: ubuntu-focal 2026-04-18 16:35:08.390702 | localhost | Product Name: OpenStack Nova 2026-04-18 16:35:08.390721 | localhost | Interface IP: 199.19.213.152 2026-04-18 16:35:08.402507 | 2026-04-18 16:35:08.402692 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 16:35:08.776538 | localhost -> localhost | changed 2026-04-18 16:35:08.781319 | 2026-04-18 16:35:08.781393 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 16:35:09.686958 | localhost -> localhost | changed 2026-04-18 16:35:09.693364 | 2026-04-18 16:35:09.693466 | PLAY [all] 2026-04-18 16:35:09.701343 | 2026-04-18 16:35:09.701416 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 16:35:10.008483 | ubuntu-focal -> localhost | ok 2026-04-18 16:35:10.014269 | 2026-04-18 16:35:10.014336 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 16:35:10.046586 | ubuntu-focal | ok 2026-04-18 16:35:10.071953 | ubuntu-focal | included: /var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 16:35:10.077550 | 2026-04-18 16:35:10.077614 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 16:35:11.146598 | ubuntu-focal -> localhost | Generating public/private rsa key pair. 2026-04-18 16:35:11.146909 | ubuntu-focal -> localhost | Your identification has been saved in /var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/6afd4346dd474260959eb74c7dcc602a_id_rsa 2026-04-18 16:35:11.146993 | ubuntu-focal -> localhost | Your public key has been saved in /var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/6afd4346dd474260959eb74c7dcc602a_id_rsa.pub 2026-04-18 16:35:11.147047 | ubuntu-focal -> localhost | The key fingerprint is: 2026-04-18 16:35:11.147105 | ubuntu-focal -> localhost | SHA256:dgXii/U5COi8liT136CqDfyPuQguB+p+TZz8lEXWNkM zuul-build-sshkey 2026-04-18 16:35:11.147189 | ubuntu-focal -> localhost | The key's randomart image is: 2026-04-18 16:35:11.147245 | ubuntu-focal -> localhost | +---[RSA 3072]----+ 2026-04-18 16:35:11.147305 | ubuntu-focal -> localhost | | . +E | 2026-04-18 16:35:11.147353 | ubuntu-focal -> localhost | | . . + * | 2026-04-18 16:35:11.147407 | ubuntu-focal -> localhost | | o . = . + | 2026-04-18 16:35:11.147470 | ubuntu-focal -> localhost | | + . + = o | 2026-04-18 16:35:11.147521 | ubuntu-focal -> localhost | | . * + S = | 2026-04-18 16:35:11.147566 | ubuntu-focal -> localhost | |.. o B * + . | 2026-04-18 16:35:11.147609 | ubuntu-focal -> localhost | |o.o * + . . | 2026-04-18 16:35:11.147653 | ubuntu-focal -> localhost | |+..B = . | 2026-04-18 16:35:11.147704 | ubuntu-focal -> localhost | |+=+.Bo. | 2026-04-18 16:35:11.147757 | ubuntu-focal -> localhost | +----[SHA256]-----+ 2026-04-18 16:35:11.147873 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.652377 2026-04-18 16:35:11.158347 | 2026-04-18 16:35:11.158425 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 16:35:11.193464 | ubuntu-focal | ok 2026-04-18 16:35:11.206486 | ubuntu-focal | included: /var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 16:35:11.215053 | 2026-04-18 16:35:11.215161 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 16:35:11.240790 | ubuntu-focal | skipping: Conditional result was False 2026-04-18 16:35:11.249293 | 2026-04-18 16:35:11.249416 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 16:35:11.773899 | ubuntu-focal | changed 2026-04-18 16:35:11.780367 | 2026-04-18 16:35:11.780487 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 16:35:11.964277 | ubuntu-focal | ok 2026-04-18 16:35:11.970254 | 2026-04-18 16:35:11.970332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 16:35:12.512619 | ubuntu-focal | changed 2026-04-18 16:35:12.518215 | 2026-04-18 16:35:12.518293 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 16:35:12.946507 | ubuntu-focal | changed 2026-04-18 16:35:12.951939 | 2026-04-18 16:35:12.952045 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 16:35:12.976175 | ubuntu-focal | skipping: Conditional result was False 2026-04-18 16:35:12.985350 | 2026-04-18 16:35:12.985507 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 16:35:13.519647 | ubuntu-focal -> localhost | changed 2026-04-18 16:35:13.535007 | 2026-04-18 16:35:13.544418 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 16:35:13.869183 | ubuntu-focal -> localhost | Identity added: /var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/6afd4346dd474260959eb74c7dcc602a_id_rsa (zuul-build-sshkey) 2026-04-18 16:35:13.869381 | ubuntu-focal -> localhost | ok: Runtime: 0:00:00.017008 2026-04-18 16:35:13.875551 | 2026-04-18 16:35:13.875671 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 16:35:14.208238 | ubuntu-focal | ok 2026-04-18 16:35:14.215293 | 2026-04-18 16:35:14.215398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 16:35:14.241196 | ubuntu-focal | skipping: Conditional result was False 2026-04-18 16:35:14.256172 | 2026-04-18 16:35:14.256325 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 16:35:14.595699 | ubuntu-focal | ok 2026-04-18 16:35:14.614578 | 2026-04-18 16:35:14.614812 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 16:35:15.663321 | ubuntu-focal | Output suppressed because no_log was given 2026-04-18 16:35:15.696403 | 2026-04-18 16:35:15.696598 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 16:35:15.876222 | ubuntu-focal | ok: "logs" 2026-04-18 16:35:15.876646 | ubuntu-focal | ok: All items complete 2026-04-18 16:35:15.876686 | 2026-04-18 16:35:16.012309 | ubuntu-focal | ok: "artifacts" 2026-04-18 16:35:16.158732 | ubuntu-focal | ok: "docs" 2026-04-18 16:35:16.173893 | 2026-04-18 16:35:16.174056 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 16:35:16.353537 | ubuntu-focal | changed: "logs" 2026-04-18 16:35:16.531022 | ubuntu-focal | changed: "artifacts" 2026-04-18 16:35:16.620763 | ubuntu-focal | changed: "docs" 2026-04-18 16:35:16.648543 | 2026-04-18 16:35:16.648661 | PLAY RECAP 2026-04-18 16:35:16.648717 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:35:16.648747 | ubuntu-focal | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 16:35:16.648768 | 2026-04-18 16:35:16.783801 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 16:35:16.785517 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:35:17.353224 | 2026-04-18 16:35:17.353329 | PLAY [all] 2026-04-18 16:35:17.364194 | 2026-04-18 16:35:17.364271 | TASK [setup-uv : Extract archive] 2026-04-18 16:35:19.495120 | ubuntu-focal | changed 2026-04-18 16:35:19.506466 | 2026-04-18 16:35:19.506642 | TASK [setup-uv : Print version] 2026-04-18 16:35:19.937713 | ubuntu-focal | uv 0.8.13 2026-04-18 16:35:20.059968 | ubuntu-focal | ok: Runtime: 0:00:00.009763 2026-04-18 16:35:20.070055 | 2026-04-18 16:35:20.070207 | PLAY RECAP 2026-04-18 16:35:20.070299 | ubuntu-focal | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:35:20.070353 | 2026-04-18 16:35:20.182279 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 16:35:20.184471 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:35:20.911685 | 2026-04-18 16:35:20.911958 | PLAY [all] 2026-04-18 16:35:20.930274 | 2026-04-18 16:35:20.930486 | TASK [Copy inventory file for Zuul] 2026-04-18 16:35:21.758319 | ubuntu-focal | changed 2026-04-18 16:35:21.763459 | 2026-04-18 16:35:21.763541 | TASK [Switch "ansible_host" to private IP] 2026-04-18 16:35:22.058051 | ubuntu-focal | changed: 1 replacements made 2026-04-18 16:35:22.172596 | 2026-04-18 16:35:22.172711 | TASK [Run Molecule scenario] 2026-04-18 16:35:22.662982 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-18 16:35:23.384232 | ubuntu-focal | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-18 16:35:23.553439 | ubuntu-focal | Using CPython 3.13.7 2026-04-18 16:35:23.553503 | ubuntu-focal | Creating virtual environment at: .venv 2026-04-18 16:35:23.860102 | ubuntu-focal | Downloading cryptography (4.3MiB) 2026-04-18 16:35:23.860509 | ubuntu-focal | Downloading pygments (1.2MiB) 2026-04-18 16:35:23.863764 | ubuntu-focal | Downloading ansible-core (2.3MiB) 2026-04-18 16:35:24.012313 | ubuntu-focal | Downloading cryptography 2026-04-18 16:35:24.048534 | ubuntu-focal | Downloading pygments 2026-04-18 16:35:24.196428 | ubuntu-focal | Downloading ansible-core 2026-04-18 16:35:24.224902 | ubuntu-focal | Installed 36 packages in 27ms 2026-04-18 16:35:25.296056 | ubuntu-focal | INFO Collection 'vexxhost.containers' detected. 2026-04-18 16:35:25.296136 | ubuntu-focal | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 16:35:26.065488 | ubuntu-focal | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-18 16:35:26.065553 | ubuntu-focal | INFO default scenario not found, disabling shared state. 2026-04-18 16:35:26.065646 | ubuntu-focal | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 16:35:26.065717 | ubuntu-focal | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-18 16:35:35.763852 | ubuntu-focal | INFO [forget-package > dependency] Executing 2026-04-18 16:35:35.763932 | ubuntu-focal | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-18 16:35:35.764182 | ubuntu-focal | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-18 16:35:35.764219 | ubuntu-focal | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 16:35:35.769253 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-18 16:35:35.769489 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:35:35.774324 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-18 16:35:35.774358 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-18 16:35:35.774416 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-18 16:35:35.779259 | ubuntu-focal | INFO [forget-package > syntax] Executing 2026-04-18 16:35:36.294007 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-18 16:35:36.294237 | 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-18 16:35:36.294444 | 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-18 16:35:36.294597 | ubuntu-focal | 2026-04-18 16:35:36.664591 | ubuntu-focal | 2026-04-18 16:35:36.664717 | ubuntu-focal | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-18 16:35:36.753075 | ubuntu-focal | INFO [forget-package > syntax] Executed: Successful 2026-04-18 16:35:36.763344 | ubuntu-focal | INFO [forget-package > create] Executing 2026-04-18 16:35:36.764607 | ubuntu-focal | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:35:36.769418 | ubuntu-focal | INFO [forget-package > prepare] Executing 2026-04-18 16:35:37.245945 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-18 16:35:37.246099 | 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-18 16:35:37.246296 | 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-18 16:35:37.246459 | ubuntu-focal | 2026-04-18 16:35:37.586342 | ubuntu-focal | 2026-04-18 16:35:37.586431 | ubuntu-focal | PLAY [Prepare] ***************************************************************** 2026-04-18 16:35:37.586561 | ubuntu-focal | 2026-04-18 16:35:37.586788 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:35:37.586931 | ubuntu-focal | Saturday 18 April 2026 16:35:37 +0000 (0:00:00.029) 0:00:00.029 ******** 2026-04-18 16:35:38.708229 | 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-18 16:35:38.710291 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:38.710491 | ubuntu-focal | 2026-04-18 16:35:38.710692 | ubuntu-focal | TASK [Install NGINX] *********************************************************** 2026-04-18 16:35:38.710881 | ubuntu-focal | Saturday 18 April 2026 16:35:38 +0000 (0:00:01.124) 0:00:01.154 ******** 2026-04-18 16:35:52.712869 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-18 16:35:52.712954 | ubuntu-focal | 2026-04-18 16:35:52.713070 | ubuntu-focal | TASK [Ensure NGINX is running] ************************************************* 2026-04-18 16:35:52.713183 | ubuntu-focal | Saturday 18 April 2026 16:35:52 +0000 (0:00:14.002) 0:00:15.156 ******** 2026-04-18 16:35:53.345130 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:53.345194 | ubuntu-focal | 2026-04-18 16:35:53.345202 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-18 16:35:53.345211 | ubuntu-focal | ubuntu-focal : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 16:35:53.345217 | ubuntu-focal | 2026-04-18 16:35:53.345222 | ubuntu-focal | 2026-04-18 16:35:53.345228 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-18 16:35:53.345239 | ubuntu-focal | Saturday 18 April 2026 16:35:53 +0000 (0:00:00.631) 0:00:15.788 ******** 2026-04-18 16:35:53.345310 | ubuntu-focal | =============================================================================== 2026-04-18 16:35:53.345492 | ubuntu-focal | Install NGINX ---------------------------------------------------------- 14.00s 2026-04-18 16:35:53.345661 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.12s 2026-04-18 16:35:53.345827 | ubuntu-focal | Ensure NGINX is running ------------------------------------------------- 0.63s 2026-04-18 16:35:53.465383 | ubuntu-focal | INFO [forget-package > prepare] Executed: Successful 2026-04-18 16:35:53.474191 | ubuntu-focal | INFO [forget-package > converge] Executing 2026-04-18 16:35:53.975210 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-18 16:35:53.975395 | 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-18 16:35:53.975594 | 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-18 16:35:53.975754 | ubuntu-focal | 2026-04-18 16:35:54.281559 | ubuntu-focal | 2026-04-18 16:35:54.281704 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-18 16:35:54.281859 | ubuntu-focal | 2026-04-18 16:35:54.282032 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:35:54.282201 | ubuntu-focal | Saturday 18 April 2026 16:35:54 +0000 (0:00:00.007) 0:00:00.007 ******** 2026-04-18 16:35:55.302821 | 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-18 16:35:55.304794 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:55.304974 | ubuntu-focal | 2026-04-18 16:35:55.305167 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 16:35:55.305346 | ubuntu-focal | Saturday 18 April 2026 16:35:55 +0000 (0:00:01.023) 0:00:01.030 ******** 2026-04-18 16:35:55.668981 | 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-18 16:35:55.672320 | ubuntu-focal | changed: [ubuntu-focal] 2026-04-18 16:35:55.672410 | ubuntu-focal | 2026-04-18 16:35:55.672582 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-18 16:35:55.672690 | ubuntu-focal | ubuntu-focal : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 16:35:55.672789 | ubuntu-focal | 2026-04-18 16:35:55.672882 | ubuntu-focal | 2026-04-18 16:35:55.673003 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-18 16:35:55.673117 | ubuntu-focal | Saturday 18 April 2026 16:35:55 +0000 (0:00:00.367) 0:00:01.398 ******** 2026-04-18 16:35:55.673224 | ubuntu-focal | =============================================================================== 2026-04-18 16:35:55.673340 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.02s 2026-04-18 16:35:55.673456 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.37s 2026-04-18 16:35:55.767729 | ubuntu-focal | INFO [forget-package > converge] Executed: Successful 2026-04-18 16:35:55.773190 | ubuntu-focal | INFO [forget-package > idempotence] Executing 2026-04-18 16:35:56.266331 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-18 16:35:56.266415 | 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-18 16:35:56.266425 | 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-18 16:35:56.266509 | ubuntu-focal | 2026-04-18 16:35:56.609975 | ubuntu-focal | 2026-04-18 16:35:56.610067 | ubuntu-focal | PLAY [Converge] **************************************************************** 2026-04-18 16:35:56.610187 | ubuntu-focal | 2026-04-18 16:35:56.610395 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:35:56.610527 | ubuntu-focal | Saturday 18 April 2026 16:35:56 +0000 (0:00:00.008) 0:00:00.008 ******** 2026-04-18 16:35:57.686081 | 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-18 16:35:57.688313 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:57.688476 | ubuntu-focal | 2026-04-18 16:35:57.688657 | ubuntu-focal | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 16:35:57.688833 | ubuntu-focal | Saturday 18 April 2026 16:35:57 +0000 (0:00:01.078) 0:00:01.087 ******** 2026-04-18 16:35:58.037981 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:58.038135 | ubuntu-focal | 2026-04-18 16:35:58.038326 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-18 16:35:58.038513 | ubuntu-focal | ubuntu-focal : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 16:35:58.038666 | ubuntu-focal | 2026-04-18 16:35:58.038815 | ubuntu-focal | 2026-04-18 16:35:58.039021 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-18 16:35:58.039269 | ubuntu-focal | Saturday 18 April 2026 16:35:58 +0000 (0:00:00.349) 0:00:01.436 ******** 2026-04-18 16:35:58.039423 | ubuntu-focal | =============================================================================== 2026-04-18 16:35:58.039590 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-18 16:35:58.039761 | ubuntu-focal | vexxhost.containers.forget_package : Forget package --------------------- 0.35s 2026-04-18 16:35:58.144306 | ubuntu-focal | INFO [forget-package > idempotence] Executed: Successful 2026-04-18 16:35:58.154186 | ubuntu-focal | INFO [forget-package > side_effect] Executing 2026-04-18 16:35:58.154453 | ubuntu-focal | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:35:58.159360 | ubuntu-focal | INFO [forget-package > verify] Executing 2026-04-18 16:35:58.640161 | ubuntu-focal | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-18 16:35:58.640404 | 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-18 16:35:58.640611 | 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-18 16:35:58.640773 | ubuntu-focal | 2026-04-18 16:35:58.933624 | ubuntu-focal | 2026-04-18 16:35:58.933783 | ubuntu-focal | PLAY [Verify] ****************************************************************** 2026-04-18 16:35:58.933942 | ubuntu-focal | 2026-04-18 16:35:58.934120 | ubuntu-focal | TASK [Gathering Facts] ********************************************************* 2026-04-18 16:35:58.934299 | ubuntu-focal | Saturday 18 April 2026 16:35:58 +0000 (0:00:00.007) 0:00:00.007 ******** 2026-04-18 16:35:59.962239 | 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-18 16:35:59.964972 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:35:59.965075 | ubuntu-focal | 2026-04-18 16:35:59.965192 | ubuntu-focal | TASK [Populate package facts] ************************************************** 2026-04-18 16:35:59.965302 | ubuntu-focal | Saturday 18 April 2026 16:35:59 +0000 (0:00:01.031) 0:00:01.039 ******** 2026-04-18 16:36:01.967874 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:36:01.967960 | ubuntu-focal | 2026-04-18 16:36:01.968264 | ubuntu-focal | TASK [Populate service facts] ************************************************** 2026-04-18 16:36:01.968325 | ubuntu-focal | Saturday 18 April 2026 16:36:01 +0000 (0:00:02.002) 0:00:03.042 ******** 2026-04-18 16:36:03.707745 | ubuntu-focal | ok: [ubuntu-focal] 2026-04-18 16:36:03.707814 | ubuntu-focal | 2026-04-18 16:36:03.707820 | ubuntu-focal | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-18 16:36:03.707825 | ubuntu-focal | Saturday 18 April 2026 16:36:03 +0000 (0:00:01.739) 0:00:04.782 ******** 2026-04-18 16:36:03.737712 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-18 16:36:03.737735 | ubuntu-focal | "changed": false, 2026-04-18 16:36:03.737742 | ubuntu-focal | "msg": "All assertions passed" 2026-04-18 16:36:03.737749 | ubuntu-focal | } 2026-04-18 16:36:03.737754 | ubuntu-focal | 2026-04-18 16:36:03.737760 | ubuntu-focal | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-18 16:36:03.737766 | ubuntu-focal | Saturday 18 April 2026 16:36:03 +0000 (0:00:00.029) 0:00:04.811 ******** 2026-04-18 16:36:03.766799 | ubuntu-focal | ok: [ubuntu-focal] => { 2026-04-18 16:36:03.766860 | ubuntu-focal | "changed": false, 2026-04-18 16:36:03.766867 | ubuntu-focal | "msg": "All assertions passed" 2026-04-18 16:36:03.766874 | ubuntu-focal | } 2026-04-18 16:36:03.766881 | ubuntu-focal | 2026-04-18 16:36:03.766887 | ubuntu-focal | PLAY RECAP ********************************************************************* 2026-04-18 16:36:03.766894 | ubuntu-focal | ubuntu-focal : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-18 16:36:03.766900 | ubuntu-focal | 2026-04-18 16:36:03.766905 | ubuntu-focal | 2026-04-18 16:36:03.766911 | ubuntu-focal | TASKS RECAP ******************************************************************** 2026-04-18 16:36:03.766917 | ubuntu-focal | Saturday 18 April 2026 16:36:03 +0000 (0:00:00.027) 0:00:04.839 ******** 2026-04-18 16:36:03.766922 | ubuntu-focal | =============================================================================== 2026-04-18 16:36:03.766929 | ubuntu-focal | Populate package facts -------------------------------------------------- 2.00s 2026-04-18 16:36:03.766935 | ubuntu-focal | Populate service facts -------------------------------------------------- 1.74s 2026-04-18 16:36:03.766941 | ubuntu-focal | Gathering Facts --------------------------------------------------------- 1.03s 2026-04-18 16:36:03.766947 | ubuntu-focal | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-18 16:36:03.766953 | ubuntu-focal | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-04-18 16:36:03.911667 | ubuntu-focal | INFO [forget-package > verify] Executed: Successful 2026-04-18 16:36:03.922459 | ubuntu-focal | INFO [forget-package > cleanup] Executing 2026-04-18 16:36:03.922708 | ubuntu-focal | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 16:36:03.927605 | ubuntu-focal | INFO [forget-package > destroy] Executing 2026-04-18 16:36:03.927744 | ubuntu-focal | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-18 16:36:03.927840 | ubuntu-focal | INFO [forget-package > destroy] Executed: Successful 2026-04-18 16:36:03.928110 | ubuntu-focal | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-18 16:36:04.299374 | ubuntu-focal | ok: Runtime: 0:00:41.504753 2026-04-18 16:36:04.302912 | 2026-04-18 16:36:04.302966 | PLAY RECAP 2026-04-18 16:36:04.303016 | ubuntu-focal | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 16:36:04.303038 | 2026-04-18 16:36:04.405168 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 16:36:04.406315 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:36:05.076410 | 2026-04-18 16:36:05.076780 | PLAY [all] 2026-04-18 16:36:05.090395 | 2026-04-18 16:36:05.090512 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 16:36:05.145201 | ubuntu-focal | skipping: Conditional result was False 2026-04-18 16:36:05.156937 | 2026-04-18 16:36:05.157095 | TASK [fetch-output : Set log path for single node] 2026-04-18 16:36:05.192886 | ubuntu-focal | ok 2026-04-18 16:36:05.197622 | 2026-04-18 16:36:05.197719 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 16:36:05.586772 | ubuntu-focal -> localhost | ok: "/var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/logs" 2026-04-18 16:36:05.811770 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/artifacts" 2026-04-18 16:36:06.030906 | ubuntu-focal -> localhost | changed: "/var/lib/zuul/builds/6afd4346dd474260959eb74c7dcc602a/work/docs" 2026-04-18 16:36:06.047582 | 2026-04-18 16:36:06.047750 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 16:36:06.623629 | ubuntu-focal | ok 2026-04-18 16:36:06.623890 | ubuntu-focal | changed: All items complete 2026-04-18 16:36:06.623919 | 2026-04-18 16:36:07.096163 | ubuntu-focal | changed: .d..t...... ./ 2026-04-18 16:36:07.619595 | ubuntu-focal | changed: .d..t...... ./ 2026-04-18 16:36:07.655564 | 2026-04-18 16:36:07.655685 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 16:36:08.080350 | ubuntu-focal -> localhost | ok: Item: artifacts Runtime: 0:00:00.022454 2026-04-18 16:36:08.387762 | ubuntu-focal -> localhost | ok: Item: docs Runtime: 0:00:00.022588 2026-04-18 16:36:08.408160 | 2026-04-18 16:36:08.408279 | PLAY [all] 2026-04-18 16:36:08.415969 | 2026-04-18 16:36:08.416088 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 16:36:08.843701 | ubuntu-focal | changed 2026-04-18 16:36:08.850016 | 2026-04-18 16:36:08.850085 | PLAY RECAP 2026-04-18 16:36:08.850133 | ubuntu-focal | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 16:36:08.850156 | 2026-04-18 16:36:08.972998 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 16:36:09.122650 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 16:36:09.702318 | 2026-04-18 16:36:09.702440 | PLAY [localhost] 2026-04-18 16:36:09.712569 | 2026-04-18 16:36:09.712644 | TASK [Generate Zuul manifest] 2026-04-18 16:36:09.750479 | localhost | ok 2026-04-18 16:36:09.766012 | 2026-04-18 16:36:09.766117 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 16:36:10.149435 | localhost | changed 2026-04-18 16:36:10.160467 | 2026-04-18 16:36:10.160579 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 16:36:10.206035 | localhost | ok 2026-04-18 16:36:10.214349 | 2026-04-18 16:36:10.214423 | TASK [Upload logs] 2026-04-18 16:36:10.233314 | localhost | ok 2026-04-18 16:36:10.292360 | 2026-04-18 16:36:10.292485 | TASK [Set zuul-log-path fact] 2026-04-18 16:36:10.320885 | localhost | ok 2026-04-18 16:36:10.341935 | 2026-04-18 16:36:10.342055 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 16:36:10.372200 | localhost | ok 2026-04-18 16:36:10.380449 | 2026-04-18 16:36:10.380527 | TASK [upload-logs : Create log directories] 2026-04-18 16:36:10.868728 | localhost | changed 2026-04-18 16:36:10.875079 | 2026-04-18 16:36:10.875165 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 16:36:11.863017 | localhost -> localhost | ok: Runtime: 0:00:00.455657 2026-04-18 16:36:11.870311 | 2026-04-18 16:36:11.870387 | TASK [upload-logs : Upload logs to log server] 2026-04-18 16:36:12.456585 | localhost | Output suppressed because no_log was given 2026-04-18 16:36:12.467802 | 2026-04-18 16:36:12.467936 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 16:36:12.518432 | localhost | skipping: Conditional result was False 2026-04-18 16:36:12.526033 | localhost | skipping: Conditional result was False 2026-04-18 16:36:12.541850 | 2026-04-18 16:36:12.542036 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 16:36:12.589966 | localhost | skipping: Conditional result was False 2026-04-18 16:36:12.590397 | 2026-04-18 16:36:12.600468 | localhost | skipping: Conditional result was False 2026-04-18 16:36:12.617762 | 2026-04-18 16:36:12.618243 | LOOP [upload-logs : Upload console log and json output]