2026-04-29 20:48:27.884994 | Job console starting 2026-04-29 20:48:27.966566 | Updating git repos 2026-04-29 20:48:28.066537 | Cloning repos into workspace 2026-04-29 20:48:28.784242 | Restoring repo states 2026-04-29 20:48:28.796807 | Merging changes 2026-04-29 20:48:29.973880 | Checking out repos 2026-04-29 20:48:30.431071 | Preparing playbooks 2026-04-29 20:48:32.326166 | Running Ansible setup 2026-04-29 20:48:36.038024 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 20:48:36.765169 | 2026-04-29 20:48:36.765337 | PLAY [localhost] 2026-04-29 20:48:36.788228 | 2026-04-29 20:48:36.788391 | TASK [Gathering Facts] 2026-04-29 20:48:37.821500 | localhost | ok 2026-04-29 20:48:37.828654 | 2026-04-29 20:48:37.828735 | TASK [Setup log path fact] 2026-04-29 20:48:37.847955 | localhost | ok 2026-04-29 20:48:37.860811 | 2026-04-29 20:48:37.860886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 20:48:37.891670 | localhost | ok 2026-04-29 20:48:37.901706 | 2026-04-29 20:48:37.901815 | TASK [emit-job-header : Print job information] 2026-04-29 20:48:37.932891 | # Job Information 2026-04-29 20:48:37.933126 | Ansible Version: 2.16.18 2026-04-29 20:48:37.933161 | Job: ansible-collection-containers-molecule-forget-package-debian-trixie 2026-04-29 20:48:37.933185 | Pipeline: check 2026-04-29 20:48:37.933205 | Executor: 2d72f0692154 2026-04-29 20:48:37.933226 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/126 2026-04-29 20:48:37.933249 | Event ID: 9b4e1cc0-440c-11f1-90ca-0e5250fcd001 2026-04-29 20:48:37.936590 | 2026-04-29 20:48:37.936669 | LOOP [emit-job-header : Print node information] 2026-04-29 20:48:38.016548 | localhost | ok: 2026-04-29 20:48:38.016762 | localhost | # Node Information 2026-04-29 20:48:38.016798 | localhost | Inventory Hostname: debian-trixie 2026-04-29 20:48:38.016826 | localhost | Hostname: np0000171283 2026-04-29 20:48:38.016852 | localhost | Username: zuul 2026-04-29 20:48:38.016881 | localhost | Distro: Debian 13.4 2026-04-29 20:48:38.016907 | localhost | Provider: yul1 2026-04-29 20:48:38.016931 | localhost | Region: ca-ymq-1 2026-04-29 20:48:38.016976 | localhost | Label: debian-trixie 2026-04-29 20:48:38.017002 | localhost | Product Name: OpenStack Nova 2026-04-29 20:48:38.017024 | localhost | Interface IP: 199.204.45.132 2026-04-29 20:48:38.031322 | 2026-04-29 20:48:38.031479 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 20:48:38.433086 | localhost -> localhost | changed 2026-04-29 20:48:38.439775 | 2026-04-29 20:48:38.439854 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 20:48:39.523254 | localhost -> localhost | changed 2026-04-29 20:48:39.533126 | 2026-04-29 20:48:39.533187 | PLAY [all] 2026-04-29 20:48:39.543771 | 2026-04-29 20:48:39.621128 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 20:48:39.919383 | debian-trixie -> localhost | ok 2026-04-29 20:48:39.924568 | 2026-04-29 20:48:39.924639 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 20:48:39.954008 | debian-trixie | ok 2026-04-29 20:48:39.969322 | debian-trixie | included: /var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 20:48:39.974100 | 2026-04-29 20:48:39.974163 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 20:48:41.131562 | debian-trixie -> localhost | Generating public/private rsa key pair. 2026-04-29 20:48:41.244713 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/14fb524d7dd24fd0a23eb8348ad3a978_id_rsa 2026-04-29 20:48:41.244816 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/14fb524d7dd24fd0a23eb8348ad3a978_id_rsa.pub 2026-04-29 20:48:41.244874 | debian-trixie -> localhost | The key fingerprint is: 2026-04-29 20:48:41.244922 | debian-trixie -> localhost | SHA256:aKTMIuY/duFpFzRG8Nx+OntFzfZKTDnZfegu3SV6/JY zuul-build-sshkey 2026-04-29 20:48:41.245032 | debian-trixie -> localhost | The key's randomart image is: 2026-04-29 20:48:41.245093 | debian-trixie -> localhost | +---[RSA 3072]----+ 2026-04-29 20:48:41.245153 | debian-trixie -> localhost | | .. | 2026-04-29 20:48:41.245208 | debian-trixie -> localhost | | o.. | 2026-04-29 20:48:41.245259 | debian-trixie -> localhost | | oo . o=.| 2026-04-29 20:48:41.245306 | debian-trixie -> localhost | | o o =. .*++| 2026-04-29 20:48:41.245349 | debian-trixie -> localhost | |... + = S. ..+..o| 2026-04-29 20:48:41.245393 | debian-trixie -> localhost | |o. . o . o .= o| 2026-04-29 20:48:41.245436 | debian-trixie -> localhost | | . . o .o .* +o| 2026-04-29 20:48:41.245479 | debian-trixie -> localhost | | .o = . o.o *Eo| 2026-04-29 20:48:41.245529 | debian-trixie -> localhost | | ..+ . .. o o.| 2026-04-29 20:48:41.245585 | debian-trixie -> localhost | +----[SHA256]-----+ 2026-04-29 20:48:41.245716 | debian-trixie -> localhost | ok: Runtime: 0:00:00.604125 2026-04-29 20:48:41.259615 | 2026-04-29 20:48:41.259842 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 20:48:41.290335 | debian-trixie | ok 2026-04-29 20:48:41.686528 | debian-trixie | included: /var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 20:48:41.693297 | 2026-04-29 20:48:41.693364 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 20:48:41.719021 | debian-trixie | skipping: Conditional result was False 2026-04-29 20:48:41.726597 | 2026-04-29 20:48:41.732123 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 20:48:42.279678 | debian-trixie | changed 2026-04-29 20:48:42.284419 | 2026-04-29 20:48:42.284491 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 20:48:42.493509 | debian-trixie | ok 2026-04-29 20:48:42.500986 | 2026-04-29 20:48:42.501179 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 20:48:43.046581 | debian-trixie | changed 2026-04-29 20:48:43.051187 | 2026-04-29 20:48:43.051277 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 20:48:43.590598 | debian-trixie | changed 2026-04-29 20:48:43.595009 | 2026-04-29 20:48:43.595075 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 20:48:43.620631 | debian-trixie | skipping: Conditional result was False 2026-04-29 20:48:43.627164 | 2026-04-29 20:48:43.627301 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 20:48:44.048331 | debian-trixie -> localhost | changed 2026-04-29 20:48:44.072471 | 2026-04-29 20:48:44.072628 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 20:48:44.406008 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/14fb524d7dd24fd0a23eb8348ad3a978_id_rsa (zuul-build-sshkey) 2026-04-29 20:48:44.406237 | debian-trixie -> localhost | ok: Runtime: 0:00:00.030114 2026-04-29 20:48:44.412812 | 2026-04-29 20:48:44.412875 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 20:48:44.772778 | debian-trixie | ok 2026-04-29 20:48:44.776609 | 2026-04-29 20:48:44.776673 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 20:48:44.803420 | debian-trixie | skipping: Conditional result was False 2026-04-29 20:48:44.821649 | 2026-04-29 20:48:44.821836 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-29 20:48:45.174119 | debian-trixie | ok 2026-04-29 20:48:45.183638 | 2026-04-29 20:48:45.183700 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-29 20:48:46.125425 | debian-trixie | Output suppressed because no_log was given 2026-04-29 20:48:46.143289 | 2026-04-29 20:48:46.143425 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-29 20:48:46.357460 | debian-trixie | ok: "logs" 2026-04-29 20:48:46.357768 | debian-trixie | ok: All items complete 2026-04-29 20:48:46.357815 | 2026-04-29 20:48:46.537148 | debian-trixie | ok: "artifacts" 2026-04-29 20:48:46.729860 | debian-trixie | ok: "docs" 2026-04-29 20:48:46.741917 | 2026-04-29 20:48:46.742731 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-29 20:48:46.950876 | debian-trixie | changed: "logs" 2026-04-29 20:48:47.127598 | debian-trixie | changed: "artifacts" 2026-04-29 20:48:47.311497 | debian-trixie | changed: "docs" 2026-04-29 20:48:47.324443 | 2026-04-29 20:48:47.324563 | PLAY RECAP 2026-04-29 20:48:47.324612 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-29 20:48:47.324641 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:48:47.324663 | 2026-04-29 20:48:47.562317 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 20:48:47.570348 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-29 20:48:48.169497 | 2026-04-29 20:48:48.169634 | PLAY [all] 2026-04-29 20:48:48.180431 | 2026-04-29 20:48:48.180511 | TASK [setup-uv : Extract archive] 2026-04-29 20:48:50.591309 | debian-trixie | changed 2026-04-29 20:48:50.596751 | 2026-04-29 20:48:50.596834 | TASK [setup-uv : Print version] 2026-04-29 20:48:51.008734 | debian-trixie | uv 0.8.13 2026-04-29 20:48:51.138118 | debian-trixie | ok: Runtime: 0:00:00.013744 2026-04-29 20:48:51.158098 | 2026-04-29 20:48:51.158200 | PLAY RECAP 2026-04-29 20:48:51.158248 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:48:51.158272 | 2026-04-29 20:48:51.310864 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-29 20:48:51.313159 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-29 20:48:51.882240 | 2026-04-29 20:48:51.882372 | PLAY [all] 2026-04-29 20:48:51.892799 | 2026-04-29 20:48:51.892871 | TASK [Copy inventory file for Zuul] 2026-04-29 20:48:52.879009 | debian-trixie | changed 2026-04-29 20:48:52.884437 | 2026-04-29 20:48:52.884527 | TASK [Switch "ansible_host" to private IP] 2026-04-29 20:48:53.201130 | debian-trixie | changed: 1 replacements made 2026-04-29 20:48:53.207597 | 2026-04-29 20:48:53.208287 | TASK [Run Molecule scenario] 2026-04-29 20:48:53.691493 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-29 20:48:53.691569 | debian-trixie | Creating virtual environment at: .venv 2026-04-29 20:48:54.061878 | debian-trixie | Downloading pygments (1.2MiB) 2026-04-29 20:48:54.062697 | debian-trixie | Downloading ansible-core (2.3MiB) 2026-04-29 20:48:54.063628 | debian-trixie | Downloading cryptography (4.3MiB) 2026-04-29 20:48:54.220846 | debian-trixie | Downloading cryptography 2026-04-29 20:48:54.270283 | debian-trixie | Downloading pygments 2026-04-29 20:48:54.403778 | debian-trixie | Downloading ansible-core 2026-04-29 20:48:54.458032 | debian-trixie | Installed 36 packages in 53ms 2026-04-29 20:48:55.121662 | debian-trixie | INFO Collection 'vexxhost.containers' detected. 2026-04-29 20:48:55.121730 | debian-trixie | INFO Scenarios will be used from 'extensions/molecule' 2026-04-29 20:48:55.991421 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-29 20:48:55.991484 | debian-trixie | INFO default scenario not found, disabling shared state. 2026-04-29 20:48:55.991511 | debian-trixie | INFO [forget-package > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-29 20:48:55.991597 | debian-trixie | INFO [forget-package > prerun] Performing prerun with role_name_check=0... 2026-04-29 20:49:04.666241 | debian-trixie | INFO [forget-package > dependency] Executing 2026-04-29 20:49:04.666571 | debian-trixie | WARNING [forget-package > dependency] Missing roles requirements file: requirements.yml 2026-04-29 20:49:04.666869 | debian-trixie | WARNING [forget-package > dependency] Missing collections requirements file: collections.yml 2026-04-29 20:49:04.667060 | debian-trixie | WARNING [forget-package > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-29 20:49:04.673120 | debian-trixie | INFO [forget-package > cleanup] Executing 2026-04-29 20:49:04.673400 | debian-trixie | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:04.678896 | debian-trixie | INFO [forget-package > destroy] Executing 2026-04-29 20:49:04.678993 | debian-trixie | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-29 20:49:04.679044 | debian-trixie | INFO [forget-package > destroy] Executed: Successful 2026-04-29 20:49:04.684393 | debian-trixie | INFO [forget-package > syntax] Executing 2026-04-29 20:49:05.207052 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:05.207349 | debian-trixie | [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-29 20:49:05.207634 | debian-trixie | 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-29 20:49:05.207823 | debian-trixie | 2026-04-29 20:49:05.579786 | debian-trixie | 2026-04-29 20:49:05.579962 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/forget-package/converge.yml 2026-04-29 20:49:05.639739 | debian-trixie | INFO [forget-package > syntax] Executed: Successful 2026-04-29 20:49:05.651282 | debian-trixie | INFO [forget-package > create] Executing 2026-04-29 20:49:05.652751 | debian-trixie | WARNING [forget-package > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:05.658569 | debian-trixie | INFO [forget-package > prepare] Executing 2026-04-29 20:49:06.144187 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:06.144379 | debian-trixie | [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-29 20:49:06.144580 | debian-trixie | 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-29 20:49:06.144748 | debian-trixie | 2026-04-29 20:49:06.487677 | debian-trixie | 2026-04-29 20:49:06.487933 | debian-trixie | PLAY [Prepare] ***************************************************************** 2026-04-29 20:49:06.488182 | debian-trixie | 2026-04-29 20:49:06.488403 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:06.488666 | debian-trixie | Wednesday 29 April 2026 20:49:06 +0000 (0:00:00.028) 0:00:00.028 ******* 2026-04-29 20:49:08.799476 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', 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-29 20:49:08.802656 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:08.802778 | debian-trixie | 2026-04-29 20:49:08.802935 | debian-trixie | TASK [Install NGINX] *********************************************************** 2026-04-29 20:49:08.806887 | debian-trixie | Wednesday 29 April 2026 20:49:08 +0000 (0:00:02.315) 0:00:02.344 ******* 2026-04-29 20:49:17.706024 | debian-trixie | changed: [debian-trixie] 2026-04-29 20:49:17.706073 | debian-trixie | 2026-04-29 20:49:17.706084 | debian-trixie | TASK [Ensure NGINX is running] ************************************************* 2026-04-29 20:49:17.706093 | debian-trixie | Wednesday 29 April 2026 20:49:17 +0000 (0:00:08.901) 0:00:11.245 ******* 2026-04-29 20:49:18.452946 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:18.453059 | debian-trixie | 2026-04-29 20:49:18.453261 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-29 20:49:18.453477 | debian-trixie | debian-trixie : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:18.453658 | debian-trixie | 2026-04-29 20:49:18.453832 | debian-trixie | 2026-04-29 20:49:18.454012 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-29 20:49:18.454249 | debian-trixie | Wednesday 29 April 2026 20:49:18 +0000 (0:00:00.748) 0:00:11.993 ******* 2026-04-29 20:49:18.454432 | debian-trixie | =============================================================================== 2026-04-29 20:49:18.454641 | debian-trixie | Install NGINX ----------------------------------------------------------- 8.90s 2026-04-29 20:49:18.454816 | debian-trixie | Gathering Facts --------------------------------------------------------- 2.32s 2026-04-29 20:49:18.455059 | debian-trixie | Ensure NGINX is running ------------------------------------------------- 0.75s 2026-04-29 20:49:18.538055 | debian-trixie | INFO [forget-package > prepare] Executed: Successful 2026-04-29 20:49:18.548447 | debian-trixie | INFO [forget-package > converge] Executing 2026-04-29 20:49:19.095432 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:19.095630 | debian-trixie | [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-29 20:49:19.095848 | debian-trixie | 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-29 20:49:19.096000 | debian-trixie | 2026-04-29 20:49:19.423537 | debian-trixie | 2026-04-29 20:49:19.423678 | debian-trixie | PLAY [Converge] **************************************************************** 2026-04-29 20:49:19.423924 | debian-trixie | 2026-04-29 20:49:19.424047 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:19.424283 | debian-trixie | Wednesday 29 April 2026 20:49:19 +0000 (0:00:00.008) 0:00:00.008 ******* 2026-04-29 20:49:20.533032 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', 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-29 20:49:20.535409 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:20.535589 | debian-trixie | 2026-04-29 20:49:20.535811 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-29 20:49:20.536002 | debian-trixie | Wednesday 29 April 2026 20:49:20 +0000 (0:00:01.112) 0:00:01.120 ******* 2026-04-29 20:49:20.992004 | debian-trixie | [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-29 20:49:20.996896 | debian-trixie | changed: [debian-trixie] 2026-04-29 20:49:20.997150 | debian-trixie | 2026-04-29 20:49:20.997366 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-29 20:49:20.997580 | debian-trixie | debian-trixie : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:20.997756 | debian-trixie | 2026-04-29 20:49:20.997925 | debian-trixie | 2026-04-29 20:49:20.998136 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-29 20:49:20.998324 | debian-trixie | Wednesday 29 April 2026 20:49:20 +0000 (0:00:00.461) 0:00:01.582 ******* 2026-04-29 20:49:20.998501 | debian-trixie | =============================================================================== 2026-04-29 20:49:20.998690 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.11s 2026-04-29 20:49:20.998986 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-04-29 20:49:21.115289 | debian-trixie | INFO [forget-package > converge] Executed: Successful 2026-04-29 20:49:21.125878 | debian-trixie | INFO [forget-package > idempotence] Executing 2026-04-29 20:49:21.657374 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:21.657445 | debian-trixie | [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-29 20:49:21.657705 | debian-trixie | 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-29 20:49:21.657862 | debian-trixie | 2026-04-29 20:49:22.011772 | debian-trixie | 2026-04-29 20:49:22.011923 | debian-trixie | PLAY [Converge] **************************************************************** 2026-04-29 20:49:22.012100 | debian-trixie | 2026-04-29 20:49:22.012284 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:22.012475 | debian-trixie | Wednesday 29 April 2026 20:49:22 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-04-29 20:49:24.112266 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', 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-29 20:49:24.114155 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:24.114265 | debian-trixie | 2026-04-29 20:49:24.114405 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-29 20:49:24.114543 | debian-trixie | Wednesday 29 April 2026 20:49:24 +0000 (0:00:02.102) 0:00:02.111 ******* 2026-04-29 20:49:24.536470 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:24.536574 | debian-trixie | 2026-04-29 20:49:24.536771 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-29 20:49:24.536979 | debian-trixie | debian-trixie : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:24.537152 | debian-trixie | 2026-04-29 20:49:24.537317 | debian-trixie | 2026-04-29 20:49:24.537506 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-29 20:49:24.537687 | debian-trixie | Wednesday 29 April 2026 20:49:24 +0000 (0:00:00.422) 0:00:02.534 ******* 2026-04-29 20:49:24.537859 | debian-trixie | =============================================================================== 2026-04-29 20:49:24.538041 | debian-trixie | Gathering Facts --------------------------------------------------------- 2.10s 2026-04-29 20:49:24.538224 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.42s 2026-04-29 20:49:24.639005 | debian-trixie | INFO [forget-package > idempotence] Executed: Successful 2026-04-29 20:49:24.649419 | debian-trixie | INFO [forget-package > side_effect] Executing 2026-04-29 20:49:24.649738 | debian-trixie | WARNING [forget-package > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:24.655019 | debian-trixie | INFO [forget-package > verify] Executing 2026-04-29 20:49:25.204484 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-29 20:49:25.204668 | debian-trixie | [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-29 20:49:25.204923 | debian-trixie | 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-29 20:49:25.205119 | debian-trixie | 2026-04-29 20:49:25.555494 | debian-trixie | 2026-04-29 20:49:25.555577 | debian-trixie | PLAY [Verify] ****************************************************************** 2026-04-29 20:49:25.555586 | debian-trixie | 2026-04-29 20:49:25.555689 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-29 20:49:25.555764 | debian-trixie | Wednesday 29 April 2026 20:49:25 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-04-29 20:49:26.699376 | debian-trixie | [WARNING]: Host 'debian-trixie' is using the discovered Python interpreter at '/usr/bin/python3.13', 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-29 20:49:26.699459 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:26.699553 | debian-trixie | 2026-04-29 20:49:26.699642 | debian-trixie | TASK [Populate package facts] ************************************************** 2026-04-29 20:49:26.699730 | debian-trixie | Wednesday 29 April 2026 20:49:26 +0000 (0:00:01.144) 0:00:01.154 ******* 2026-04-29 20:49:28.146973 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:28.147127 | debian-trixie | 2026-04-29 20:49:28.147348 | debian-trixie | TASK [Populate service facts] ************************************************** 2026-04-29 20:49:28.147560 | debian-trixie | Wednesday 29 April 2026 20:49:28 +0000 (0:00:01.446) 0:00:02.601 ******* 2026-04-29 20:49:32.055790 | debian-trixie | ok: [debian-trixie] 2026-04-29 20:49:32.055876 | debian-trixie | 2026-04-29 20:49:32.055887 | debian-trixie | TASK [Assert that the NGINX package is not installed] ************************** 2026-04-29 20:49:32.055895 | debian-trixie | Wednesday 29 April 2026 20:49:32 +0000 (0:00:03.905) 0:00:06.506 ******* 2026-04-29 20:49:32.082702 | debian-trixie | ok: [debian-trixie] => { 2026-04-29 20:49:32.082763 | debian-trixie | "changed": false, 2026-04-29 20:49:32.082883 | debian-trixie | "msg": "All assertions passed" 2026-04-29 20:49:32.083003 | debian-trixie | } 2026-04-29 20:49:32.083144 | debian-trixie | 2026-04-29 20:49:32.083174 | debian-trixie | TASK [Assert that the NGINX service is still up] ******************************* 2026-04-29 20:49:32.083273 | debian-trixie | Wednesday 29 April 2026 20:49:32 +0000 (0:00:00.030) 0:00:06.537 ******* 2026-04-29 20:49:32.112943 | debian-trixie | ok: [debian-trixie] => { 2026-04-29 20:49:32.113016 | debian-trixie | "changed": false, 2026-04-29 20:49:32.113103 | debian-trixie | "msg": "All assertions passed" 2026-04-29 20:49:32.113182 | debian-trixie | } 2026-04-29 20:49:32.113262 | debian-trixie | 2026-04-29 20:49:32.113347 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-29 20:49:32.113437 | debian-trixie | debian-trixie : ok=5 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-29 20:49:32.113514 | debian-trixie | 2026-04-29 20:49:32.113589 | debian-trixie | 2026-04-29 20:49:32.113672 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-29 20:49:32.113758 | debian-trixie | Wednesday 29 April 2026 20:49:32 +0000 (0:00:00.030) 0:00:06.568 ******* 2026-04-29 20:49:32.113837 | debian-trixie | =============================================================================== 2026-04-29 20:49:32.113921 | debian-trixie | Populate service facts -------------------------------------------------- 3.91s 2026-04-29 20:49:32.114004 | debian-trixie | Populate package facts -------------------------------------------------- 1.45s 2026-04-29 20:49:32.114088 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.14s 2026-04-29 20:49:32.114173 | debian-trixie | Assert that the NGINX service is still up ------------------------------- 0.03s 2026-04-29 20:49:32.114263 | debian-trixie | Assert that the NGINX package is not installed -------------------------- 0.03s 2026-04-29 20:49:32.214174 | debian-trixie | INFO [forget-package > verify] Executed: Successful 2026-04-29 20:49:32.225978 | debian-trixie | INFO [forget-package > cleanup] Executing 2026-04-29 20:49:32.226459 | debian-trixie | WARNING [forget-package > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-29 20:49:32.234347 | debian-trixie | INFO [forget-package > destroy] Executing 2026-04-29 20:49:32.234443 | debian-trixie | WARNING [forget-package > destroy] Skipping, '--destroy=never' requested. 2026-04-29 20:49:32.234538 | debian-trixie | INFO [forget-package > destroy] Executed: Successful 2026-04-29 20:49:32.235019 | debian-trixie | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-29 20:49:32.784487 | debian-trixie | ok: Runtime: 0:00:38.710305 2026-04-29 20:49:32.788555 | 2026-04-29 20:49:32.788620 | PLAY RECAP 2026-04-29 20:49:32.788679 | debian-trixie | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 20:49:32.788714 | 2026-04-29 20:49:32.907360 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-29 20:49:32.910026 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 20:49:33.516463 | 2026-04-29 20:49:33.516621 | PLAY [all] 2026-04-29 20:49:33.527560 | 2026-04-29 20:49:33.527640 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-29 20:49:33.573239 | debian-trixie | skipping: Conditional result was False 2026-04-29 20:49:33.582311 | 2026-04-29 20:49:33.582480 | TASK [fetch-output : Set log path for single node] 2026-04-29 20:49:33.626041 | debian-trixie | ok 2026-04-29 20:49:33.632447 | 2026-04-29 20:49:33.632562 | LOOP [fetch-output : Ensure local output dirs] 2026-04-29 20:49:34.067080 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/logs" 2026-04-29 20:49:34.285294 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/artifacts" 2026-04-29 20:49:34.497951 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/14fb524d7dd24fd0a23eb8348ad3a978/work/docs" 2026-04-29 20:49:34.511509 | 2026-04-29 20:49:34.511578 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 20:49:35.255889 | debian-trixie | changed: .d..t...... ./ 2026-04-29 20:49:35.256119 | debian-trixie | changed: All items complete 2026-04-29 20:49:35.256148 | 2026-04-29 20:49:35.781816 | debian-trixie | changed: .d..t...... ./ 2026-04-29 20:49:36.293195 | debian-trixie | changed: .d..t...... ./ 2026-04-29 20:49:36.316213 | 2026-04-29 20:49:36.316391 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 20:49:36.774562 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.008759 2026-04-29 20:49:37.206934 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.009140 2026-04-29 20:49:37.224202 | 2026-04-29 20:49:37.224359 | PLAY [all] 2026-04-29 20:49:37.230487 | 2026-04-29 20:49:37.230637 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 20:49:37.713386 | debian-trixie | changed 2026-04-29 20:49:37.719467 | 2026-04-29 20:49:37.719529 | PLAY RECAP 2026-04-29 20:49:37.719578 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-29 20:49:37.719600 | 2026-04-29 20:49:37.875783 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 20:49:37.877407 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 20:49:38.516611 | 2026-04-29 20:49:38.516747 | PLAY [localhost] 2026-04-29 20:49:38.527500 | 2026-04-29 20:49:38.527574 | TASK [Generate Zuul manifest] 2026-04-29 20:49:38.550813 | localhost | ok 2026-04-29 20:49:38.569372 | 2026-04-29 20:49:38.569460 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 20:49:38.993568 | localhost | changed 2026-04-29 20:49:39.008763 | 2026-04-29 20:49:39.009040 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 20:49:39.040159 | localhost | ok 2026-04-29 20:49:39.052430 | 2026-04-29 20:49:39.052587 | TASK [Upload logs] 2026-04-29 20:49:39.074264 | localhost | ok 2026-04-29 20:49:39.158670 | 2026-04-29 20:49:39.158851 | TASK [Set zuul-log-path fact] 2026-04-29 20:49:39.179442 | localhost | ok 2026-04-29 20:49:39.193955 | 2026-04-29 20:49:39.194023 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 20:49:39.227950 | localhost | ok 2026-04-29 20:49:39.237522 | 2026-04-29 20:49:39.237612 | TASK [upload-logs : Create log directories] 2026-04-29 20:49:39.660561 | localhost | changed 2026-04-29 20:49:39.666770 | 2026-04-29 20:49:39.670186 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 20:49:40.784581 | localhost -> localhost | ok: Runtime: 0:00:00.005775 2026-04-29 20:49:40.789848 | 2026-04-29 20:49:40.789920 | TASK [upload-logs : Upload logs to log server] 2026-04-29 20:49:41.285624 | localhost | Output suppressed because no_log was given 2026-04-29 20:49:41.291066 | 2026-04-29 20:49:41.291154 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 20:49:41.341253 | localhost | skipping: Conditional result was False 2026-04-29 20:49:41.348381 | localhost | skipping: Conditional result was False 2026-04-29 20:49:41.365750 | 2026-04-29 20:49:41.365903 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 20:49:41.410609 | localhost | skipping: Conditional result was False 2026-04-29 20:49:41.410954 | 2026-04-29 20:49:41.415244 | localhost | skipping: Conditional result was False 2026-04-29 20:49:41.428648 | 2026-04-29 20:49:41.428744 | LOOP [upload-logs : Upload console log and json output]