2026-04-15 01:00:45.784921 | Job console starting 2026-04-15 01:00:45.816181 | Updating git repos 2026-04-15 01:00:45.838738 | Cloning repos into workspace 2026-04-15 01:00:45.909798 | Restoring repo states 2026-04-15 01:00:45.917989 | Merging changes 2026-04-15 01:00:46.158671 | Checking out repos 2026-04-15 01:00:46.184274 | Preparing playbooks 2026-04-15 01:00:47.608595 | Running Ansible setup 2026-04-15 01:00:52.532222 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:00:53.221183 | 2026-04-15 01:00:53.221304 | PLAY [localhost] 2026-04-15 01:00:53.228741 | 2026-04-15 01:00:53.228818 | TASK [Gathering Facts] 2026-04-15 01:00:54.157565 | localhost | ok 2026-04-15 01:00:54.164140 | 2026-04-15 01:00:54.164222 | TASK [Setup log path fact] 2026-04-15 01:00:54.187380 | localhost | ok 2026-04-15 01:00:54.198907 | 2026-04-15 01:00:54.198988 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:00:54.229681 | localhost | ok 2026-04-15 01:00:54.236502 | 2026-04-15 01:00:54.236567 | TASK [emit-job-header : Print job information] 2026-04-15 01:00:54.276251 | # Job Information 2026-04-15 01:00:54.276497 | Ansible Version: 2.16.16 2026-04-15 01:00:54.276578 | Job: ansible-collection-containers-molecule-nerdctl-debian-trixie 2026-04-15 01:00:54.276629 | Pipeline: check 2026-04-15 01:00:54.276674 | Executor: 0a8996d2b663 2026-04-15 01:00:54.276718 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109 2026-04-15 01:00:54.276768 | Event ID: 276b5040-3866-11f1-87ec-4c6fd3e486d6 2026-04-15 01:00:54.281981 | 2026-04-15 01:00:54.282042 | LOOP [emit-job-header : Print node information] 2026-04-15 01:00:54.365716 | localhost | ok: 2026-04-15 01:00:54.365870 | localhost | # Node Information 2026-04-15 01:00:54.365898 | localhost | Inventory Hostname: debian-trixie 2026-04-15 01:00:54.365923 | localhost | Hostname: np0000166331 2026-04-15 01:00:54.365943 | localhost | Username: zuul 2026-04-15 01:00:54.365965 | localhost | Distro: Debian 13.4 2026-04-15 01:00:54.365984 | localhost | Provider: yul1 2026-04-15 01:00:54.366002 | localhost | Region: ca-ymq-1 2026-04-15 01:00:54.366020 | localhost | Label: debian-trixie 2026-04-15 01:00:54.366038 | localhost | Product Name: OpenStack Nova 2026-04-15 01:00:54.366056 | localhost | Interface IP: 199.19.213.215 2026-04-15 01:00:54.374344 | 2026-04-15 01:00:54.374417 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-15 01:00:54.796352 | localhost -> localhost | changed 2026-04-15 01:00:54.805715 | 2026-04-15 01:00:54.805894 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-15 01:00:55.682965 | localhost -> localhost | changed 2026-04-15 01:00:55.691913 | 2026-04-15 01:00:55.691977 | PLAY [all] 2026-04-15 01:00:55.700703 | 2026-04-15 01:00:55.700828 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-15 01:00:55.950371 | debian-trixie -> localhost | ok 2026-04-15 01:00:55.957274 | 2026-04-15 01:00:55.957367 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-15 01:00:55.990592 | debian-trixie | ok 2026-04-15 01:00:56.004479 | debian-trixie | included: /var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-15 01:00:56.011883 | 2026-04-15 01:00:56.011972 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-15 01:00:57.276305 | debian-trixie -> localhost | Generating public/private rsa key pair. 2026-04-15 01:00:57.276561 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/39768b8b70d0407e8cee5414c809b1eb_id_rsa 2026-04-15 01:00:57.276591 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/39768b8b70d0407e8cee5414c809b1eb_id_rsa.pub 2026-04-15 01:00:57.276614 | debian-trixie -> localhost | The key fingerprint is: 2026-04-15 01:00:57.276635 | debian-trixie -> localhost | SHA256:Mux8XVThWupbeZETvY/TWYJZPxjN91Hqt3qUC/vPI0Q zuul-build-sshkey 2026-04-15 01:00:57.276667 | debian-trixie -> localhost | The key's randomart image is: 2026-04-15 01:00:57.276689 | debian-trixie -> localhost | +---[RSA 3072]----+ 2026-04-15 01:00:57.276716 | debian-trixie -> localhost | | o..| 2026-04-15 01:00:57.276737 | debian-trixie -> localhost | | oo.o| 2026-04-15 01:00:57.276757 | debian-trixie -> localhost | | ..==o| 2026-04-15 01:00:57.276776 | debian-trixie -> localhost | | . . Eo.B| 2026-04-15 01:00:57.276796 | debian-trixie -> localhost | | + S B.o**| 2026-04-15 01:00:57.276816 | debian-trixie -> localhost | | o o . o o OO| 2026-04-15 01:00:57.276836 | debian-trixie -> localhost | | o . . o Oo=| 2026-04-15 01:00:57.276855 | debian-trixie -> localhost | | . =.B | 2026-04-15 01:00:57.276878 | debian-trixie -> localhost | | ..+.=| 2026-04-15 01:00:57.276898 | debian-trixie -> localhost | +----[SHA256]-----+ 2026-04-15 01:00:57.276945 | debian-trixie -> localhost | ok: Runtime: 0:00:00.868353 2026-04-15 01:00:57.281480 | 2026-04-15 01:00:57.281553 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-15 01:00:57.311943 | debian-trixie | ok 2026-04-15 01:00:57.327744 | debian-trixie | included: /var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-15 01:00:57.337228 | 2026-04-15 01:00:57.337290 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-15 01:00:57.361553 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:00:57.369990 | 2026-04-15 01:00:57.370078 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-15 01:00:57.895151 | debian-trixie | changed 2026-04-15 01:00:57.903228 | 2026-04-15 01:00:57.903292 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-15 01:00:58.115100 | debian-trixie | ok 2026-04-15 01:00:58.119269 | 2026-04-15 01:00:58.119331 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-15 01:00:58.674355 | debian-trixie | changed 2026-04-15 01:00:58.680344 | 2026-04-15 01:00:58.680408 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-15 01:00:59.249672 | debian-trixie | changed 2026-04-15 01:00:59.256872 | 2026-04-15 01:00:59.257017 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-15 01:00:59.274734 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:00:59.281713 | 2026-04-15 01:00:59.281806 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-15 01:00:59.701809 | debian-trixie -> localhost | changed 2026-04-15 01:00:59.714185 | 2026-04-15 01:00:59.714263 | TASK [add-build-sshkey : Add back temp key] 2026-04-15 01:00:59.981630 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/39768b8b70d0407e8cee5414c809b1eb_id_rsa (zuul-build-sshkey) 2026-04-15 01:00:59.981899 | debian-trixie -> localhost | ok: Runtime: 0:00:00.012148 2026-04-15 01:00:59.986964 | 2026-04-15 01:00:59.987030 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-15 01:01:00.325954 | debian-trixie | ok 2026-04-15 01:01:00.330026 | 2026-04-15 01:01:00.330093 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-15 01:01:00.355681 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:01:00.368423 | 2026-04-15 01:01:00.368509 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-15 01:01:00.723493 | debian-trixie | ok 2026-04-15 01:01:00.728827 | 2026-04-15 01:01:00.728900 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-15 01:01:01.618407 | debian-trixie | Output suppressed because no_log was given 2026-04-15 01:01:01.624843 | 2026-04-15 01:01:01.624916 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-15 01:01:01.853515 | debian-trixie | ok: "logs" 2026-04-15 01:01:01.853739 | debian-trixie | ok: All items complete 2026-04-15 01:01:01.853769 | 2026-04-15 01:01:02.042443 | debian-trixie | ok: "artifacts" 2026-04-15 01:01:02.228432 | debian-trixie | ok: "docs" 2026-04-15 01:01:02.242952 | 2026-04-15 01:01:02.243128 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-15 01:01:02.466312 | debian-trixie | changed: "logs" 2026-04-15 01:01:02.663221 | debian-trixie | changed: "artifacts" 2026-04-15 01:01:02.845571 | debian-trixie | changed: "docs" 2026-04-15 01:01:02.858412 | 2026-04-15 01:01:02.858547 | PLAY RECAP 2026-04-15 01:01:02.858609 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-15 01:01:02.858652 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:01:02.858683 | 2026-04-15 01:01:02.988147 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:01:02.989288 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:01:03.628239 | 2026-04-15 01:01:03.628430 | PLAY [all] 2026-04-15 01:01:03.640245 | 2026-04-15 01:01:03.640323 | TASK [setup-uv : Extract archive] 2026-04-15 01:01:06.101370 | debian-trixie | changed 2026-04-15 01:01:06.106692 | 2026-04-15 01:01:06.106776 | TASK [setup-uv : Print version] 2026-04-15 01:01:06.486243 | debian-trixie | uv 0.8.13 2026-04-15 01:01:06.651452 | debian-trixie | ok: Runtime: 0:00:00.012760 2026-04-15 01:01:06.657874 | 2026-04-15 01:01:06.657939 | PLAY RECAP 2026-04-15 01:01:06.657997 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:01:06.658031 | 2026-04-15 01:01:06.750329 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:01:06.751587 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:01:07.286797 | 2026-04-15 01:01:07.286906 | PLAY [all] 2026-04-15 01:01:07.296284 | 2026-04-15 01:01:07.296356 | TASK [Copy inventory file for Zuul] 2026-04-15 01:01:08.309969 | debian-trixie | changed 2026-04-15 01:01:08.314564 | 2026-04-15 01:01:08.314639 | TASK [Switch "ansible_host" to private IP] 2026-04-15 01:01:08.619120 | debian-trixie | changed: 1 replacements made 2026-04-15 01:01:08.626253 | 2026-04-15 01:01:08.626396 | TASK [Run Molecule scenario] 2026-04-15 01:01:09.102106 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-15 01:01:09.102216 | debian-trixie | Creating virtual environment at: .venv 2026-04-15 01:01:09.885738 | debian-trixie | Downloading pygments (1.2MiB) 2026-04-15 01:01:09.885790 | debian-trixie | Downloading ansible-core (2.3MiB) 2026-04-15 01:01:09.889149 | debian-trixie | Downloading cryptography (4.3MiB) 2026-04-15 01:01:10.212135 | debian-trixie | Downloading pygments 2026-04-15 01:01:10.219893 | debian-trixie | Downloading cryptography 2026-04-15 01:01:10.379586 | debian-trixie | Downloading ansible-core 2026-04-15 01:01:10.426047 | debian-trixie | Installed 36 packages in 45ms 2026-04-15 01:01:11.164032 | debian-trixie | INFO Collection 'vexxhost.containers' detected. 2026-04-15 01:01:11.164100 | debian-trixie | INFO Scenarios will be used from 'extensions/molecule' 2026-04-15 01:01:12.046426 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-15 01:01:12.046494 | debian-trixie | INFO default scenario not found, disabling shared state. 2026-04-15 01:01:12.046576 | debian-trixie | INFO [nerdctl > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-15 01:01:12.046654 | debian-trixie | INFO [nerdctl > prerun] Performing prerun with role_name_check=0... 2026-04-15 01:01:49.551939 | debian-trixie | INFO [nerdctl > dependency] Executing 2026-04-15 01:01:49.552018 | debian-trixie | WARNING [nerdctl > dependency] Missing roles requirements file: requirements.yml 2026-04-15 01:01:49.552281 | debian-trixie | WARNING [nerdctl > dependency] Missing collections requirements file: collections.yml 2026-04-15 01:01:49.552669 | debian-trixie | WARNING [nerdctl > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-15 01:01:49.557967 | debian-trixie | INFO [nerdctl > cleanup] Executing 2026-04-15 01:01:49.558318 | debian-trixie | WARNING [nerdctl > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:49.563731 | debian-trixie | INFO [nerdctl > destroy] Executing 2026-04-15 01:01:49.563755 | debian-trixie | WARNING [nerdctl > destroy] Skipping, '--destroy=never' requested. 2026-04-15 01:01:49.563771 | debian-trixie | INFO [nerdctl > destroy] Executed: Successful 2026-04-15 01:01:49.569288 | debian-trixie | INFO [nerdctl > syntax] Executing 2026-04-15 01:01:50.126552 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:50.126729 | 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-15 01:01:50.126971 | 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-15 01:01:50.127189 | debian-trixie | 2026-04-15 01:01:50.559544 | debian-trixie | 2026-04-15 01:01:50.559643 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/nerdctl/converge.yml 2026-04-15 01:01:50.701673 | debian-trixie | INFO [nerdctl > syntax] Executed: Successful 2026-04-15 01:01:50.711092 | debian-trixie | INFO [nerdctl > create] Executing 2026-04-15 01:01:50.713143 | debian-trixie | WARNING [nerdctl > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:50.719642 | debian-trixie | INFO [nerdctl > prepare] Executing 2026-04-15 01:01:51.291916 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:51.292078 | 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-15 01:01:51.292348 | 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-15 01:01:51.292496 | debian-trixie | 2026-04-15 01:01:51.678759 | debian-trixie | 2026-04-15 01:01:51.678890 | debian-trixie | PLAY [Prepare] ***************************************************************** 2026-04-15 01:01:51.679076 | debian-trixie | 2026-04-15 01:01:51.679281 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:01:51.679485 | debian-trixie | Wednesday 15 April 2026 01:01:51 +0000 (0:00:00.034) 0:00:00.034 ******* 2026-04-15 01:01:53.002253 | 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-15 01:01:53.004394 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:01:53.004557 | debian-trixie | 2026-04-15 01:01:53.004754 | debian-trixie | TASK [Update "apt" cache] ****************************************************** 2026-04-15 01:01:53.004950 | debian-trixie | Wednesday 15 April 2026 01:01:53 +0000 (0:00:01.327) 0:00:01.362 ******* 2026-04-15 01:01:58.205532 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:01:58.205609 | debian-trixie | 2026-04-15 01:01:58.205884 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-15 01:01:58.206110 | debian-trixie | debian-trixie : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:01:58.206296 | debian-trixie | 2026-04-15 01:01:58.206484 | debian-trixie | 2026-04-15 01:01:58.206696 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-15 01:01:58.206888 | debian-trixie | Wednesday 15 April 2026 01:01:58 +0000 (0:00:05.200) 0:00:06.563 ******* 2026-04-15 01:01:58.207087 | debian-trixie | =============================================================================== 2026-04-15 01:01:58.207415 | debian-trixie | Update "apt" cache ------------------------------------------------------ 5.20s 2026-04-15 01:01:58.207625 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.33s 2026-04-15 01:01:58.327505 | debian-trixie | INFO [nerdctl > prepare] Executed: Successful 2026-04-15 01:01:58.336309 | debian-trixie | INFO [nerdctl > converge] Executing 2026-04-15 01:01:58.842581 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:58.842659 | 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-15 01:01:58.842846 | 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-15 01:01:58.843029 | debian-trixie | 2026-04-15 01:01:59.221256 | debian-trixie | 2026-04-15 01:01:59.221331 | debian-trixie | PLAY [Converge] **************************************************************** 2026-04-15 01:01:59.221497 | debian-trixie | 2026-04-15 01:01:59.221740 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:01:59.222010 | debian-trixie | Wednesday 15 April 2026 01:01:59 +0000 (0:00:00.013) 0:00:00.013 ******* 2026-04-15 01:02:00.360692 | 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-15 01:02:00.365572 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:00.365594 | debian-trixie | 2026-04-15 01:02:00.365603 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:00.365612 | debian-trixie | Wednesday 15 April 2026 01:02:00 +0000 (0:00:01.143) 0:00:01.157 ******* 2026-04-15 01:02:00.884380 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:00.884681 | debian-trixie | 2026-04-15 01:02:00.884970 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-15 01:02:00.885245 | debian-trixie | Wednesday 15 April 2026 01:02:00 +0000 (0:00:00.519) 0:00:01.677 ******* 2026-04-15 01:02:00.928533 | debian-trixie | skipping: [debian-trixie] 2026-04-15 01:02:00.928941 | debian-trixie | 2026-04-15 01:02:00.929216 | debian-trixie | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-15 01:02:00.929484 | debian-trixie | Wednesday 15 April 2026 01:02:00 +0000 (0:00:00.044) 0:00:01.721 ******* 2026-04-15 01:02:01.390052 | debian-trixie | changed: [debian-trixie] 2026-04-15 01:02:01.390082 | debian-trixie | 2026-04-15 01:02:01.390087 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-15 01:02:01.390105 | debian-trixie | Wednesday 15 April 2026 01:02:01 +0000 (0:00:00.457) 0:00:02.179 ******* 2026-04-15 01:02:01.491217 | debian-trixie | ok: [debian-trixie] => { 2026-04-15 01:02:01.491243 | debian-trixie | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-15 01:02:01.491252 | debian-trixie | } 2026-04-15 01:02:01.491261 | debian-trixie | 2026-04-15 01:02:01.491269 | debian-trixie | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-15 01:02:01.491278 | debian-trixie | Wednesday 15 April 2026 01:02:01 +0000 (0:00:00.103) 0:00:02.283 ******* 2026-04-15 01:02:02.290435 | 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-15 01:02:02.296390 | debian-trixie | changed: [debian-trixie] 2026-04-15 01:02:02.296485 | debian-trixie | 2026-04-15 01:02:02.296609 | debian-trixie | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-15 01:02:02.296703 | debian-trixie | Wednesday 15 April 2026 01:02:02 +0000 (0:00:00.806) 0:00:03.089 ******* 2026-04-15 01:02:02.327057 | debian-trixie | skipping: [debian-trixie] 2026-04-15 01:02:02.327226 | debian-trixie | 2026-04-15 01:02:02.327427 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:02.327620 | debian-trixie | Wednesday 15 April 2026 01:02:02 +0000 (0:00:00.030) 0:00:03.120 ******* 2026-04-15 01:02:02.643052 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:02.643197 | debian-trixie | 2026-04-15 01:02:02.643431 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-15 01:02:02.643636 | debian-trixie | Wednesday 15 April 2026 01:02:02 +0000 (0:00:00.315) 0:00:03.435 ******* 2026-04-15 01:02:03.821741 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:03.821796 | debian-trixie | 2026-04-15 01:02:03.821822 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-15 01:02:03.822125 | debian-trixie | Wednesday 15 April 2026 01:02:03 +0000 (0:00:01.170) 0:00:04.606 ******* 2026-04-15 01:02:03.897198 | 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-15 01:02:03.897382 | debian-trixie | 2026-04-15 01:02:03.897582 | debian-trixie | Task failed. 2026-04-15 01:02:03.897845 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3 2026-04-15 01:02:03.898045 | debian-trixie | 2026-04-15 01:02:03.898263 | debian-trixie | 13 # under the License. 2026-04-15 01:02:03.898461 | debian-trixie | 14 2026-04-15 01:02:03.898633 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:03.898816 | debian-trixie | ^ column 3 2026-04-15 01:02:03.898995 | debian-trixie | 2026-04-15 01:02:03.899174 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:03.899343 | debian-trixie | 2026-04-15 01:02:03.899531 | debian-trixie | Finalization of task args for 'ansible.builtin.debug' failed. 2026-04-15 01:02:03.899732 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3 2026-04-15 01:02:03.899903 | debian-trixie | 2026-04-15 01:02:03.900082 | debian-trixie | 14 2026-04-15 01:02:03.900269 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:03.900464 | debian-trixie | 16 ansible.builtin.debug: 2026-04-15 01:02:03.900647 | debian-trixie | ^ column 3 2026-04-15 01:02:03.900842 | debian-trixie | 2026-04-15 01:02:03.901045 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:03.901218 | debian-trixie | 2026-04-15 01:02:03.901412 | debian-trixie | Error while resolving value for 'msg'. 2026-04-15 01:02:03.901816 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10 2026-04-15 01:02:03.901991 | debian-trixie | 2026-04-15 01:02:03.902276 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:03.902428 | debian-trixie | 16 ansible.builtin.debug: 2026-04-15 01:02:03.902548 | debian-trixie | 17 msg: "{{ download_artifact_url }}" 2026-04-15 01:02:03.902664 | debian-trixie | ^ column 10 2026-04-15 01:02:03.902771 | debian-trixie | 2026-04-15 01:02:03.902880 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:03.902985 | debian-trixie | 2026-04-15 01:02:03.903112 | debian-trixie | object of type 'NoneType' has no attribute 'keys' 2026-04-15 01:02:03.903233 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22 2026-04-15 01:02:03.903338 | debian-trixie | 2026-04-15 01:02:03.903454 | debian-trixie | 13 # under the License. 2026-04-15 01:02:03.903566 | debian-trixie | 14 2026-04-15 01:02:03.903695 | debian-trixie | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}" 2026-04-15 01:02:03.903808 | debian-trixie | ^ column 22 2026-04-15 01:02:03.903914 | debian-trixie | 2026-04-15 01:02:03.904134 | 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-15 01:02:03.904241 | debian-trixie | 2026-04-15 01:02:03.904373 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-15 01:02:03.904493 | debian-trixie | debian-trixie : ok=7 changed=2 unreachable=0 failed=1 skipped=2 rescued=0 ignored=0 2026-04-15 01:02:03.904598 | debian-trixie | 2026-04-15 01:02:03.904703 | debian-trixie | 2026-04-15 01:02:03.904819 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-15 01:02:03.904939 | debian-trixie | Wednesday 15 April 2026 01:02:03 +0000 (0:00:00.086) 0:00:04.693 ******* 2026-04-15 01:02:03.905051 | debian-trixie | =============================================================================== 2026-04-15 01:02:03.905182 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 1.17s 2026-04-15 01:02:03.905325 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.14s 2026-04-15 01:02:03.905453 | debian-trixie | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-04-15 01:02:03.905578 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.52s 2026-04-15 01:02:03.905726 | debian-trixie | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-04-15 01:02:03.905850 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.32s 2026-04-15 01:02:03.905973 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.10s 2026-04-15 01:02:03.906142 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.09s 2026-04-15 01:02:03.906253 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-15 01:02:03.906396 | debian-trixie | vexxhost.containers.download_artifact : Extract archive ----------------- 0.03s 2026-04-15 01:02:04.051177 | debian-trixie | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.nerdctl/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/nerdctl/converge.yml 2026-04-15 01:02:04.051332 | debian-trixie | ERROR [nerdctl > converge] Executed: Failed 2026-04-15 01:02:04.051478 | debian-trixie | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.QUTN.nerdctl/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/nerdctl/converge.yml 2026-04-15 01:02:04.214651 | debian-trixie | ERROR 2026-04-15 01:02:04.215013 | debian-trixie | { 2026-04-15 01:02:04.215082 | debian-trixie | "delta": "0:00:55.114363", 2026-04-15 01:02:04.215130 | debian-trixie | "end": "2026-04-15 01:02:04.138680", 2026-04-15 01:02:04.215172 | debian-trixie | "msg": "non-zero return code", 2026-04-15 01:02:04.215212 | debian-trixie | "rc": 2, 2026-04-15 01:02:04.215256 | debian-trixie | "start": "2026-04-15 01:01:09.024317" 2026-04-15 01:02:04.215296 | debian-trixie | } failure 2026-04-15 01:02:04.219885 | 2026-04-15 01:02:04.219947 | PLAY RECAP 2026-04-15 01:02:04.220009 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:02:04.220040 | 2026-04-15 01:02:04.356561 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:02:04.358803 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:04.911817 | 2026-04-15 01:02:04.911933 | PLAY [all] 2026-04-15 01:02:04.921331 | 2026-04-15 01:02:04.921404 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-15 01:02:04.966031 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:02:04.973217 | 2026-04-15 01:02:04.973322 | TASK [fetch-output : Set log path for single node] 2026-04-15 01:02:05.014511 | debian-trixie | ok 2026-04-15 01:02:05.020744 | 2026-04-15 01:02:05.020809 | LOOP [fetch-output : Ensure local output dirs] 2026-04-15 01:02:05.390831 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/logs" 2026-04-15 01:02:05.594279 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/artifacts" 2026-04-15 01:02:05.803680 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/39768b8b70d0407e8cee5414c809b1eb/work/docs" 2026-04-15 01:02:05.817569 | 2026-04-15 01:02:05.817733 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-15 01:02:06.481556 | debian-trixie | ok 2026-04-15 01:02:06.481774 | debian-trixie | changed: All items complete 2026-04-15 01:02:06.481818 | 2026-04-15 01:02:06.981130 | debian-trixie | changed: .d..t...... ./ 2026-04-15 01:02:07.472466 | debian-trixie | changed: .d..t...... ./ 2026-04-15 01:02:07.485852 | 2026-04-15 01:02:07.485973 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-15 01:02:07.881636 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.007056 2026-04-15 01:02:08.093817 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.005305 2026-04-15 01:02:08.109389 | 2026-04-15 01:02:08.109486 | PLAY [all] 2026-04-15 01:02:08.114111 | 2026-04-15 01:02:08.114175 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-15 01:02:08.567678 | debian-trixie | changed 2026-04-15 01:02:08.580578 | 2026-04-15 01:02:08.580634 | PLAY RECAP 2026-04-15 01:02:08.580677 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-15 01:02:08.580699 | 2026-04-15 01:02:08.684175 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:08.686516 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-15 01:02:09.258179 | 2026-04-15 01:02:09.258292 | PLAY [localhost] 2026-04-15 01:02:09.268116 | 2026-04-15 01:02:09.268188 | TASK [Generate Zuul manifest] 2026-04-15 01:02:09.285417 | localhost | ok 2026-04-15 01:02:09.299194 | 2026-04-15 01:02:09.299286 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-15 01:02:09.636766 | localhost | changed 2026-04-15 01:02:09.648644 | 2026-04-15 01:02:09.648744 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-15 01:02:09.679945 | localhost | ok 2026-04-15 01:02:09.691542 | 2026-04-15 01:02:09.691832 | TASK [Upload logs] 2026-04-15 01:02:09.713084 | localhost | ok 2026-04-15 01:02:09.778110 | 2026-04-15 01:02:09.778228 | TASK [Set zuul-log-path fact] 2026-04-15 01:02:09.802444 | localhost | ok 2026-04-15 01:02:09.813650 | 2026-04-15 01:02:09.813718 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:02:09.844226 | localhost | ok 2026-04-15 01:02:09.853783 | 2026-04-15 01:02:09.853870 | TASK [upload-logs : Create log directories] 2026-04-15 01:02:10.239496 | localhost | changed 2026-04-15 01:02:10.245748 | 2026-04-15 01:02:10.245845 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-15 01:02:10.639605 | localhost -> localhost | ok: Runtime: 0:00:00.013439 2026-04-15 01:02:10.645315 | 2026-04-15 01:02:10.645383 | TASK [upload-logs : Upload logs to log server] 2026-04-15 01:02:11.101466 | localhost | Output suppressed because no_log was given 2026-04-15 01:02:11.105839 | 2026-04-15 01:02:11.105906 | LOOP [upload-logs : Compress console log and json output] 2026-04-15 01:02:11.156385 | localhost | skipping: Conditional result was False 2026-04-15 01:02:11.163814 | localhost | skipping: Conditional result was False 2026-04-15 01:02:11.178196 | 2026-04-15 01:02:11.178380 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-15 01:02:11.227150 | localhost | skipping: Conditional result was False 2026-04-15 01:02:11.227590 | 2026-04-15 01:02:11.231099 | localhost | skipping: Conditional result was False 2026-04-15 01:02:11.243571 | 2026-04-15 01:02:11.243730 | LOOP [upload-logs : Upload console log and json output]