2026-04-15 01:00:39.822479 | Job console starting 2026-04-15 01:00:39.837448 | Updating git repos 2026-04-15 01:00:39.858446 | Cloning repos into workspace 2026-04-15 01:00:39.943046 | Restoring repo states 2026-04-15 01:00:39.950272 | Merging changes 2026-04-15 01:00:40.190520 | Checking out repos 2026-04-15 01:00:40.218958 | Preparing playbooks 2026-04-15 01:00:41.956012 | Running Ansible setup 2026-04-15 01:00:45.866705 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:00:46.555125 | 2026-04-15 01:00:46.566962 | PLAY [localhost] 2026-04-15 01:00:46.581510 | 2026-04-15 01:00:46.581684 | TASK [Gathering Facts] 2026-04-15 01:00:47.459056 | localhost | ok 2026-04-15 01:00:47.469597 | 2026-04-15 01:00:47.469690 | TASK [Setup log path fact] 2026-04-15 01:00:47.491010 | localhost | ok 2026-04-15 01:00:47.518740 | 2026-04-15 01:00:47.518869 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:00:47.548584 | localhost | ok 2026-04-15 01:00:47.564834 | 2026-04-15 01:00:47.564926 | TASK [emit-job-header : Print job information] 2026-04-15 01:00:47.605661 | # Job Information 2026-04-15 01:00:47.605836 | Ansible Version: 2.16.16 2026-04-15 01:00:47.605887 | Job: ansible-collection-containers-molecule-docker-debian-trixie 2026-04-15 01:00:47.606050 | Pipeline: check 2026-04-15 01:00:47.606112 | Executor: 0a8996d2b663 2026-04-15 01:00:47.606147 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/109 2026-04-15 01:00:47.606181 | Event ID: 276b5040-3866-11f1-87ec-4c6fd3e486d6 2026-04-15 01:00:47.610250 | 2026-04-15 01:00:47.610340 | LOOP [emit-job-header : Print node information] 2026-04-15 01:00:47.763317 | localhost | ok: 2026-04-15 01:00:47.763532 | localhost | # Node Information 2026-04-15 01:00:47.763575 | localhost | Inventory Hostname: debian-trixie 2026-04-15 01:00:47.763607 | localhost | Hostname: np0000166338 2026-04-15 01:00:47.763666 | localhost | Username: zuul 2026-04-15 01:00:47.763701 | localhost | Distro: Debian 13.4 2026-04-15 01:00:47.763761 | localhost | Provider: yul1 2026-04-15 01:00:47.763839 | localhost | Region: ca-ymq-1 2026-04-15 01:00:47.763905 | localhost | Label: debian-trixie 2026-04-15 01:00:47.763959 | localhost | Product Name: OpenStack Nova 2026-04-15 01:00:47.764011 | localhost | Interface IP: 199.204.45.169 2026-04-15 01:00:47.777786 | 2026-04-15 01:00:47.777865 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-15 01:00:48.287994 | localhost -> localhost | changed 2026-04-15 01:00:48.296444 | 2026-04-15 01:00:48.296571 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-15 01:00:49.295060 | localhost -> localhost | changed 2026-04-15 01:00:49.305468 | 2026-04-15 01:00:49.305544 | PLAY [all] 2026-04-15 01:00:49.315239 | 2026-04-15 01:00:49.315303 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-15 01:00:49.557806 | debian-trixie -> localhost | ok 2026-04-15 01:00:49.566964 | 2026-04-15 01:00:49.567098 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-15 01:00:49.602408 | debian-trixie | ok 2026-04-15 01:00:49.626831 | debian-trixie | included: /var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-15 01:00:49.632624 | 2026-04-15 01:00:49.632688 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-15 01:00:50.548779 | debian-trixie -> localhost | Generating public/private rsa key pair. 2026-04-15 01:00:50.549022 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/85716a61a369440daa2e9101c92b90b0_id_rsa 2026-04-15 01:00:50.549072 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/85716a61a369440daa2e9101c92b90b0_id_rsa.pub 2026-04-15 01:00:50.549106 | debian-trixie -> localhost | The key fingerprint is: 2026-04-15 01:00:50.549139 | debian-trixie -> localhost | SHA256:URT5D+NBbRTmvKPjR4ca+z4HjwL2/TII9/5uuR4MzV8 zuul-build-sshkey 2026-04-15 01:00:50.549186 | debian-trixie -> localhost | The key's randomart image is: 2026-04-15 01:00:50.549218 | debian-trixie -> localhost | +---[RSA 3072]----+ 2026-04-15 01:00:50.549250 | debian-trixie -> localhost | | .+o o+. | 2026-04-15 01:00:50.549282 | debian-trixie -> localhost | | .. .+o | 2026-04-15 01:00:50.549313 | debian-trixie -> localhost | | . o .o | 2026-04-15 01:00:50.549346 | debian-trixie -> localhost | | . = o. | 2026-04-15 01:00:50.549375 | debian-trixie -> localhost | | S . *o+E| 2026-04-15 01:00:50.549405 | debian-trixie -> localhost | | + +.B.+| 2026-04-15 01:00:50.549438 | debian-trixie -> localhost | | . =oO Bo| 2026-04-15 01:00:50.549467 | debian-trixie -> localhost | | .*.O.=| 2026-04-15 01:00:50.549500 | debian-trixie -> localhost | | .*=%=| 2026-04-15 01:00:50.549530 | debian-trixie -> localhost | +----[SHA256]-----+ 2026-04-15 01:00:50.549597 | debian-trixie -> localhost | ok: Runtime: 0:00:00.440663 2026-04-15 01:00:50.556110 | 2026-04-15 01:00:50.556172 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-15 01:00:50.588175 | debian-trixie | ok 2026-04-15 01:00:50.597830 | debian-trixie | included: /var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-15 01:00:50.604237 | 2026-04-15 01:00:50.604299 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-15 01:00:50.629293 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:00:50.638625 | 2026-04-15 01:00:50.638762 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-15 01:00:51.243839 | debian-trixie | changed 2026-04-15 01:00:51.249624 | 2026-04-15 01:00:51.249764 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-15 01:00:51.475635 | debian-trixie | ok 2026-04-15 01:00:51.480667 | 2026-04-15 01:00:51.480739 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-15 01:00:52.027305 | debian-trixie | changed 2026-04-15 01:00:52.032146 | 2026-04-15 01:00:52.032272 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-15 01:00:52.552096 | debian-trixie | changed 2026-04-15 01:00:52.566211 | 2026-04-15 01:00:52.566285 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-15 01:00:52.587020 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:00:52.592282 | 2026-04-15 01:00:52.592353 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-15 01:00:52.994229 | debian-trixie -> localhost | changed 2026-04-15 01:00:53.003628 | 2026-04-15 01:00:53.003759 | TASK [add-build-sshkey : Add back temp key] 2026-04-15 01:00:53.318527 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/85716a61a369440daa2e9101c92b90b0_id_rsa (zuul-build-sshkey) 2026-04-15 01:00:53.318734 | debian-trixie -> localhost | ok: Runtime: 0:00:00.028530 2026-04-15 01:00:53.322932 | 2026-04-15 01:00:53.323001 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-15 01:00:53.655263 | debian-trixie | ok 2026-04-15 01:00:53.659031 | 2026-04-15 01:00:53.659095 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-15 01:00:53.683841 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:00:53.691526 | 2026-04-15 01:00:53.691598 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-15 01:00:54.078980 | debian-trixie | ok 2026-04-15 01:00:54.085994 | 2026-04-15 01:00:54.086069 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-15 01:00:54.949962 | debian-trixie | Output suppressed because no_log was given 2026-04-15 01:00:54.958067 | 2026-04-15 01:00:54.958141 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-15 01:00:55.163278 | debian-trixie | ok: "logs" 2026-04-15 01:00:55.163482 | debian-trixie | ok: All items complete 2026-04-15 01:00:55.163511 | 2026-04-15 01:00:55.341519 | debian-trixie | ok: "artifacts" 2026-04-15 01:00:55.525440 | debian-trixie | ok: "docs" 2026-04-15 01:00:55.536360 | 2026-04-15 01:00:55.536497 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-15 01:00:55.771173 | debian-trixie | changed: "logs" 2026-04-15 01:00:55.961238 | debian-trixie | changed: "artifacts" 2026-04-15 01:00:56.168240 | debian-trixie | changed: "docs" 2026-04-15 01:00:56.191807 | 2026-04-15 01:00:56.191915 | PLAY RECAP 2026-04-15 01:00:56.191964 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-15 01:00:56.191994 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:00:56.192019 | 2026-04-15 01:00:56.348823 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-15 01:00:56.350931 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:00:56.989826 | 2026-04-15 01:00:56.990290 | PLAY [all] 2026-04-15 01:00:57.006516 | 2026-04-15 01:00:57.006661 | TASK [setup-uv : Extract archive] 2026-04-15 01:00:59.457928 | debian-trixie | changed 2026-04-15 01:00:59.463238 | 2026-04-15 01:00:59.463329 | TASK [setup-uv : Print version] 2026-04-15 01:00:59.831913 | debian-trixie | uv 0.8.13 2026-04-15 01:00:59.990268 | debian-trixie | ok: Runtime: 0:00:00.014964 2026-04-15 01:00:59.995011 | 2026-04-15 01:00:59.995057 | PLAY RECAP 2026-04-15 01:00:59.995101 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:00:59.995126 | 2026-04-15 01:01:00.103572 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-15 01:01:00.104666 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:01:00.694256 | 2026-04-15 01:01:00.694385 | PLAY [all] 2026-04-15 01:01:00.704359 | 2026-04-15 01:01:00.704445 | TASK [Copy inventory file for Zuul] 2026-04-15 01:01:01.617577 | debian-trixie | changed 2026-04-15 01:01:01.623297 | 2026-04-15 01:01:01.623372 | TASK [Switch "ansible_host" to private IP] 2026-04-15 01:01:01.925295 | debian-trixie | changed: 1 replacements made 2026-04-15 01:01:01.940810 | 2026-04-15 01:01:01.940929 | TASK [Run Molecule scenario] 2026-04-15 01:01:02.386503 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-15 01:01:02.386599 | debian-trixie | Creating virtual environment at: .venv 2026-04-15 01:01:02.640079 | debian-trixie | Downloading ansible-core (2.3MiB) 2026-04-15 01:01:02.641015 | debian-trixie | Downloading pygments (1.2MiB) 2026-04-15 01:01:02.722992 | debian-trixie | Downloading cryptography (4.3MiB) 2026-04-15 01:01:02.808966 | debian-trixie | Downloading cryptography 2026-04-15 01:01:02.862187 | debian-trixie | Downloading pygments 2026-04-15 01:01:03.060088 | debian-trixie | Downloading ansible-core 2026-04-15 01:01:03.108254 | debian-trixie | Installed 36 packages in 47ms 2026-04-15 01:01:03.782425 | debian-trixie | INFO Collection 'vexxhost.containers' detected. 2026-04-15 01:01:03.782508 | debian-trixie | INFO Scenarios will be used from 'extensions/molecule' 2026-04-15 01:01:04.590226 | debian-trixie | :1: SyntaxWarning: invalid decimal literal 2026-04-15 01:01:04.691230 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-15 01:01:04.691310 | debian-trixie | INFO default scenario not found, disabling shared state. 2026-04-15 01:01:04.691404 | debian-trixie | INFO [docker > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-15 01:01:04.691504 | debian-trixie | INFO [docker > prerun] Performing prerun with role_name_check=0... 2026-04-15 01:01:51.951989 | debian-trixie | INFO [docker > dependency] Executing 2026-04-15 01:01:51.952201 | debian-trixie | WARNING [docker > dependency] Missing roles requirements file: requirements.yml 2026-04-15 01:01:51.952544 | debian-trixie | WARNING [docker > dependency] Missing collections requirements file: collections.yml 2026-04-15 01:01:51.952728 | debian-trixie | WARNING [docker > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-15 01:01:51.960557 | debian-trixie | INFO [docker > cleanup] Executing 2026-04-15 01:01:51.960970 | debian-trixie | WARNING [docker > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:51.967489 | debian-trixie | INFO [docker > destroy] Executing 2026-04-15 01:01:51.967558 | debian-trixie | WARNING [docker > destroy] Skipping, '--destroy=never' requested. 2026-04-15 01:01:51.967701 | debian-trixie | INFO [docker > destroy] Executed: Successful 2026-04-15 01:01:51.974458 | debian-trixie | INFO [docker > syntax] Executing 2026-04-15 01:01:52.532395 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:52.532458 | 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:52.532470 | 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:52.532479 | debian-trixie | 2026-04-15 01:01:52.989946 | debian-trixie | 2026-04-15 01:01:52.990108 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml 2026-04-15 01:01:53.094656 | debian-trixie | INFO [docker > syntax] Executed: Successful 2026-04-15 01:01:53.106935 | debian-trixie | INFO [docker > create] Executing 2026-04-15 01:01:53.108430 | debian-trixie | WARNING [docker > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-15 01:01:53.113712 | debian-trixie | INFO [docker > prepare] Executing 2026-04-15 01:01:53.629836 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:01:53.630498 | 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:53.630509 | 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:53.630515 | debian-trixie | 2026-04-15 01:01:53.980839 | debian-trixie | 2026-04-15 01:01:53.980964 | debian-trixie | PLAY [Prepare] ***************************************************************** 2026-04-15 01:01:53.981161 | debian-trixie | 2026-04-15 01:01:53.981437 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:01:53.981644 | debian-trixie | Wednesday 15 April 2026 01:01:53 +0000 (0:00:00.030) 0:00:00.030 ******* 2026-04-15 01:01:55.324556 | 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:55.327123 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:01:55.327322 | debian-trixie | 2026-04-15 01:01:55.327528 | debian-trixie | TASK [Update "apt" cache] ****************************************************** 2026-04-15 01:01:55.327731 | debian-trixie | Wednesday 15 April 2026 01:01:55 +0000 (0:00:01.347) 0:00:01.377 ******* 2026-04-15 01:02:00.250014 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:00.250135 | debian-trixie | 2026-04-15 01:02:00.250382 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-15 01:02:00.250618 | debian-trixie | debian-trixie : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-15 01:02:00.250808 | debian-trixie | 2026-04-15 01:02:00.251044 | debian-trixie | 2026-04-15 01:02:00.251260 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-15 01:02:00.251485 | debian-trixie | Wednesday 15 April 2026 01:02:00 +0000 (0:00:04.922) 0:00:06.300 ******* 2026-04-15 01:02:00.251685 | debian-trixie | =============================================================================== 2026-04-15 01:02:00.251893 | debian-trixie | Update "apt" cache ------------------------------------------------------ 4.92s 2026-04-15 01:02:00.252099 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.35s 2026-04-15 01:02:00.343570 | debian-trixie | INFO [docker > prepare] Executed: Successful 2026-04-15 01:02:00.356626 | debian-trixie | INFO [docker > converge] Executing 2026-04-15 01:02:00.887556 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-15 01:02:00.887736 | 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:02:00.887947 | 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:02:00.888118 | debian-trixie | 2026-04-15 01:02:01.358300 | debian-trixie | 2026-04-15 01:02:01.358348 | debian-trixie | PLAY [Converge] **************************************************************** 2026-04-15 01:02:01.358412 | debian-trixie | 2026-04-15 01:02:01.358524 | debian-trixie | TASK [Gathering Facts] ********************************************************* 2026-04-15 01:02:01.358640 | debian-trixie | Wednesday 15 April 2026 01:02:01 +0000 (0:00:00.019) 0:00:00.019 ******* 2026-04-15 01:02:02.483595 | 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:02.487029 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:02.487220 | debian-trixie | 2026-04-15 01:02:02.487431 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:02.487629 | debian-trixie | Wednesday 15 April 2026 01:02:02 +0000 (0:00:01.132) 0:00:01.151 ******* 2026-04-15 01:02:02.992259 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:02.992285 | debian-trixie | 2026-04-15 01:02:02.992290 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-15 01:02:02.992294 | debian-trixie | Wednesday 15 April 2026 01:02:02 +0000 (0:00:00.503) 0:00:01.655 ******* 2026-04-15 01:02:03.033037 | debian-trixie | skipping: [debian-trixie] 2026-04-15 01:02:03.033227 | debian-trixie | 2026-04-15 01:02:03.033428 | debian-trixie | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-15 01:02:03.033618 | debian-trixie | Wednesday 15 April 2026 01:02:03 +0000 (0:00:00.042) 0:00:01.697 ******* 2026-04-15 01:02:03.504926 | debian-trixie | changed: [debian-trixie] 2026-04-15 01:02:03.504991 | debian-trixie | 2026-04-15 01:02:03.505111 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-15 01:02:03.505235 | debian-trixie | Wednesday 15 April 2026 01:02:03 +0000 (0:00:00.470) 0:00:02.168 ******* 2026-04-15 01:02:03.607710 | debian-trixie | ok: [debian-trixie] => { 2026-04-15 01:02:03.607864 | debian-trixie | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-15 01:02:03.608050 | debian-trixie | } 2026-04-15 01:02:03.608236 | debian-trixie | 2026-04-15 01:02:03.608471 | debian-trixie | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-15 01:02:03.608679 | debian-trixie | Wednesday 15 April 2026 01:02:03 +0000 (0:00:00.103) 0:00:02.271 ******* 2026-04-15 01:02:04.616376 | 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:04.621897 | debian-trixie | changed: [debian-trixie] 2026-04-15 01:02:04.622081 | debian-trixie | 2026-04-15 01:02:04.622292 | debian-trixie | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-15 01:02:04.622493 | debian-trixie | Wednesday 15 April 2026 01:02:04 +0000 (0:00:01.014) 0:00:03.286 ******* 2026-04-15 01:02:04.652595 | debian-trixie | skipping: [debian-trixie] 2026-04-15 01:02:04.652766 | debian-trixie | 2026-04-15 01:02:04.652963 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-15 01:02:04.653157 | debian-trixie | Wednesday 15 April 2026 01:02:04 +0000 (0:00:00.030) 0:00:03.317 ******* 2026-04-15 01:02:04.692913 | debian-trixie | skipping: [debian-trixie] 2026-04-15 01:02:04.693077 | debian-trixie | 2026-04-15 01:02:04.693269 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-15 01:02:04.693461 | debian-trixie | Wednesday 15 April 2026 01:02:04 +0000 (0:00:00.040) 0:00:03.357 ******* 2026-04-15 01:02:05.002253 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:05.002437 | debian-trixie | 2026-04-15 01:02:05.002656 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-15 01:02:05.002858 | debian-trixie | Wednesday 15 April 2026 01:02:04 +0000 (0:00:00.309) 0:00:03.666 ******* 2026-04-15 01:02:06.296326 | debian-trixie | ok: [debian-trixie] 2026-04-15 01:02:06.296502 | debian-trixie | 2026-04-15 01:02:06.296755 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-15 01:02:06.296964 | debian-trixie | Wednesday 15 April 2026 01:02:06 +0000 (0:00:01.293) 0:00:04.960 ******* 2026-04-15 01:02:06.367135 | 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:06.367237 | debian-trixie | 2026-04-15 01:02:06.367464 | debian-trixie | Task failed. 2026-04-15 01:02:06.367725 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3 2026-04-15 01:02:06.367922 | debian-trixie | 2026-04-15 01:02:06.368116 | debian-trixie | 13 # under the License. 2026-04-15 01:02:06.368633 | debian-trixie | 14 2026-04-15 01:02:06.368647 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:06.368787 | debian-trixie | ^ column 3 2026-04-15 01:02:06.368981 | debian-trixie | 2026-04-15 01:02:06.369168 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:06.369334 | debian-trixie | 2026-04-15 01:02:06.369535 | debian-trixie | Finalization of task args for 'ansible.builtin.debug' failed. 2026-04-15 01:02:06.369857 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3 2026-04-15 01:02:06.370048 | debian-trixie | 2026-04-15 01:02:06.370230 | debian-trixie | 14 2026-04-15 01:02:06.370427 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:06.370621 | debian-trixie | 16 ansible.builtin.debug: 2026-04-15 01:02:06.370806 | debian-trixie | ^ column 3 2026-04-15 01:02:06.370981 | debian-trixie | 2026-04-15 01:02:06.371181 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:06.371349 | debian-trixie | 2026-04-15 01:02:06.371641 | debian-trixie | Error while resolving value for 'msg'. 2026-04-15 01:02:06.371921 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10 2026-04-15 01:02:06.372032 | debian-trixie | 2026-04-15 01:02:06.372158 | debian-trixie | 15 - name: Starting download of file 2026-04-15 01:02:06.372352 | debian-trixie | 16 ansible.builtin.debug: 2026-04-15 01:02:06.372500 | debian-trixie | 17 msg: "{{ download_artifact_url }}" 2026-04-15 01:02:06.372617 | debian-trixie | ^ column 10 2026-04-15 01:02:06.372720 | debian-trixie | 2026-04-15 01:02:06.372839 | debian-trixie | <<< caused by >>> 2026-04-15 01:02:06.372949 | debian-trixie | 2026-04-15 01:02:06.373078 | debian-trixie | object of type 'NoneType' has no attribute 'keys' 2026-04-15 01:02:06.373246 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22 2026-04-15 01:02:06.373398 | debian-trixie | 2026-04-15 01:02:06.373545 | debian-trixie | 13 # under the License. 2026-04-15 01:02:06.373669 | debian-trixie | 14 2026-04-15 01:02:06.373823 | debian-trixie | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}" 2026-04-15 01:02:06.373963 | debian-trixie | ^ column 22 2026-04-15 01:02:06.374090 | debian-trixie | 2026-04-15 01:02:06.374337 | 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:06.374478 | debian-trixie | 2026-04-15 01:02:06.374645 | debian-trixie | PLAY RECAP ********************************************************************* 2026-04-15 01:02:06.374785 | debian-trixie | debian-trixie : ok=7 changed=2 unreachable=0 failed=1 skipped=3 rescued=0 ignored=0 2026-04-15 01:02:06.374897 | debian-trixie | 2026-04-15 01:02:06.375021 | debian-trixie | 2026-04-15 01:02:06.375273 | debian-trixie | TASKS RECAP ******************************************************************** 2026-04-15 01:02:06.375463 | debian-trixie | Wednesday 15 April 2026 01:02:06 +0000 (0:00:00.074) 0:00:05.034 ******* 2026-04-15 01:02:06.375634 | debian-trixie | =============================================================================== 2026-04-15 01:02:06.375770 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 1.29s 2026-04-15 01:02:06.375903 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.13s 2026-04-15 01:02:06.376017 | debian-trixie | vexxhost.containers.download_artifact : Download item ------------------- 1.01s 2026-04-15 01:02:06.376137 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-04-15 01:02:06.376285 | debian-trixie | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.47s 2026-04-15 01:02:06.376403 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.31s 2026-04-15 01:02:06.376514 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.10s 2026-04-15 01:02:06.376632 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.07s 2026-04-15 01:02:06.376750 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-15 01:02:06.376870 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-04-15 01:02:06.376994 | debian-trixie | vexxhost.containers.download_artifact : Extract archive ----------------- 0.03s 2026-04-15 01:02:06.503255 | 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-15 01:02:06.503377 | debian-trixie | ERROR [docker > converge] Executed: Failed 2026-04-15 01:02:06.503618 | 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-15 01:02:07.033579 | debian-trixie | ERROR 2026-04-15 01:02:07.033842 | debian-trixie | { 2026-04-15 01:02:07.033905 | debian-trixie | "delta": "0:01:04.299486", 2026-04-15 01:02:07.033951 | debian-trixie | "end": "2026-04-15 01:02:06.607987", 2026-04-15 01:02:07.033993 | debian-trixie | "msg": "non-zero return code", 2026-04-15 01:02:07.034036 | debian-trixie | "rc": 2, 2026-04-15 01:02:07.034082 | debian-trixie | "start": "2026-04-15 01:01:02.308501" 2026-04-15 01:02:07.034121 | debian-trixie | } failure 2026-04-15 01:02:07.041238 | 2026-04-15 01:02:07.041512 | PLAY RECAP 2026-04-15 01:02:07.041622 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-15 01:02:07.041672 | 2026-04-15 01:02:07.156577 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-15 01:02:07.158239 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:07.731022 | 2026-04-15 01:02:07.731146 | PLAY [all] 2026-04-15 01:02:07.741050 | 2026-04-15 01:02:07.741140 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-15 01:02:07.786019 | debian-trixie | skipping: Conditional result was False 2026-04-15 01:02:07.793968 | 2026-04-15 01:02:07.794150 | TASK [fetch-output : Set log path for single node] 2026-04-15 01:02:07.833550 | debian-trixie | ok 2026-04-15 01:02:07.839688 | 2026-04-15 01:02:07.839780 | LOOP [fetch-output : Ensure local output dirs] 2026-04-15 01:02:08.208465 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/logs" 2026-04-15 01:02:08.418792 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/artifacts" 2026-04-15 01:02:08.633841 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/85716a61a369440daa2e9101c92b90b0/work/docs" 2026-04-15 01:02:08.653575 | 2026-04-15 01:02:08.653730 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-15 01:02:09.306279 | debian-trixie | changed: .d..t...... ./ 2026-04-15 01:02:09.306580 | debian-trixie | changed: All items complete 2026-04-15 01:02:09.306640 | 2026-04-15 01:02:09.828348 | debian-trixie | changed: .d..t...... ./ 2026-04-15 01:02:10.349433 | debian-trixie | changed: .d..t...... ./ 2026-04-15 01:02:10.371966 | 2026-04-15 01:02:10.372309 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-15 01:02:10.799810 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.006988 2026-04-15 01:02:11.020941 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.006566 2026-04-15 01:02:11.045708 | 2026-04-15 01:02:11.046218 | PLAY [all] 2026-04-15 01:02:11.051458 | 2026-04-15 01:02:11.051533 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-15 01:02:11.498904 | debian-trixie | changed 2026-04-15 01:02:11.504718 | 2026-04-15 01:02:11.504780 | PLAY RECAP 2026-04-15 01:02:11.504835 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-15 01:02:11.504877 | 2026-04-15 01:02:11.602847 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-15 01:02:11.604890 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-15 01:02:12.144026 | 2026-04-15 01:02:12.144401 | PLAY [localhost] 2026-04-15 01:02:12.154432 | 2026-04-15 01:02:12.154503 | TASK [Generate Zuul manifest] 2026-04-15 01:02:12.171875 | localhost | ok 2026-04-15 01:02:12.185558 | 2026-04-15 01:02:12.185640 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-15 01:02:12.499326 | localhost | changed 2026-04-15 01:02:12.510987 | 2026-04-15 01:02:12.511123 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-15 01:02:12.541994 | localhost | ok 2026-04-15 01:02:12.550660 | 2026-04-15 01:02:12.550749 | TASK [Upload logs] 2026-04-15 01:02:12.571485 | localhost | ok 2026-04-15 01:02:12.631254 | 2026-04-15 01:02:12.631354 | TASK [Set zuul-log-path fact] 2026-04-15 01:02:12.651837 | localhost | ok 2026-04-15 01:02:12.666826 | 2026-04-15 01:02:12.666890 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-15 01:02:12.697839 | localhost | ok 2026-04-15 01:02:12.709213 | 2026-04-15 01:02:12.709280 | TASK [upload-logs : Create log directories] 2026-04-15 01:02:13.102682 | localhost | changed 2026-04-15 01:02:13.108845 | 2026-04-15 01:02:13.108938 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-15 01:02:13.494818 | localhost -> localhost | ok: Runtime: 0:00:00.004423 2026-04-15 01:02:13.500709 | 2026-04-15 01:02:13.500789 | TASK [upload-logs : Upload logs to log server] 2026-04-15 01:02:13.998276 | localhost | Output suppressed because no_log was given 2026-04-15 01:02:14.002594 | 2026-04-15 01:02:14.002659 | LOOP [upload-logs : Compress console log and json output] 2026-04-15 01:02:14.048197 | localhost | skipping: Conditional result was False 2026-04-15 01:02:14.057056 | localhost | skipping: Conditional result was False 2026-04-15 01:02:14.075445 | 2026-04-15 01:02:14.075631 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-15 01:02:14.118200 | localhost | skipping: Conditional result was False 2026-04-15 01:02:14.118611 | 2026-04-15 01:02:14.122296 | localhost | skipping: Conditional result was False 2026-04-15 01:02:14.140436 | 2026-04-15 01:02:14.140615 | LOOP [upload-logs : Upload console log and json output]