2026-04-24 01:01:07.120137 | Job console starting 2026-04-24 01:01:07.128056 | Updating git repos 2026-04-24 01:01:07.158957 | Cloning repos into workspace 2026-04-24 01:01:07.224350 | Restoring repo states 2026-04-24 01:01:07.232318 | Merging changes 2026-04-24 01:01:07.530974 | Checking out repos 2026-04-24 01:01:07.563225 | Preparing playbooks 2026-04-24 01:01:08.470560 | Running Ansible setup 2026-04-24 01:01:11.779014 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-24 01:01:12.326246 | 2026-04-24 01:01:12.326372 | PLAY [localhost] 2026-04-24 01:01:12.333539 | 2026-04-24 01:01:12.333607 | TASK [Gathering Facts] 2026-04-24 01:01:13.224700 | localhost | ok 2026-04-24 01:01:13.235732 | 2026-04-24 01:01:13.235830 | TASK [Setup log path fact] 2026-04-24 01:01:13.257088 | localhost | ok 2026-04-24 01:01:13.269687 | 2026-04-24 01:01:13.269752 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-24 01:01:13.304176 | localhost | ok 2026-04-24 01:01:13.311354 | 2026-04-24 01:01:13.311424 | TASK [emit-job-header : Print job information] 2026-04-24 01:01:13.352610 | # Job Information 2026-04-24 01:01:13.352890 | Ansible Version: 2.16.16 2026-04-24 01:01:13.352994 | Job: ansible-collection-containers-molecule-docker-ubuntu-jammy 2026-04-24 01:01:13.353051 | Pipeline: check 2026-04-24 01:01:13.353095 | Executor: 0a8996d2b663 2026-04-24 01:01:13.353137 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/120 2026-04-24 01:01:13.353183 | Event ID: f893b090-3f78-11f1-873d-35d7e9189637 2026-04-24 01:01:13.356776 | 2026-04-24 01:01:13.356842 | LOOP [emit-job-header : Print node information] 2026-04-24 01:01:13.455298 | localhost | ok: 2026-04-24 01:01:13.455529 | localhost | # Node Information 2026-04-24 01:01:13.455557 | localhost | Inventory Hostname: ubuntu-jammy 2026-04-24 01:01:13.455578 | localhost | Hostname: np0000169892 2026-04-24 01:01:13.455598 | localhost | Username: zuul 2026-04-24 01:01:13.455620 | localhost | Distro: Ubuntu 22.04 2026-04-24 01:01:13.455639 | localhost | Provider: yul1 2026-04-24 01:01:13.455658 | localhost | Region: ca-ymq-1 2026-04-24 01:01:13.455677 | localhost | Label: ubuntu-jammy 2026-04-24 01:01:13.455695 | localhost | Product Name: OpenStack Nova 2026-04-24 01:01:13.455714 | localhost | Interface IP: 199.204.45.140 2026-04-24 01:01:13.472894 | 2026-04-24 01:01:13.473065 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-24 01:01:13.873353 | localhost -> localhost | changed 2026-04-24 01:01:13.882112 | 2026-04-24 01:01:13.882215 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-24 01:01:14.708800 | localhost -> localhost | changed 2026-04-24 01:01:14.718925 | 2026-04-24 01:01:14.718984 | PLAY [all] 2026-04-24 01:01:14.726743 | 2026-04-24 01:01:14.726811 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-24 01:01:14.944558 | ubuntu-jammy -> localhost | ok 2026-04-24 01:01:14.953378 | 2026-04-24 01:01:14.953467 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-24 01:01:14.988613 | ubuntu-jammy | ok 2026-04-24 01:01:15.001065 | ubuntu-jammy | included: /var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-24 01:01:15.006331 | 2026-04-24 01:01:15.006392 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-24 01:01:15.798344 | ubuntu-jammy -> localhost | Generating public/private rsa key pair. 2026-04-24 01:01:15.798511 | ubuntu-jammy -> localhost | Your identification has been saved in /var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/d50d10aa1b644a7c8a42e18f893f8281_id_rsa 2026-04-24 01:01:15.798542 | ubuntu-jammy -> localhost | Your public key has been saved in /var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/d50d10aa1b644a7c8a42e18f893f8281_id_rsa.pub 2026-04-24 01:01:15.798564 | ubuntu-jammy -> localhost | The key fingerprint is: 2026-04-24 01:01:15.798585 | ubuntu-jammy -> localhost | SHA256:sTcRTBaBLyM2fxqADJ53p5DSY12kPX+Xx3i8tnXGCfY zuul-build-sshkey 2026-04-24 01:01:15.798612 | ubuntu-jammy -> localhost | The key's randomart image is: 2026-04-24 01:01:15.798633 | ubuntu-jammy -> localhost | +---[RSA 3072]----+ 2026-04-24 01:01:15.798655 | ubuntu-jammy -> localhost | | ..+*o | 2026-04-24 01:01:15.798675 | ubuntu-jammy -> localhost | | . oo... | 2026-04-24 01:01:15.798695 | ubuntu-jammy -> localhost | | . = +..+.. | 2026-04-24 01:01:15.798714 | ubuntu-jammy -> localhost | | + X B +=.. = | 2026-04-24 01:01:15.798734 | ubuntu-jammy -> localhost | | + = BSo+ .o+ =| 2026-04-24 01:01:15.798753 | ubuntu-jammy -> localhost | | . o..o..o+o| 2026-04-24 01:01:15.798772 | ubuntu-jammy -> localhost | | + E=| 2026-04-24 01:01:15.798792 | ubuntu-jammy -> localhost | | . ..+| 2026-04-24 01:01:15.798813 | ubuntu-jammy -> localhost | | . | 2026-04-24 01:01:15.798833 | ubuntu-jammy -> localhost | +----[SHA256]-----+ 2026-04-24 01:01:15.798878 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.355588 2026-04-24 01:01:15.803698 | 2026-04-24 01:01:15.803764 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-24 01:01:15.826105 | ubuntu-jammy | ok 2026-04-24 01:01:15.834983 | ubuntu-jammy | included: /var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-24 01:01:15.842181 | 2026-04-24 01:01:15.842241 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-24 01:01:15.855980 | ubuntu-jammy | skipping: Conditional result was False 2026-04-24 01:01:15.863029 | 2026-04-24 01:01:15.863112 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-24 01:01:16.276228 | ubuntu-jammy | changed 2026-04-24 01:01:16.281218 | 2026-04-24 01:01:16.281280 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-24 01:01:16.453005 | ubuntu-jammy | ok 2026-04-24 01:01:16.460896 | 2026-04-24 01:01:16.461001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-24 01:01:17.029631 | ubuntu-jammy | changed 2026-04-24 01:01:17.036234 | 2026-04-24 01:01:17.036298 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-24 01:01:17.483108 | ubuntu-jammy | changed 2026-04-24 01:01:17.488249 | 2026-04-24 01:01:17.488325 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-24 01:01:17.511607 | ubuntu-jammy | skipping: Conditional result was False 2026-04-24 01:01:17.519409 | 2026-04-24 01:01:17.519500 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-24 01:01:17.855967 | ubuntu-jammy -> localhost | changed 2026-04-24 01:01:17.872328 | 2026-04-24 01:01:17.872471 | TASK [add-build-sshkey : Add back temp key] 2026-04-24 01:01:18.158845 | ubuntu-jammy -> localhost | Identity added: /var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/d50d10aa1b644a7c8a42e18f893f8281_id_rsa (zuul-build-sshkey) 2026-04-24 01:01:18.159072 | ubuntu-jammy -> localhost | ok: Runtime: 0:00:00.013442 2026-04-24 01:01:18.165458 | 2026-04-24 01:01:18.165517 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-24 01:01:18.492114 | ubuntu-jammy | ok 2026-04-24 01:01:18.498247 | 2026-04-24 01:01:18.498324 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-24 01:01:18.524369 | ubuntu-jammy | skipping: Conditional result was False 2026-04-24 01:01:18.538993 | 2026-04-24 01:01:18.539079 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-24 01:01:18.886804 | ubuntu-jammy | ok 2026-04-24 01:01:18.943542 | 2026-04-24 01:01:18.943708 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-24 01:01:20.116190 | ubuntu-jammy | Output suppressed because no_log was given 2026-04-24 01:01:20.126577 | 2026-04-24 01:01:20.126640 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-24 01:01:20.303210 | ubuntu-jammy | ok: "logs" 2026-04-24 01:01:20.303542 | ubuntu-jammy | ok: All items complete 2026-04-24 01:01:20.303584 | 2026-04-24 01:01:20.464381 | ubuntu-jammy | ok: "artifacts" 2026-04-24 01:01:20.623736 | ubuntu-jammy | ok: "docs" 2026-04-24 01:01:20.639207 | 2026-04-24 01:01:20.639321 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-24 01:01:20.899661 | ubuntu-jammy | changed: "logs" 2026-04-24 01:01:21.003171 | ubuntu-jammy | changed: "artifacts" 2026-04-24 01:01:21.166046 | ubuntu-jammy | changed: "docs" 2026-04-24 01:01:21.188477 | 2026-04-24 01:01:21.188579 | PLAY RECAP 2026-04-24 01:01:21.188619 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-24 01:01:21.188647 | ubuntu-jammy | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-24 01:01:21.188666 | 2026-04-24 01:01:21.305473 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-24 01:01:21.307747 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-24 01:01:21.884263 | 2026-04-24 01:01:21.884410 | PLAY [all] 2026-04-24 01:01:21.895910 | 2026-04-24 01:01:21.896018 | TASK [setup-uv : Extract archive] 2026-04-24 01:01:24.215455 | ubuntu-jammy | changed 2026-04-24 01:01:24.223327 | 2026-04-24 01:01:24.223518 | TASK [setup-uv : Print version] 2026-04-24 01:01:24.489971 | ubuntu-jammy | uv 0.8.13 2026-04-24 01:01:24.770867 | ubuntu-jammy | ok: Runtime: 0:00:00.013330 2026-04-24 01:01:24.776952 | 2026-04-24 01:01:24.777085 | PLAY RECAP 2026-04-24 01:01:24.777130 | ubuntu-jammy | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-24 01:01:24.777155 | 2026-04-24 01:01:24.892855 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-24 01:01:24.894374 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-24 01:01:25.476844 | 2026-04-24 01:01:25.543891 | PLAY [all] 2026-04-24 01:01:25.560763 | 2026-04-24 01:01:25.560847 | TASK [Copy inventory file for Zuul] 2026-04-24 01:01:26.417452 | ubuntu-jammy | changed 2026-04-24 01:01:26.424453 | 2026-04-24 01:01:26.424538 | TASK [Switch "ansible_host" to private IP] 2026-04-24 01:01:26.693987 | ubuntu-jammy | changed: 1 replacements made 2026-04-24 01:01:26.701203 | 2026-04-24 01:01:26.701299 | TASK [Run Molecule scenario] 2026-04-24 01:01:27.171449 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) (30.9MiB) 2026-04-24 01:01:28.100736 | ubuntu-jammy | Downloading cpython-3.13.7-linux-x86_64-gnu (download) 2026-04-24 01:01:28.280998 | ubuntu-jammy | Using CPython 3.13.7 2026-04-24 01:01:28.281089 | ubuntu-jammy | Creating virtual environment at: .venv 2026-04-24 01:01:28.579241 | ubuntu-jammy | Downloading cryptography (4.3MiB) 2026-04-24 01:01:28.579993 | ubuntu-jammy | Downloading pygments (1.2MiB) 2026-04-24 01:01:28.619855 | ubuntu-jammy | Downloading ansible-core (2.3MiB) 2026-04-24 01:01:28.755983 | ubuntu-jammy | Downloading cryptography 2026-04-24 01:01:28.805522 | ubuntu-jammy | Downloading pygments 2026-04-24 01:01:28.959558 | ubuntu-jammy | Downloading ansible-core 2026-04-24 01:01:28.989425 | ubuntu-jammy | Installed 36 packages in 29ms 2026-04-24 01:01:30.199361 | ubuntu-jammy | INFO Collection 'vexxhost.containers' detected. 2026-04-24 01:01:30.199458 | ubuntu-jammy | INFO Scenarios will be used from 'extensions/molecule' 2026-04-24 01:01:31.011095 | ubuntu-jammy | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-24 01:01:31.011171 | ubuntu-jammy | INFO default scenario not found, disabling shared state. 2026-04-24 01:01:31.011238 | ubuntu-jammy | INFO [docker > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-24 01:01:31.011339 | ubuntu-jammy | INFO [docker > prerun] Performing prerun with role_name_check=0... 2026-04-24 01:01:54.858986 | ubuntu-jammy | INFO [docker > dependency] Executing 2026-04-24 01:01:54.859090 | ubuntu-jammy | WARNING [docker > dependency] Missing roles requirements file: requirements.yml 2026-04-24 01:01:54.859184 | ubuntu-jammy | WARNING [docker > dependency] Missing collections requirements file: collections.yml 2026-04-24 01:01:54.859298 | ubuntu-jammy | WARNING [docker > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-24 01:01:54.864383 | ubuntu-jammy | INFO [docker > cleanup] Executing 2026-04-24 01:01:54.864698 | ubuntu-jammy | WARNING [docker > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-24 01:01:54.869670 | ubuntu-jammy | INFO [docker > destroy] Executing 2026-04-24 01:01:54.869706 | ubuntu-jammy | WARNING [docker > destroy] Skipping, '--destroy=never' requested. 2026-04-24 01:01:54.869777 | ubuntu-jammy | INFO [docker > destroy] Executed: Successful 2026-04-24 01:01:54.874995 | ubuntu-jammy | INFO [docker > syntax] Executing 2026-04-24 01:01:55.378876 | ubuntu-jammy | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-24 01:01:55.379115 | ubuntu-jammy | [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-24 01:01:55.379391 | ubuntu-jammy | 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-24 01:01:55.379573 | ubuntu-jammy | 2026-04-24 01:01:55.821697 | ubuntu-jammy | 2026-04-24 01:01:55.821856 | ubuntu-jammy | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml 2026-04-24 01:01:55.898478 | ubuntu-jammy | INFO [docker > syntax] Executed: Successful 2026-04-24 01:01:55.907256 | ubuntu-jammy | INFO [docker > create] Executing 2026-04-24 01:01:55.909169 | ubuntu-jammy | WARNING [docker > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-24 01:01:55.914173 | ubuntu-jammy | INFO [docker > prepare] Executing 2026-04-24 01:01:56.390146 | ubuntu-jammy | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-24 01:01:56.390306 | ubuntu-jammy | [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-24 01:01:56.390503 | ubuntu-jammy | 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-24 01:01:56.390664 | ubuntu-jammy | 2026-04-24 01:01:56.755060 | ubuntu-jammy | 2026-04-24 01:01:56.755217 | ubuntu-jammy | PLAY [Prepare] ***************************************************************** 2026-04-24 01:01:56.755386 | ubuntu-jammy | 2026-04-24 01:01:56.755574 | ubuntu-jammy | TASK [Gathering Facts] ********************************************************* 2026-04-24 01:01:56.755822 | ubuntu-jammy | Friday 24 April 2026 01:01:56 +0000 (0:00:00.038) 0:00:00.038 ********** 2026-04-24 01:01:57.974824 | ubuntu-jammy | [WARNING]: Host 'ubuntu-jammy' is using the discovered Python interpreter at '/usr/bin/python3.10', 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-24 01:01:57.976510 | ubuntu-jammy | ok: [ubuntu-jammy] 2026-04-24 01:01:57.976661 | ubuntu-jammy | 2026-04-24 01:01:57.976870 | ubuntu-jammy | TASK [Update "apt" cache] ****************************************************** 2026-04-24 01:01:57.977037 | ubuntu-jammy | Friday 24 April 2026 01:01:57 +0000 (0:00:01.222) 0:00:01.261 ********** 2026-04-24 01:02:04.731225 | ubuntu-jammy | changed: [ubuntu-jammy] 2026-04-24 01:02:04.731959 | ubuntu-jammy | 2026-04-24 01:02:04.731978 | ubuntu-jammy | PLAY RECAP ********************************************************************* 2026-04-24 01:02:04.731992 | ubuntu-jammy | ubuntu-jammy : ok=2 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-24 01:02:04.732005 | ubuntu-jammy | 2026-04-24 01:02:04.732021 | ubuntu-jammy | 2026-04-24 01:02:04.732211 | ubuntu-jammy | TASKS RECAP ******************************************************************** 2026-04-24 01:02:04.732368 | ubuntu-jammy | Friday 24 April 2026 01:02:04 +0000 (0:00:06.750) 0:00:08.011 ********** 2026-04-24 01:02:04.732518 | ubuntu-jammy | =============================================================================== 2026-04-24 01:02:04.732641 | ubuntu-jammy | Update "apt" cache ------------------------------------------------------ 6.75s 2026-04-24 01:02:04.732835 | ubuntu-jammy | Gathering Facts --------------------------------------------------------- 1.22s 2026-04-24 01:02:04.812630 | ubuntu-jammy | INFO [docker > prepare] Executed: Successful 2026-04-24 01:02:04.821823 | ubuntu-jammy | INFO [docker > converge] Executing 2026-04-24 01:02:05.328634 | ubuntu-jammy | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg. 2026-04-24 01:02:05.328760 | ubuntu-jammy | [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-24 01:02:05.328962 | ubuntu-jammy | 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-24 01:02:05.329061 | ubuntu-jammy | 2026-04-24 01:02:05.723743 | ubuntu-jammy | 2026-04-24 01:02:05.723907 | ubuntu-jammy | PLAY [Converge] **************************************************************** 2026-04-24 01:02:05.724080 | ubuntu-jammy | 2026-04-24 01:02:05.724287 | ubuntu-jammy | TASK [Gathering Facts] ********************************************************* 2026-04-24 01:02:05.724625 | ubuntu-jammy | Friday 24 April 2026 01:02:05 +0000 (0:00:00.016) 0:00:00.016 ********** 2026-04-24 01:02:06.742775 | ubuntu-jammy | [WARNING]: Host 'ubuntu-jammy' is using the discovered Python interpreter at '/usr/bin/python3.10', 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-24 01:02:06.746107 | ubuntu-jammy | ok: [ubuntu-jammy] 2026-04-24 01:02:06.746286 | ubuntu-jammy | 2026-04-24 01:02:06.746478 | ubuntu-jammy | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-24 01:02:06.746661 | ubuntu-jammy | Friday 24 April 2026 01:02:06 +0000 (0:00:01.025) 0:00:01.042 ********** 2026-04-24 01:02:07.250043 | ubuntu-jammy | ok: [ubuntu-jammy] 2026-04-24 01:02:07.250147 | ubuntu-jammy | 2026-04-24 01:02:07.250162 | ubuntu-jammy | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-24 01:02:07.250172 | ubuntu-jammy | Friday 24 April 2026 01:02:07 +0000 (0:00:00.502) 0:00:01.545 ********** 2026-04-24 01:02:07.283727 | ubuntu-jammy | skipping: [ubuntu-jammy] 2026-04-24 01:02:07.283820 | ubuntu-jammy | 2026-04-24 01:02:07.283985 | ubuntu-jammy | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-24 01:02:07.284147 | ubuntu-jammy | Friday 24 April 2026 01:02:07 +0000 (0:00:00.034) 0:00:01.580 ********** 2026-04-24 01:02:07.700429 | ubuntu-jammy | changed: [ubuntu-jammy] 2026-04-24 01:02:07.700530 | ubuntu-jammy | 2026-04-24 01:02:07.700725 | ubuntu-jammy | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-24 01:02:07.700913 | ubuntu-jammy | Friday 24 April 2026 01:02:07 +0000 (0:00:00.416) 0:00:01.996 ********** 2026-04-24 01:02:07.787844 | ubuntu-jammy | ok: [ubuntu-jammy] => { 2026-04-24 01:02:07.787992 | ubuntu-jammy | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-24 01:02:07.788152 | ubuntu-jammy | } 2026-04-24 01:02:07.788322 | ubuntu-jammy | 2026-04-24 01:02:07.788504 | ubuntu-jammy | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-24 01:02:07.788674 | ubuntu-jammy | Friday 24 April 2026 01:02:07 +0000 (0:00:00.087) 0:00:02.083 ********** 2026-04-24 01:02:08.608763 | ubuntu-jammy | [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-24 01:02:08.612671 | ubuntu-jammy | changed: [ubuntu-jammy] 2026-04-24 01:02:08.612775 | ubuntu-jammy | 2026-04-24 01:02:08.612875 | ubuntu-jammy | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-24 01:02:08.612970 | ubuntu-jammy | Friday 24 April 2026 01:02:08 +0000 (0:00:00.825) 0:00:02.909 ********** 2026-04-24 01:02:08.629888 | ubuntu-jammy | skipping: [ubuntu-jammy] 2026-04-24 01:02:08.629954 | ubuntu-jammy | 2026-04-24 01:02:08.630030 | ubuntu-jammy | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-24 01:02:08.630145 | ubuntu-jammy | Friday 24 April 2026 01:02:08 +0000 (0:00:00.017) 0:00:02.926 ********** 2026-04-24 01:02:08.662413 | ubuntu-jammy | skipping: [ubuntu-jammy] 2026-04-24 01:02:08.662543 | ubuntu-jammy | 2026-04-24 01:02:08.662730 | ubuntu-jammy | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-24 01:02:08.662911 | ubuntu-jammy | Friday 24 April 2026 01:02:08 +0000 (0:00:00.032) 0:00:02.958 ********** 2026-04-24 01:02:08.918298 | ubuntu-jammy | ok: [ubuntu-jammy] 2026-04-24 01:02:08.918532 | ubuntu-jammy | 2026-04-24 01:02:08.918852 | ubuntu-jammy | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-24 01:02:08.919189 | ubuntu-jammy | Friday 24 April 2026 01:02:08 +0000 (0:00:00.255) 0:00:03.214 ********** 2026-04-24 01:02:10.148448 | ubuntu-jammy | ok: [ubuntu-jammy] 2026-04-24 01:02:10.148599 | ubuntu-jammy | 2026-04-24 01:02:10.148831 | ubuntu-jammy | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-24 01:02:10.149019 | ubuntu-jammy | Friday 24 April 2026 01:02:10 +0000 (0:00:01.229) 0:00:04.444 ********** 2026-04-24 01:02:10.200931 | ubuntu-jammy | [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-24 01:02:10.201069 | ubuntu-jammy | 2026-04-24 01:02:10.201244 | ubuntu-jammy | Task failed. 2026-04-24 01:02:10.201436 | ubuntu-jammy | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3 2026-04-24 01:02:10.201593 | ubuntu-jammy | 2026-04-24 01:02:10.201756 | ubuntu-jammy | 13 # under the License. 2026-04-24 01:02:10.201917 | ubuntu-jammy | 14 2026-04-24 01:02:10.202085 | ubuntu-jammy | 15 - name: Starting download of file 2026-04-24 01:02:10.202299 | ubuntu-jammy | ^ column 3 2026-04-24 01:02:10.202517 | ubuntu-jammy | 2026-04-24 01:02:10.202693 | ubuntu-jammy | <<< caused by >>> 2026-04-24 01:02:10.202845 | ubuntu-jammy | 2026-04-24 01:02:10.203015 | ubuntu-jammy | Finalization of task args for 'ansible.builtin.debug' failed. 2026-04-24 01:02:10.203201 | ubuntu-jammy | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3 2026-04-24 01:02:10.203350 | ubuntu-jammy | 2026-04-24 01:02:10.203508 | ubuntu-jammy | 14 2026-04-24 01:02:10.203678 | ubuntu-jammy | 15 - name: Starting download of file 2026-04-24 01:02:10.203843 | ubuntu-jammy | 16 ansible.builtin.debug: 2026-04-24 01:02:10.204003 | ubuntu-jammy | ^ column 3 2026-04-24 01:02:10.204153 | ubuntu-jammy | 2026-04-24 01:02:10.204318 | ubuntu-jammy | <<< caused by >>> 2026-04-24 01:02:10.204514 | ubuntu-jammy | 2026-04-24 01:02:10.204668 | ubuntu-jammy | Error while resolving value for 'msg'. 2026-04-24 01:02:10.204882 | ubuntu-jammy | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10 2026-04-24 01:02:10.205030 | ubuntu-jammy | 2026-04-24 01:02:10.205197 | ubuntu-jammy | 15 - name: Starting download of file 2026-04-24 01:02:10.205354 | ubuntu-jammy | 16 ansible.builtin.debug: 2026-04-24 01:02:10.205521 | ubuntu-jammy | 17 msg: "{{ download_artifact_url }}" 2026-04-24 01:02:10.205681 | ubuntu-jammy | ^ column 10 2026-04-24 01:02:10.205829 | ubuntu-jammy | 2026-04-24 01:02:10.205988 | ubuntu-jammy | <<< caused by >>> 2026-04-24 01:02:10.206135 | ubuntu-jammy | 2026-04-24 01:02:10.206303 | ubuntu-jammy | object of type 'NoneType' has no attribute 'keys' 2026-04-24 01:02:10.206478 | ubuntu-jammy | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22 2026-04-24 01:02:10.206625 | ubuntu-jammy | 2026-04-24 01:02:10.206788 | ubuntu-jammy | 13 # under the License. 2026-04-24 01:02:10.206953 | ubuntu-jammy | 14 2026-04-24 01:02:10.207134 | ubuntu-jammy | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}" 2026-04-24 01:02:10.207295 | ubuntu-jammy | ^ column 22 2026-04-24 01:02:10.207444 | ubuntu-jammy | 2026-04-24 01:02:10.207754 | ubuntu-jammy | fatal: [ubuntu-jammy]: 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-24 01:02:10.207921 | ubuntu-jammy | 2026-04-24 01:02:10.208099 | ubuntu-jammy | PLAY RECAP ********************************************************************* 2026-04-24 01:02:10.208273 | ubuntu-jammy | ubuntu-jammy : ok=7 changed=2 unreachable=0 failed=1 skipped=3 rescued=0 ignored=0 2026-04-24 01:02:10.208451 | ubuntu-jammy | 2026-04-24 01:02:10.208627 | ubuntu-jammy | 2026-04-24 01:02:10.208814 | ubuntu-jammy | TASKS RECAP ******************************************************************** 2026-04-24 01:02:10.208979 | ubuntu-jammy | Friday 24 April 2026 01:02:10 +0000 (0:00:00.054) 0:00:04.499 ********** 2026-04-24 01:02:10.209133 | ubuntu-jammy | =============================================================================== 2026-04-24 01:02:10.209301 | ubuntu-jammy | vexxhost.containers.package : Update state for tar ---------------------- 1.23s 2026-04-24 01:02:10.209445 | ubuntu-jammy | Gathering Facts --------------------------------------------------------- 1.03s 2026-04-24 01:02:10.209526 | ubuntu-jammy | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-04-24 01:02:10.209602 | ubuntu-jammy | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-04-24 01:02:10.209679 | ubuntu-jammy | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-04-24 01:02:10.209755 | ubuntu-jammy | vexxhost.containers.forget_package : Forget package --------------------- 0.26s 2026-04-24 01:02:10.209831 | ubuntu-jammy | vexxhost.containers.download_artifact : Starting download of file ------- 0.09s 2026-04-24 01:02:10.209907 | ubuntu-jammy | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-24 01:02:10.209984 | ubuntu-jammy | vexxhost.containers.package : Update state for tar ---------------------- 0.03s 2026-04-24 01:02:10.210061 | ubuntu-jammy | vexxhost.containers.package : Update state for tar ---------------------- 0.03s 2026-04-24 01:02:10.210136 | ubuntu-jammy | vexxhost.containers.download_artifact : Extract archive ----------------- 0.02s 2026-04-24 01:02:10.319916 | ubuntu-jammy | 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-24 01:02:10.320019 | ubuntu-jammy | ERROR [docker > converge] Executed: Failed 2026-04-24 01:02:10.320127 | ubuntu-jammy | 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-24 01:02:10.805845 | ubuntu-jammy | ERROR 2026-04-24 01:02:10.806106 | ubuntu-jammy | { 2026-04-24 01:02:10.806149 | ubuntu-jammy | "delta": "0:00:43.471089", 2026-04-24 01:02:10.806179 | ubuntu-jammy | "end": "2026-04-24 01:02:10.395255", 2026-04-24 01:02:10.806213 | ubuntu-jammy | "msg": "non-zero return code", 2026-04-24 01:02:10.806241 | ubuntu-jammy | "rc": 2, 2026-04-24 01:02:10.806270 | ubuntu-jammy | "start": "2026-04-24 01:01:26.924166" 2026-04-24 01:02:10.806296 | ubuntu-jammy | } failure 2026-04-24 01:02:10.810116 | 2026-04-24 01:02:10.810168 | PLAY RECAP 2026-04-24 01:02:10.810215 | ubuntu-jammy | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-24 01:02:10.810238 | 2026-04-24 01:02:10.965609 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-24 01:02:10.969400 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-24 01:02:11.629202 | 2026-04-24 01:02:11.630047 | PLAY [all] 2026-04-24 01:02:11.644861 | 2026-04-24 01:02:11.644942 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-24 01:02:11.690818 | ubuntu-jammy | skipping: Conditional result was False 2026-04-24 01:02:11.699619 | 2026-04-24 01:02:11.699747 | TASK [fetch-output : Set log path for single node] 2026-04-24 01:02:11.745598 | ubuntu-jammy | ok 2026-04-24 01:02:11.751790 | 2026-04-24 01:02:11.751859 | LOOP [fetch-output : Ensure local output dirs] 2026-04-24 01:02:12.172340 | ubuntu-jammy -> localhost | ok: "/var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/logs" 2026-04-24 01:02:12.382032 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/artifacts" 2026-04-24 01:02:12.589232 | ubuntu-jammy -> localhost | changed: "/var/lib/zuul/builds/d50d10aa1b644a7c8a42e18f893f8281/work/docs" 2026-04-24 01:02:12.613435 | 2026-04-24 01:02:12.613594 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-24 01:02:13.237131 | ubuntu-jammy | changed: .d..t...... ./ 2026-04-24 01:02:13.237482 | ubuntu-jammy | changed: All items complete 2026-04-24 01:02:13.237531 | 2026-04-24 01:02:13.701525 | ubuntu-jammy | changed: .d..t...... ./ 2026-04-24 01:02:14.156307 | ubuntu-jammy | changed: .d..t...... ./ 2026-04-24 01:02:14.177901 | 2026-04-24 01:02:14.178040 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-24 01:02:14.615189 | ubuntu-jammy -> localhost | ok: Item: artifacts Runtime: 0:00:00.007884 2026-04-24 01:02:14.827106 | ubuntu-jammy -> localhost | ok: Item: docs Runtime: 0:00:00.008739 2026-04-24 01:02:14.843844 | 2026-04-24 01:02:14.843989 | PLAY [all] 2026-04-24 01:02:14.850924 | 2026-04-24 01:02:14.850992 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-24 01:02:15.268987 | ubuntu-jammy | changed 2026-04-24 01:02:15.275699 | 2026-04-24 01:02:15.275749 | PLAY RECAP 2026-04-24 01:02:15.275808 | ubuntu-jammy | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-24 01:02:15.275832 | 2026-04-24 01:02:15.397973 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-24 01:02:15.399253 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-24 01:02:15.940290 | 2026-04-24 01:02:15.940949 | PLAY [localhost] 2026-04-24 01:02:15.950953 | 2026-04-24 01:02:15.951023 | TASK [Generate Zuul manifest] 2026-04-24 01:02:15.971402 | localhost | ok 2026-04-24 01:02:15.987417 | 2026-04-24 01:02:15.987493 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-24 01:02:16.320853 | localhost | changed 2026-04-24 01:02:16.333938 | 2026-04-24 01:02:16.334013 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-24 01:02:16.365445 | localhost | ok 2026-04-24 01:02:16.373789 | 2026-04-24 01:02:16.373852 | TASK [Upload logs] 2026-04-24 01:02:16.393918 | localhost | ok 2026-04-24 01:02:16.457465 | 2026-04-24 01:02:16.457613 | TASK [Set zuul-log-path fact] 2026-04-24 01:02:16.482401 | localhost | ok 2026-04-24 01:02:16.495114 | 2026-04-24 01:02:16.495200 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-24 01:02:16.526524 | localhost | ok 2026-04-24 01:02:16.535660 | 2026-04-24 01:02:16.535731 | TASK [upload-logs : Create log directories] 2026-04-24 01:02:16.940448 | localhost | changed 2026-04-24 01:02:16.947092 | 2026-04-24 01:02:16.947188 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-24 01:02:17.387100 | localhost -> localhost | ok: Runtime: 0:00:00.004303 2026-04-24 01:02:17.391919 | 2026-04-24 01:02:17.391982 | TASK [upload-logs : Upload logs to log server] 2026-04-24 01:02:17.845667 | localhost | Output suppressed because no_log was given 2026-04-24 01:02:17.849393 | 2026-04-24 01:02:17.849456 | LOOP [upload-logs : Compress console log and json output] 2026-04-24 01:02:17.898522 | localhost | skipping: Conditional result was False 2026-04-24 01:02:17.904791 | localhost | skipping: Conditional result was False 2026-04-24 01:02:17.918178 | 2026-04-24 01:02:17.918273 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-24 01:02:17.963493 | localhost | skipping: Conditional result was False 2026-04-24 01:02:17.963938 | 2026-04-24 01:02:17.969081 | localhost | skipping: Conditional result was False 2026-04-24 01:02:17.983800 | 2026-04-24 01:02:17.983893 | LOOP [upload-logs : Upload console log and json output]