2026-04-17 00:58:22.356638 | Job console starting 2026-04-17 00:58:22.364838 | Updating git repos 2026-04-17 00:58:22.405997 | Cloning repos into workspace 2026-04-17 00:58:22.464712 | Restoring repo states 2026-04-17 00:58:22.473490 | Merging changes 2026-04-17 00:58:22.729477 | Checking out repos 2026-04-17 00:58:22.844952 | Preparing playbooks 2026-04-17 00:58:24.051181 | Running Ansible setup 2026-04-17 00:58:27.895035 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 00:58:28.516232 | 2026-04-17 00:58:28.761887 | PLAY [localhost] 2026-04-17 00:58:28.782260 | 2026-04-17 00:58:28.782489 | TASK [Gathering Facts] 2026-04-17 00:58:29.937722 | localhost | ok 2026-04-17 00:58:29.944419 | 2026-04-17 00:58:29.944494 | TASK [Setup log path fact] 2026-04-17 00:58:29.965201 | localhost | ok 2026-04-17 00:58:29.978240 | 2026-04-17 00:58:29.978391 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 00:58:30.009979 | localhost | ok 2026-04-17 00:58:30.016265 | 2026-04-17 00:58:30.017535 | TASK [emit-job-header : Print job information] 2026-04-17 00:58:30.050366 | # Job Information 2026-04-17 00:58:30.050563 | Ansible Version: 2.16.16 2026-04-17 00:58:30.050608 | Job: ansible-collection-containers-molecule-docker-debian-trixie 2026-04-17 00:58:30.050634 | Pipeline: check 2026-04-17 00:58:30.050657 | Executor: 0a8996d2b663 2026-04-17 00:58:30.050678 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109 2026-04-17 00:58:30.050701 | Event ID: 64e04cd0-39f8-11f1-9088-4230c452b1b4 2026-04-17 00:58:30.053781 | 2026-04-17 00:58:30.053854 | LOOP [emit-job-header : Print node information] 2026-04-17 00:58:30.170774 | localhost | ok: 2026-04-17 00:58:30.170969 | localhost | # Node Information 2026-04-17 00:58:30.170998 | localhost | Inventory Hostname: debian-trixie 2026-04-17 00:58:30.171020 | localhost | Hostname: np0000166924 2026-04-17 00:58:30.171041 | localhost | Username: zuul 2026-04-17 00:58:30.171064 | localhost | Distro: Debian 13.4 2026-04-17 00:58:30.171083 | localhost | Provider: yul1 2026-04-17 00:58:30.171102 | localhost | Region: ca-ymq-1 2026-04-17 00:58:30.171121 | localhost | Label: debian-trixie 2026-04-17 00:58:30.171140 | localhost | Product Name: OpenStack Nova 2026-04-17 00:58:30.171158 | localhost | Interface IP: 199.204.45.210 2026-04-17 00:58:30.180726 | 2026-04-17 00:58:30.180873 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-17 00:58:30.581639 | localhost -> localhost | changed 2026-04-17 00:58:30.588192 | 2026-04-17 00:58:30.588314 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-17 00:58:31.685953 | localhost -> localhost | changed 2026-04-17 00:58:31.693205 | 2026-04-17 00:58:31.693272 | PLAY [all] 2026-04-17 00:58:31.701434 | 2026-04-17 00:58:31.701520 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-17 00:58:31.971207 | debian-trixie -> localhost | ok 2026-04-17 00:58:31.987798 | 2026-04-17 00:58:31.988535 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-17 00:58:32.026195 | debian-trixie | ok 2026-04-17 00:58:32.051644 | debian-trixie | included: /var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-17 00:58:32.057725 | 2026-04-17 00:58:32.057936 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-17 00:58:33.130691 | debian-trixie -> localhost | Generating public/private rsa key pair. 2026-04-17 00:58:33.130868 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/8b3f1091a9134b86b98451b7c54a7894_id_rsa 2026-04-17 00:58:33.130904 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/8b3f1091a9134b86b98451b7c54a7894_id_rsa.pub 2026-04-17 00:58:33.130927 | debian-trixie -> localhost | The key fingerprint is: 2026-04-17 00:58:33.130949 | debian-trixie -> localhost | SHA256:p4ENg0dOP9HrnL/h9hv3k1gGRo3dTuI11F9+l2SYDNI zuul-build-sshkey 2026-04-17 00:58:33.130984 | debian-trixie -> localhost | The key's randomart image is: 2026-04-17 00:58:33.131006 | debian-trixie -> localhost | +---[RSA 3072]----+ 2026-04-17 00:58:33.131031 | debian-trixie -> localhost | | o .o..o B.o| 2026-04-17 00:58:33.131053 | debian-trixie -> localhost | | = . .oE *.**| 2026-04-17 00:58:33.131075 | debian-trixie -> localhost | | . = o ...o*=| 2026-04-17 00:58:33.131096 | debian-trixie -> localhost | | . = .. o..*| 2026-04-17 00:58:33.131117 | debian-trixie -> localhost | | . So... . o| 2026-04-17 00:58:33.131138 | debian-trixie -> localhost | | ++ o | 2026-04-17 00:58:33.131158 | debian-trixie -> localhost | | . .. = o| 2026-04-17 00:58:33.131179 | debian-trixie -> localhost | | .oo =.| 2026-04-17 00:58:33.131203 | debian-trixie -> localhost | | .ooo.o| 2026-04-17 00:58:33.131223 | debian-trixie -> localhost | +----[SHA256]-----+ 2026-04-17 00:58:33.131273 | debian-trixie -> localhost | ok: Runtime: 0:00:00.671203 2026-04-17 00:58:33.135720 | 2026-04-17 00:58:33.135790 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-17 00:58:33.167393 | debian-trixie | ok 2026-04-17 00:58:33.178215 | debian-trixie | included: /var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-17 00:58:33.185193 | 2026-04-17 00:58:33.185260 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-17 00:58:33.210677 | debian-trixie | skipping: Conditional result was False 2026-04-17 00:58:33.217753 | 2026-04-17 00:58:33.217843 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-17 00:58:33.827784 | debian-trixie | changed 2026-04-17 00:58:33.832807 | 2026-04-17 00:58:33.832886 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-17 00:58:34.038885 | debian-trixie | ok 2026-04-17 00:58:34.043446 | 2026-04-17 00:58:34.043516 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-17 00:58:34.610801 | debian-trixie | changed 2026-04-17 00:58:34.615032 | 2026-04-17 00:58:34.615096 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-17 00:58:35.174723 | debian-trixie | changed 2026-04-17 00:58:35.188294 | 2026-04-17 00:58:35.188896 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-17 00:58:35.214796 | debian-trixie | skipping: Conditional result was False 2026-04-17 00:58:35.220115 | 2026-04-17 00:58:35.220200 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-17 00:58:35.586770 | debian-trixie -> localhost | changed 2026-04-17 00:58:35.598262 | 2026-04-17 00:58:35.598330 | TASK [add-build-sshkey : Add back temp key] 2026-04-17 00:58:36.002870 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/8b3f1091a9134b86b98451b7c54a7894_id_rsa (zuul-build-sshkey) 2026-04-17 00:58:36.003143 | debian-trixie -> localhost | ok: Runtime: 0:00:00.014830 2026-04-17 00:58:36.007413 | 2026-04-17 00:58:36.007477 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-17 00:58:36.368224 | debian-trixie | ok 2026-04-17 00:58:36.373800 | 2026-04-17 00:58:36.373900 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-17 00:58:36.399289 | debian-trixie | skipping: Conditional result was False 2026-04-17 00:58:36.408808 | 2026-04-17 00:58:36.408920 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-17 00:58:36.775115 | debian-trixie | ok 2026-04-17 00:58:36.788399 | 2026-04-17 00:58:36.788529 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-17 00:58:37.697658 | debian-trixie | Output suppressed because no_log was given 2026-04-17 00:58:37.931836 | 2026-04-17 00:58:37.931982 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-17 00:58:38.162522 | debian-trixie | ok: "logs" 2026-04-17 00:58:38.162837 | debian-trixie | ok: All items complete 2026-04-17 00:58:38.162875 | 2026-04-17 00:58:38.354751 | debian-trixie | ok: "artifacts" 2026-04-17 00:58:38.545436 | debian-trixie | ok: "docs" 2026-04-17 00:58:38.694966 | 2026-04-17 00:58:38.695126 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-17 00:58:38.918548 | debian-trixie | changed: "logs" 2026-04-17 00:58:39.115115 | debian-trixie | changed: "artifacts" 2026-04-17 00:58:39.295758 | debian-trixie | changed: "docs" 2026-04-17 00:58:39.306949 | 2026-04-17 00:58:39.307159 | PLAY RECAP 2026-04-17 00:58:39.307239 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-17 00:58:39.307290 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 00:58:39.307327 | 2026-04-17 00:58:39.464663 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 00:58:39.697971 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 00:58:40.350287 | 2026-04-17 00:58:40.350656 | PLAY [all] 2026-04-17 00:58:40.368096 | 2026-04-17 00:58:40.368375 | TASK [setup-uv : Extract archive] 2026-04-17 00:58:42.842651 | debian-trixie | changed 2026-04-17 00:58:42.850432 | 2026-04-17 00:58:42.850548 | TASK [setup-uv : Print version] 2026-04-17 00:58:43.301943 | debian-trixie | uv 0.8.13 2026-04-17 00:58:43.383324 | debian-trixie | ok: Runtime: 0:00:00.014387 2026-04-17 00:58:43.388643 | 2026-04-17 00:58:43.388701 | PLAY RECAP 2026-04-17 00:58:43.388750 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 00:58:43.388773 | 2026-04-17 00:58:43.546541 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 00:58:43.548208 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-17 00:58:44.098218 | 2026-04-17 00:58:44.098422 | PLAY [all] 2026-04-17 00:58:44.109778 | 2026-04-17 00:58:44.109869 | TASK [Copy inventory file for Zuul] 2026-04-17 00:58:45.109991 | debian-trixie | changed 2026-04-17 00:58:45.114671 | 2026-04-17 00:58:45.114755 | TASK [Switch "ansible_host" to private IP] 2026-04-17 00:58:45.417485 | debian-trixie | changed: 1 replacements made 2026-04-17 00:58:45.739211 | 2026-04-17 00:58:45.739339 | TASK [Run Molecule scenario] 2026-04-17 00:58:46.207884 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-17 00:58:46.208002 | debian-trixie | Creating virtual environment at: .venv 2026-04-17 00:58:46.474632 | debian-trixie | Downloading pygments (1.2MiB) 2026-04-17 00:58:46.476022 | debian-trixie | Downloading cryptography (4.3MiB) 2026-04-17 00:58:46.480008 | debian-trixie | Downloading ansible-core (2.3MiB) 2026-04-17 00:58:46.633724 | debian-trixie | Downloading cryptography 2026-04-17 00:58:46.691595 | debian-trixie | Downloading pygments 2026-04-17 00:58:46.902758 | debian-trixie | Downloading ansible-core 2026-04-17 00:58:46.954580 | debian-trixie | Installed 36 packages in 51ms 2026-04-17 00:58:47.615487 | debian-trixie | INFO Collection 'vexxhost.containers' detected. 2026-04-17 00:58:47.615571 | debian-trixie | INFO Scenarios will be used from 'extensions/molecule' 2026-04-17 00:58:48.538365 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-17 00:58:48.538436 | debian-trixie | INFO default scenario not found, disabling shared state. 2026-04-17 00:58:48.538598 | debian-trixie | INFO [docker > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-17 00:58:48.538623 | debian-trixie | INFO [docker > prerun] Performing prerun with role_name_check=0... 2026-04-17 00:58:56.675115 | debian-trixie | INFO [docker > dependency] Executing 2026-04-17 00:58:56.675192 | debian-trixie | WARNING [docker > dependency] Missing roles requirements file: requirements.yml 2026-04-17 00:58:56.675488 | debian-trixie | WARNING [docker > dependency] Missing collections requirements file: collections.yml 2026-04-17 00:58:56.675660 | debian-trixie | WARNING [docker > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-17 00:58:56.681689 | debian-trixie | INFO [docker > cleanup] Executing 2026-04-17 00:58:56.681967 | debian-trixie | WARNING [docker > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 00:58:56.687316 | debian-trixie | INFO [docker > destroy] Executing 2026-04-17 00:58:56.687344 | debian-trixie | WARNING [docker > destroy] Skipping, '--destroy=never' requested. 2026-04-17 00:58:56.687440 | debian-trixie | INFO [docker > destroy] Executed: Successful 2026-04-17 00:58:56.692904 | debian-trixie | INFO [docker > syntax] Executing 2026-04-17 00:58:57.198529 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-17 00:58:57.198597 | 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-17 00:58:57.198735 | 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-17 00:58:57.198834 | debian-trixie | 2026-04-17 00:58:57.624712 | debian-trixie | 2026-04-17 00:58:57.624833 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml 2026-04-17 00:58:57.700166 | debian-trixie | INFO [docker > syntax] Executed: Successful 2026-04-17 00:58:57.709727 | debian-trixie | INFO [docker > create] Executing 2026-04-17 00:58:57.711811 | debian-trixie | WARNING [docker > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 00:58:57.719505 | debian-trixie | INFO [docker > prepare] Executing 2026-04-17 00:58:58.199726 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-17 00:58:58.199918 | 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-17 00:58:58.200123 | 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-17 00:58:58.200350 | debian-trixie | 2026-04-17 00:58:58.545858 | debian-trixie | 2026-04-17 00:58:58.546016 | debian-trixie | PLAY [Prepare] ***************************************************************** 2026-04-17 00:58:58.546182 | debian-trixie | 2026-04-17 00:58:58.546375 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-17 00:58:58.546567 | debian-trixie | Friday 17 April 2026 00:58:58 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-04-17 00:58:59.887160 | 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-17 00:58:59.889177 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:58:59.889376 | debian-trixie | 2026-04-17 00:58:59.889585 | debian-trixie | TASK [Update "apt" cache] ****************************************************** 2026-04-17 00:58:59.889766 | debian-trixie | Friday 17 April 2026 00:58:59 +0000 (0:00:01.343) 0:00:01.371 ********** 2026-04-17 00:59:04.996031 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:59:04.996097 | debian-trixie | 2026-04-17 00:59:04.996260 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-17 00:59:04.996475 | debian-trixie | debian-trixie : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-17 00:59:04.996597 | debian-trixie | 2026-04-17 00:59:04.996709 | debian-trixie | 2026-04-17 00:59:04.996828 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-17 00:59:04.996947 | debian-trixie | Friday 17 April 2026 00:59:04 +0000 (0:00:05.107) 0:00:06.479 ********** 2026-04-17 00:59:04.997063 | debian-trixie | =============================================================================== 2026-04-17 00:59:04.997179 | debian-trixie | Update "apt" cache ------------------------------------------------------ 5.11s 2026-04-17 00:59:04.997296 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.34s 2026-04-17 00:59:05.110877 | debian-trixie | INFO [docker > prepare] Executed: Successful 2026-04-17 00:59:05.121813 | debian-trixie | INFO [docker > converge] Executing 2026-04-17 00:59:05.692564 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-17 00:59:05.692645 | 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-17 00:59:05.692656 | 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-17 00:59:05.692664 | debian-trixie | 2026-04-17 00:59:06.143595 | debian-trixie | 2026-04-17 00:59:06.143650 | debian-trixie | PLAY [Converge] **************************************************************** 2026-04-17 00:59:06.143760 | debian-trixie | 2026-04-17 00:59:06.143944 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-17 00:59:06.144130 | debian-trixie | Friday 17 April 2026 00:59:06 +0000 (0:00:00.017) 0:00:00.017 ********** 2026-04-17 00:59:07.286392 | 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-17 00:59:07.289674 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:59:07.289853 | debian-trixie | 2026-04-17 00:59:07.290056 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 00:59:07.290262 | debian-trixie | Friday 17 April 2026 00:59:07 +0000 (0:00:01.154) 0:00:01.172 ********** 2026-04-17 00:59:07.804697 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:59:07.804772 | debian-trixie | 2026-04-17 00:59:07.804782 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 00:59:07.804879 | debian-trixie | Friday 17 April 2026 00:59:07 +0000 (0:00:00.512) 0:00:01.684 ********** 2026-04-17 00:59:07.844172 | debian-trixie | skipping: [debian-trixie] 2026-04-17 00:59:07.844224 | debian-trixie | 2026-04-17 00:59:07.844431 | debian-trixie | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-17 00:59:07.844547 | debian-trixie | Friday 17 April 2026 00:59:07 +0000 (0:00:00.041) 0:00:01.726 ********** 2026-04-17 00:59:08.302523 | debian-trixie | changed: [debian-trixie] 2026-04-17 00:59:08.302578 | debian-trixie | 2026-04-17 00:59:08.302588 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 00:59:08.302665 | debian-trixie | Friday 17 April 2026 00:59:08 +0000 (0:00:00.457) 0:00:02.184 ********** 2026-04-17 00:59:08.418242 | debian-trixie | ok: [debian-trixie] => { 2026-04-17 00:59:08.418286 | debian-trixie | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-17 00:59:08.418291 | debian-trixie | } 2026-04-17 00:59:08.418295 | debian-trixie | 2026-04-17 00:59:08.418299 | debian-trixie | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 00:59:08.418303 | debian-trixie | Friday 17 April 2026 00:59:08 +0000 (0:00:00.110) 0:00:02.294 ********** 2026-04-17 00:59:09.431847 | 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-17 00:59:09.438531 | debian-trixie | changed: [debian-trixie] 2026-04-17 00:59:09.438717 | debian-trixie | 2026-04-17 00:59:09.438926 | debian-trixie | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 00:59:09.439122 | debian-trixie | Friday 17 April 2026 00:59:09 +0000 (0:00:01.026) 0:00:03.321 ********** 2026-04-17 00:59:09.474668 | debian-trixie | skipping: [debian-trixie] 2026-04-17 00:59:09.474822 | debian-trixie | 2026-04-17 00:59:09.475034 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 00:59:09.475220 | debian-trixie | Friday 17 April 2026 00:59:09 +0000 (0:00:00.036) 0:00:03.357 ********** 2026-04-17 00:59:09.516724 | debian-trixie | skipping: [debian-trixie] 2026-04-17 00:59:09.516807 | debian-trixie | 2026-04-17 00:59:09.517006 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 00:59:09.517196 | debian-trixie | Friday 17 April 2026 00:59:09 +0000 (0:00:00.041) 0:00:03.399 ********** 2026-04-17 00:59:09.841226 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:59:09.841389 | debian-trixie | 2026-04-17 00:59:09.841629 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 00:59:09.841830 | debian-trixie | Friday 17 April 2026 00:59:09 +0000 (0:00:00.323) 0:00:03.723 ********** 2026-04-17 00:59:11.053068 | debian-trixie | ok: [debian-trixie] 2026-04-17 00:59:11.053161 | debian-trixie | 2026-04-17 00:59:11.053377 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 00:59:11.053568 | debian-trixie | Friday 17 April 2026 00:59:11 +0000 (0:00:01.212) 0:00:04.935 ********** 2026-04-17 00:59:11.109259 | debian-trixie | [ERROR]: Task failed: Finalization of task args for 'ansible.builtin.debug' failed: Error while resolving value for 'msg': object of type 'NoneType' has no attribute 'keys' 2026-04-17 00:59:11.109442 | debian-trixie | 2026-04-17 00:59:11.109597 | debian-trixie | Task failed. 2026-04-17 00:59:11.109841 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3 2026-04-17 00:59:11.110001 | debian-trixie | 2026-04-17 00:59:11.110190 | debian-trixie | 13 # under the License. 2026-04-17 00:59:11.110356 | debian-trixie | 14 2026-04-17 00:59:11.110541 | debian-trixie | 15 - name: Starting download of file 2026-04-17 00:59:11.110739 | debian-trixie | ^ column 3 2026-04-17 00:59:11.110888 | debian-trixie | 2026-04-17 00:59:11.111069 | debian-trixie | <<< caused by >>> 2026-04-17 00:59:11.111248 | debian-trixie | 2026-04-17 00:59:11.111423 | debian-trixie | Finalization of task args for 'ansible.builtin.debug' failed. 2026-04-17 00:59:11.111645 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3 2026-04-17 00:59:11.111790 | debian-trixie | 2026-04-17 00:59:11.111966 | debian-trixie | 14 2026-04-17 00:59:11.112154 | debian-trixie | 15 - name: Starting download of file 2026-04-17 00:59:11.112388 | debian-trixie | 16 ansible.builtin.debug: 2026-04-17 00:59:11.112569 | debian-trixie | ^ column 3 2026-04-17 00:59:11.112735 | debian-trixie | 2026-04-17 00:59:11.112953 | debian-trixie | <<< caused by >>> 2026-04-17 00:59:11.113152 | debian-trixie | 2026-04-17 00:59:11.113338 | debian-trixie | Error while resolving value for 'msg'. 2026-04-17 00:59:11.113531 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10 2026-04-17 00:59:11.113702 | debian-trixie | 2026-04-17 00:59:11.113923 | debian-trixie | 15 - name: Starting download of file 2026-04-17 00:59:11.114107 | debian-trixie | 16 ansible.builtin.debug: 2026-04-17 00:59:11.114296 | debian-trixie | 17 msg: "{{ download_artifact_url }}" 2026-04-17 00:59:11.114500 | debian-trixie | ^ column 10 2026-04-17 00:59:11.114680 | debian-trixie | 2026-04-17 00:59:11.114824 | debian-trixie | <<< caused by >>> 2026-04-17 00:59:11.114983 | debian-trixie | 2026-04-17 00:59:11.115170 | debian-trixie | object of type 'NoneType' has no attribute 'keys' 2026-04-17 00:59:11.115365 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22 2026-04-17 00:59:11.115529 | debian-trixie | 2026-04-17 00:59:11.115709 | debian-trixie | 13 # under the License. 2026-04-17 00:59:11.115889 | debian-trixie | 14 2026-04-17 00:59:11.116112 | debian-trixie | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}" 2026-04-17 00:59:11.116300 | debian-trixie | ^ column 22 2026-04-17 00:59:11.116476 | debian-trixie | 2026-04-17 00:59:11.116818 | debian-trixie | fatal: [debian-trixie]: FAILED! => {"msg": "Task failed: Finalization of task args for 'ansible.builtin.debug' failed: Error while resolving value for 'msg': object of type 'NoneType' has no attribute 'keys'"} 2026-04-17 00:59:11.116982 | debian-trixie | 2026-04-17 00:59:11.117162 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-17 00:59:11.117363 | debian-trixie | debian-trixie : ok=7 changed=2 unreachable=0 failed=1 skipped=3 rescued=0 ignored=0 2026-04-17 00:59:11.117530 | debian-trixie | 2026-04-17 00:59:11.117685 | debian-trixie | 2026-04-17 00:59:11.117954 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-17 00:59:11.118140 | debian-trixie | Friday 17 April 2026 00:59:11 +0000 (0:00:00.058) 0:00:04.994 ********** 2026-04-17 00:59:11.118237 | debian-trixie | =============================================================================== 2026-04-17 00:59:11.118352 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 1.21s 2026-04-17 00:59:11.118441 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.15s 2026-04-17 00:59:11.118521 | debian-trixie | vexxhost.containers.download_artifact : Download item ------------------- 1.03s 2026-04-17 00:59:11.118605 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-04-17 00:59:11.118692 | debian-trixie | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-04-17 00:59:11.118776 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.32s 2026-04-17 00:59:11.118861 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.11s 2026-04-17 00:59:11.118946 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-04-17 00:59:11.119031 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-17 00:59:11.119115 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-17 00:59:11.119199 | debian-trixie | vexxhost.containers.download_artifact : Extract archive ----------------- 0.04s 2026-04-17 00:59:11.242248 | debian-trixie | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.docker/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml 2026-04-17 00:59:11.242328 | debian-trixie | ERROR [docker > converge] Executed: Failed 2026-04-17 00:59:11.242470 | debian-trixie | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.docker/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-containers/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml 2026-04-17 00:59:11.834104 | debian-trixie | ERROR 2026-04-17 00:59:12.251843 | debian-trixie | { 2026-04-17 00:59:12.251963 | debian-trixie | "delta": "0:00:25.202775", 2026-04-17 00:59:12.252018 | debian-trixie | "end": "2026-04-17 00:59:11.338032", 2026-04-17 00:59:12.252138 | debian-trixie | "msg": "non-zero return code", 2026-04-17 00:59:12.252195 | debian-trixie | "rc": 2, 2026-04-17 00:59:12.252246 | debian-trixie | "start": "2026-04-17 00:58:46.135257" 2026-04-17 00:59:12.252288 | debian-trixie | } failure 2026-04-17 00:59:12.257751 | 2026-04-17 00:59:12.257843 | PLAY RECAP 2026-04-17 00:59:12.257931 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-17 00:59:12.257977 | 2026-04-17 00:59:12.382786 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-17 00:59:12.384164 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 00:59:13.009948 | 2026-04-17 00:59:13.010128 | PLAY [all] 2026-04-17 00:59:13.022893 | 2026-04-17 00:59:13.023090 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-17 00:59:13.069037 | debian-trixie | skipping: Conditional result was False 2026-04-17 00:59:13.076356 | 2026-04-17 00:59:13.076524 | TASK [fetch-output : Set log path for single node] 2026-04-17 00:59:13.120858 | debian-trixie | ok 2026-04-17 00:59:13.128251 | 2026-04-17 00:59:13.128327 | LOOP [fetch-output : Ensure local output dirs] 2026-04-17 00:59:13.558090 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/logs" 2026-04-17 00:59:13.791462 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/artifacts" 2026-04-17 00:59:14.033574 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/8b3f1091a9134b86b98451b7c54a7894/work/docs" 2026-04-17 00:59:14.050245 | 2026-04-17 00:59:14.050434 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-17 00:59:14.754218 | debian-trixie | ok 2026-04-17 00:59:14.754494 | debian-trixie | changed: All items complete 2026-04-17 00:59:14.754532 | 2026-04-17 00:59:15.313574 | debian-trixie | changed: .d..t...... ./ 2026-04-17 00:59:15.867383 | debian-trixie | changed: .d..t...... ./ 2026-04-17 00:59:15.894302 | 2026-04-17 00:59:15.894425 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-17 00:59:16.323685 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.007472 2026-04-17 00:59:16.543295 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.007204 2026-04-17 00:59:16.565085 | 2026-04-17 00:59:16.565209 | PLAY [all] 2026-04-17 00:59:16.571430 | 2026-04-17 00:59:16.571528 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-17 00:59:17.072831 | debian-trixie | changed 2026-04-17 00:59:17.078015 | 2026-04-17 00:59:17.078073 | PLAY RECAP 2026-04-17 00:59:17.078123 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-17 00:59:17.078146 | 2026-04-17 00:59:17.224378 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 00:59:17.226059 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-17 00:59:17.856016 | 2026-04-17 00:59:17.856245 | PLAY [localhost] 2026-04-17 00:59:17.868004 | 2026-04-17 00:59:17.868087 | TASK [Generate Zuul manifest] 2026-04-17 00:59:17.890817 | localhost | ok 2026-04-17 00:59:17.915365 | 2026-04-17 00:59:18.504437 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-17 00:59:18.843042 | localhost | changed 2026-04-17 00:59:18.855884 | 2026-04-17 00:59:18.855997 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-17 00:59:18.937739 | localhost | ok 2026-04-17 00:59:18.947584 | 2026-04-17 00:59:18.947657 | TASK [Upload logs] 2026-04-17 00:59:18.970578 | localhost | ok 2026-04-17 00:59:19.033701 | 2026-04-17 00:59:19.033851 | TASK [Set zuul-log-path fact] 2026-04-17 00:59:19.055184 | localhost | ok 2026-04-17 00:59:19.070006 | 2026-04-17 00:59:19.070098 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 00:59:19.102480 | localhost | ok 2026-04-17 00:59:19.111989 | 2026-04-17 00:59:19.112084 | TASK [upload-logs : Create log directories] 2026-04-17 00:59:19.612549 | localhost | changed 2026-04-17 00:59:19.619277 | 2026-04-17 00:59:19.619381 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-17 00:59:20.615111 | localhost -> localhost | ok: Runtime: 0:00:00.566767 2026-04-17 00:59:20.621710 | 2026-04-17 00:59:20.621799 | TASK [upload-logs : Upload logs to log server] 2026-04-17 00:59:21.107778 | localhost | Output suppressed because no_log was given 2026-04-17 00:59:21.115279 | 2026-04-17 00:59:21.115360 | LOOP [upload-logs : Compress console log and json output] 2026-04-17 00:59:21.165576 | localhost | skipping: Conditional result was False 2026-04-17 00:59:21.172310 | localhost | skipping: Conditional result was False 2026-04-17 00:59:21.190038 | 2026-04-17 00:59:21.190184 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-17 00:59:21.231058 | localhost | skipping: Conditional result was False 2026-04-17 00:59:21.231540 | 2026-04-17 00:59:21.235143 | localhost | skipping: Conditional result was False 2026-04-17 00:59:21.248199 | 2026-04-17 00:59:21.248341 | LOOP [upload-logs : Upload console log and json output]