2026-04-04 10:10:48.163905 | Job console starting
2026-04-04 10:10:48.314713 | Updating git repos
2026-04-04 10:10:48.353608 | Cloning repos into workspace
2026-04-04 10:10:49.798448 | Restoring repo states
2026-04-04 10:10:49.808793 | Merging changes
2026-04-04 10:10:50.675958 | Checking out repos
2026-04-04 10:10:50.876219 | Preparing playbooks
2026-04-04 10:11:01.910116 | Running Ansible setup
2026-04-04 10:11:10.238363 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-04 10:11:10.838702 | 
2026-04-04 10:11:10.838864 | PLAY [localhost]
2026-04-04 10:11:10.846670 | 
2026-04-04 10:11:10.846803 | TASK [Gathering Facts]
2026-04-04 10:11:11.825570 | localhost | ok
2026-04-04 10:11:11.847733 | 
2026-04-04 10:11:11.847970 | TASK [Setup log path fact]
2026-04-04 10:11:11.869097 | localhost | ok
2026-04-04 10:11:11.882766 | 
2026-04-04 10:11:11.883546 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-04 10:11:11.923478 | localhost | ok
2026-04-04 10:11:11.940053 | 
2026-04-04 10:11:11.940152 | TASK [emit-job-header : Print job information]
2026-04-04 10:11:11.984220 | # Job Information
2026-04-04 10:11:12.133216 | Ansible Version: 2.16.16
2026-04-04 10:11:12.133409 | Job: ansible-collection-containers-molecule-docker-debian-trixie
2026-04-04 10:11:12.133470 | Pipeline: check
2026-04-04 10:11:12.133518 | Executor: 0a8996d2b663
2026-04-04 10:11:12.133563 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/106
2026-04-04 10:11:12.133615 | Event ID: f6253a90-2fbf-11f1-9abc-054f17db168c
2026-04-04 10:11:12.139707 | 
2026-04-04 10:11:12.139804 | LOOP [emit-job-header : Print node information]
2026-04-04 10:11:12.236656 | localhost | ok:
2026-04-04 10:11:12.236925 | localhost | # Node Information
2026-04-04 10:11:12.236980 | localhost | Inventory Hostname: debian-trixie
2026-04-04 10:11:12.237006 | localhost | Hostname: np0000163488
2026-04-04 10:11:12.237026 | localhost | Username: zuul
2026-04-04 10:11:12.237049 | localhost | Distro: Debian 13.4
2026-04-04 10:11:12.237069 | localhost | Provider: yul1
2026-04-04 10:11:12.237088 | localhost | Region: ca-ymq-1
2026-04-04 10:11:12.237107 | localhost | Label: debian-trixie
2026-04-04 10:11:12.237125 | localhost | Product Name: OpenStack Nova
2026-04-04 10:11:12.237144 | localhost | Interface IP: 199.19.213.145
2026-04-04 10:11:12.257745 | 
2026-04-04 10:11:12.257940 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-04 10:11:12.761938 | localhost -> localhost | changed
2026-04-04 10:11:12.768064 | 
2026-04-04 10:11:12.768173 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-04 10:11:13.927921 | localhost -> localhost | changed
2026-04-04 10:11:13.938645 | 
2026-04-04 10:11:13.938744 | PLAY [all]
2026-04-04 10:11:13.945993 | 
2026-04-04 10:11:13.946099 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-04 10:11:14.219057 | debian-trixie -> localhost | ok
2026-04-04 10:11:14.227960 | 
2026-04-04 10:11:14.228067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-04 10:11:14.257943 | debian-trixie | ok
2026-04-04 10:11:14.288896 | debian-trixie | included: /var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-04 10:11:14.293644 | 
2026-04-04 10:11:14.293709 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-04 10:11:15.540632 | debian-trixie -> localhost | Generating public/private rsa key pair.
2026-04-04 10:11:15.541126 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/45b1bf9284c74ddeb844c6891f5acf76_id_rsa
2026-04-04 10:11:15.541187 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/45b1bf9284c74ddeb844c6891f5acf76_id_rsa.pub
2026-04-04 10:11:15.541226 | debian-trixie -> localhost | The key fingerprint is:
2026-04-04 10:11:15.541263 | debian-trixie -> localhost | SHA256:LPzRBjq1uq5fkSjd3zD6N9yOTcNegbyD96FCOgHlogU zuul-build-sshkey
2026-04-04 10:11:15.541313 | debian-trixie -> localhost | The key's randomart image is:
2026-04-04 10:11:15.541346 | debian-trixie -> localhost | +---[RSA 3072]----+
2026-04-04 10:11:15.541388 | debian-trixie -> localhost | |                 |
2026-04-04 10:11:15.541423 | debian-trixie -> localhost | |     E   .       |
2026-04-04 10:11:15.541455 | debian-trixie -> localhost | |      . =        |
2026-04-04 10:11:15.541487 | debian-trixie -> localhost | |     o X *  . .  |
2026-04-04 10:11:15.541518 | debian-trixie -> localhost | |    . X S =  o . |
2026-04-04 10:11:15.541549 | debian-trixie -> localhost | |     o = B =... .|
2026-04-04 10:11:15.541580 | debian-trixie -> localhost | |      . + =o.=+..|
2026-04-04 10:11:15.541610 | debian-trixie -> localhost | |       o + .===o.|
2026-04-04 10:11:15.541645 | debian-trixie -> localhost | |    .++   o.o++. |
2026-04-04 10:11:15.541677 | debian-trixie -> localhost | +----[SHA256]-----+
2026-04-04 10:11:15.541763 | debian-trixie -> localhost | ok: Runtime: 0:00:00.454470
2026-04-04 10:11:15.548166 | 
2026-04-04 10:11:15.548293 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-04 10:11:15.582621 | debian-trixie | ok
2026-04-04 10:11:15.592474 | debian-trixie | included: /var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-04 10:11:15.600184 | 
2026-04-04 10:11:15.600331 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-04 10:11:15.626085 | debian-trixie | skipping: Conditional result was False
2026-04-04 10:11:15.637094 | 
2026-04-04 10:11:15.637259 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-04 10:11:16.199230 | debian-trixie | changed
2026-04-04 10:11:16.205875 | 
2026-04-04 10:11:16.206004 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-04 10:11:16.410515 | debian-trixie | ok
2026-04-04 10:11:16.416329 | 
2026-04-04 10:11:16.416416 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-04 10:11:16.944899 | debian-trixie | changed
2026-04-04 10:11:16.950777 | 
2026-04-04 10:11:16.950869 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-04 10:11:17.484984 | debian-trixie | changed
2026-04-04 10:11:17.490800 | 
2026-04-04 10:11:17.490887 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-04 10:11:17.515720 | debian-trixie | skipping: Conditional result was False
2026-04-04 10:11:17.523984 | 
2026-04-04 10:11:17.524077 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-04 10:11:17.935075 | debian-trixie -> localhost | changed
2026-04-04 10:11:17.945723 | 
2026-04-04 10:11:17.945813 | TASK [add-build-sshkey : Add back temp key]
2026-04-04 10:11:18.226591 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/45b1bf9284c74ddeb844c6891f5acf76_id_rsa (zuul-build-sshkey)
2026-04-04 10:11:18.226792 | debian-trixie -> localhost | ok: Runtime: 0:00:00.019560
2026-04-04 10:11:18.230728 | 
2026-04-04 10:11:18.230790 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-04 10:11:18.588029 | debian-trixie | ok
2026-04-04 10:11:18.594166 | 
2026-04-04 10:11:18.594332 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-04 10:11:18.619831 | debian-trixie | skipping: Conditional result was False
2026-04-04 10:11:18.634390 | 
2026-04-04 10:11:18.634492 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-04 10:11:18.987203 | debian-trixie | ok
2026-04-04 10:11:18.995300 | 
2026-04-04 10:11:18.995407 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-04 10:11:20.020917 | debian-trixie | Output suppressed because no_log was given
2026-04-04 10:11:20.028913 | 
2026-04-04 10:11:20.029038 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-04 10:11:20.256436 | debian-trixie | ok: "logs"
2026-04-04 10:11:20.256668 | debian-trixie | ok: All items complete
2026-04-04 10:11:20.256697 | 
2026-04-04 10:11:20.446039 | debian-trixie | ok: "artifacts"
2026-04-04 10:11:20.632483 | debian-trixie | ok: "docs"
2026-04-04 10:11:20.647577 | 
2026-04-04 10:11:20.647829 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-04 10:11:20.875081 | debian-trixie | changed: "logs"
2026-04-04 10:11:21.078189 | debian-trixie | changed: "artifacts"
2026-04-04 10:11:21.256563 | debian-trixie | changed: "docs"
2026-04-04 10:11:21.272581 | 
2026-04-04 10:11:21.272694 | PLAY RECAP
2026-04-04 10:11:21.272739 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-04 10:11:21.272768 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-04 10:11:21.272791 | 
2026-04-04 10:11:21.405895 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-04 10:11:21.408455 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-04 10:11:22.100802 | 
2026-04-04 10:11:22.101008 | PLAY [all]
2026-04-04 10:11:22.113380 | 
2026-04-04 10:11:22.113534 | TASK [setup-uv : Extract archive]
2026-04-04 10:11:24.460707 | debian-trixie | changed
2026-04-04 10:11:24.468863 | 
2026-04-04 10:11:24.469039 | TASK [setup-uv : Print version]
2026-04-04 10:11:24.881845 | debian-trixie | uv 0.8.13
2026-04-04 10:11:25.002382 | debian-trixie | ok: Runtime: 0:00:00.014627
2026-04-04 10:11:25.106803 | 
2026-04-04 10:11:25.106894 | PLAY RECAP
2026-04-04 10:11:25.106942 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-04 10:11:25.106991 | 
2026-04-04 10:11:25.315932 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-04 10:11:25.318367 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-04 10:11:25.942522 | 
2026-04-04 10:11:25.942681 | PLAY [all]
2026-04-04 10:11:25.952502 | 
2026-04-04 10:11:25.952573 | TASK [Copy inventory file for Zuul]
2026-04-04 10:11:27.929930 | debian-trixie | changed
2026-04-04 10:11:27.935136 | 
2026-04-04 10:11:27.935232 | TASK [Switch "ansible_host" to private IP]
2026-04-04 10:11:28.230582 | debian-trixie | changed: 1 replacements made
2026-04-04 10:11:28.237559 | 
2026-04-04 10:11:28.237646 | TASK [Run Molecule scenario]
2026-04-04 10:11:28.694386 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-04-04 10:11:28.694467 | debian-trixie | Creating virtual environment at: .venv
2026-04-04 10:11:28.918409 | debian-trixie | Downloading pygments (1.2MiB)
2026-04-04 10:11:28.918554 | debian-trixie | Downloading cryptography (4.3MiB)
2026-04-04 10:11:28.919594 | debian-trixie | Downloading ansible-core (2.3MiB)
2026-04-04 10:11:29.083851 | debian-trixie |  Downloading cryptography
2026-04-04 10:11:29.128643 | debian-trixie |  Downloading pygments
2026-04-04 10:11:29.300975 | debian-trixie |  Downloading ansible-core
2026-04-04 10:11:29.349410 | debian-trixie | Installed 36 packages in 47ms
2026-04-04 10:11:30.016499 | debian-trixie | INFO     Collection 'vexxhost.containers' detected.
2026-04-04 10:11:30.016568 | debian-trixie | INFO     Scenarios will be used from 'extensions/molecule'
2026-04-04 10:11:30.898394 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-04-04 10:11:30.898457 | debian-trixie | INFO     default scenario not found, disabling shared state.
2026-04-04 10:11:30.898522 | debian-trixie | INFO     [docker > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-04-04 10:11:30.898659 | debian-trixie | INFO     [docker > prerun] Performing prerun with role_name_check=0...
2026-04-04 10:11:38.849328 | debian-trixie | INFO     [docker > dependency] Executing
2026-04-04 10:11:38.849454 | debian-trixie | WARNING  [docker > dependency] Missing roles requirements file: requirements.yml
2026-04-04 10:11:38.849670 | debian-trixie | WARNING  [docker > dependency] Missing collections requirements file: collections.yml
2026-04-04 10:11:38.849813 | debian-trixie | WARNING  [docker > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-04-04 10:11:38.855273 | debian-trixie | INFO     [docker > cleanup] Executing
2026-04-04 10:11:38.855566 | debian-trixie | WARNING  [docker > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-04 10:11:38.860925 | debian-trixie | INFO     [docker > destroy] Executing
2026-04-04 10:11:38.860983 | debian-trixie | WARNING  [docker > destroy] Skipping, '--destroy=never' requested.
2026-04-04 10:11:38.861059 | debian-trixie | INFO     [docker > destroy] Executed: Successful
2026-04-04 10:11:38.866318 | debian-trixie | INFO     [docker > syntax] Executing
2026-04-04 10:11:39.357244 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-04 10:11:39.357295 | 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-04 10:11:39.357305 | 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-04 10:11:39.357315 | debian-trixie |
2026-04-04 10:11:39.782538 | debian-trixie |
2026-04-04 10:11:39.782704 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml
2026-04-04 10:11:39.847516 | debian-trixie | INFO     [docker > syntax] Executed: Successful
2026-04-04 10:11:39.858869 | debian-trixie | INFO     [docker > create] Executing
2026-04-04 10:11:39.861084 | debian-trixie | WARNING  [docker > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-04 10:11:39.868030 | debian-trixie | INFO     [docker > prepare] Executing
2026-04-04 10:11:40.346792 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-04 10:11:40.346818 | 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-04 10:11:40.346823 | 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-04 10:11:40.346828 | debian-trixie |
2026-04-04 10:11:40.691921 | debian-trixie |
2026-04-04 10:11:40.692171 | debian-trixie | PLAY [Prepare] *****************************************************************
2026-04-04 10:11:40.692353 | debian-trixie |
2026-04-04 10:11:40.692553 | debian-trixie | TASK [Gathering Facts] *********************************************************
2026-04-04 10:11:40.692748 | debian-trixie | Saturday 04 April 2026  10:11:40 +0000 (0:00:00.029)       0:00:00.029 ********
2026-04-04 10:11:41.940320 | 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-04 10:11:41.943149 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:41.943357 | debian-trixie |
2026-04-04 10:11:41.943570 | debian-trixie | TASK [Update "apt" cache] ******************************************************
2026-04-04 10:11:41.943775 | debian-trixie | Saturday 04 April 2026  10:11:41 +0000 (0:00:01.250)       0:00:01.280 ********
2026-04-04 10:11:46.696671 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:46.696885 | debian-trixie |
2026-04-04 10:11:46.697172 | debian-trixie | PLAY RECAP *********************************************************************
2026-04-04 10:11:46.697535 | debian-trixie | debian-trixie              : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-04 10:11:46.697675 | debian-trixie |
2026-04-04 10:11:46.697786 | debian-trixie |
2026-04-04 10:11:46.697956 | debian-trixie | TASKS RECAP ********************************************************************
2026-04-04 10:11:46.698026 | debian-trixie | Saturday 04 April 2026  10:11:46 +0000 (0:00:04.754)       0:00:06.034 ********
2026-04-04 10:11:46.698159 | debian-trixie | ===============================================================================
2026-04-04 10:11:46.698295 | debian-trixie | Update "apt" cache ------------------------------------------------------ 4.75s
2026-04-04 10:11:46.698459 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.25s
2026-04-04 10:11:46.780207 | debian-trixie | INFO     [docker > prepare] Executed: Successful
2026-04-04 10:11:46.790475 | debian-trixie | INFO     [docker > converge] Executing
2026-04-04 10:11:47.285264 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-04 10:11:47.285312 | 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-04 10:11:47.285322 | 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-04 10:11:47.285331 | debian-trixie |
2026-04-04 10:11:47.692877 | debian-trixie |
2026-04-04 10:11:47.693018 | debian-trixie | PLAY [Converge] ****************************************************************
2026-04-04 10:11:47.693257 | debian-trixie |
2026-04-04 10:11:47.693498 | debian-trixie | TASK [Gathering Facts] *********************************************************
2026-04-04 10:11:47.693633 | debian-trixie | Saturday 04 April 2026  10:11:47 +0000 (0:00:00.017)       0:00:00.017 ********
2026-04-04 10:11:48.747544 | 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-04 10:11:48.750516 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:48.750707 | debian-trixie |
2026-04-04 10:11:48.750902 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-04 10:11:48.751141 | debian-trixie | Saturday 04 April 2026  10:11:48 +0000 (0:00:01.060)       0:00:01.077 ********
2026-04-04 10:11:49.238008 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:49.238176 | debian-trixie |
2026-04-04 10:11:49.238388 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-04 10:11:49.238594 | debian-trixie | Saturday 04 April 2026  10:11:49 +0000 (0:00:00.485)       0:00:01.563 ********
2026-04-04 10:11:49.272564 | debian-trixie | skipping: [debian-trixie]
2026-04-04 10:11:49.272671 | debian-trixie |
2026-04-04 10:11:49.272886 | debian-trixie | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-04-04 10:11:49.273113 | debian-trixie | Saturday 04 April 2026  10:11:49 +0000 (0:00:00.036)       0:00:01.599 ********
2026-04-04 10:11:49.714344 | debian-trixie | changed: [debian-trixie]
2026-04-04 10:11:49.714386 | debian-trixie |
2026-04-04 10:11:49.714402 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-04 10:11:49.714484 | debian-trixie | Saturday 04 April 2026  10:11:49 +0000 (0:00:00.432)       0:00:02.032 ********
2026-04-04 10:11:49.802274 | debian-trixie | ok: [debian-trixie] => {
2026-04-04 10:11:49.802459 | debian-trixie |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.1/runc.amd64"
2026-04-04 10:11:49.802639 | debian-trixie | }
2026-04-04 10:11:49.802817 | debian-trixie |
2026-04-04 10:11:49.803014 | debian-trixie | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-04 10:11:49.803208 | debian-trixie | Saturday 04 April 2026  10:11:49 +0000 (0:00:00.096)       0:00:02.128 ********
2026-04-04 10:11:50.637339 | 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-04 10:11:50.641565 | debian-trixie | changed: [debian-trixie]
2026-04-04 10:11:50.641758 | debian-trixie |
2026-04-04 10:11:50.641959 | debian-trixie | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-04 10:11:50.642286 | debian-trixie | Saturday 04 April 2026  10:11:50 +0000 (0:00:00.839)       0:00:02.968 ********
2026-04-04 10:11:50.663004 | debian-trixie | skipping: [debian-trixie]
2026-04-04 10:11:50.663171 | debian-trixie |
2026-04-04 10:11:50.663373 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-04 10:11:50.663572 | debian-trixie | Saturday 04 April 2026  10:11:50 +0000 (0:00:00.021)       0:00:02.989 ********
2026-04-04 10:11:50.692579 | debian-trixie | skipping: [debian-trixie]
2026-04-04 10:11:50.692731 | debian-trixie |
2026-04-04 10:11:50.692911 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-04 10:11:50.693100 | debian-trixie | Saturday 04 April 2026  10:11:50 +0000 (0:00:00.029)       0:00:03.019 ********
2026-04-04 10:11:50.996381 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:50.996484 | debian-trixie |
2026-04-04 10:11:50.996632 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-04 10:11:50.996761 | debian-trixie | Saturday 04 April 2026  10:11:50 +0000 (0:00:00.303)       0:00:03.323 ********
2026-04-04 10:11:51.967067 | debian-trixie | ok: [debian-trixie]
2026-04-04 10:11:51.967237 | debian-trixie |
2026-04-04 10:11:51.967443 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-04 10:11:51.967638 | debian-trixie | Saturday 04 April 2026  10:11:51 +0000 (0:00:00.968)       0:00:04.292 ********
2026-04-04 10:11:52.027506 | 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-04 10:11:52.027654 | debian-trixie |
2026-04-04 10:11:52.027847 | debian-trixie | Task failed.
2026-04-04 10:11:52.028062 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3
2026-04-04 10:11:52.028229 | debian-trixie |
2026-04-04 10:11:52.028418 | debian-trixie | 13 # under the License.
2026-04-04 10:11:52.028598 | debian-trixie | 14
2026-04-04 10:11:52.028790 | debian-trixie | 15 - name: Starting download of file
2026-04-04 10:11:52.028965 | debian-trixie |      ^ column 3
2026-04-04 10:11:52.029134 | debian-trixie |
2026-04-04 10:11:52.029391 | debian-trixie | <<< caused by >>>
2026-04-04 10:11:52.029547 | debian-trixie |
2026-04-04 10:11:52.029752 | debian-trixie | Finalization of task args for 'ansible.builtin.debug' failed.
2026-04-04 10:11:52.029954 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3
2026-04-04 10:11:52.030122 | debian-trixie |
2026-04-04 10:11:52.030296 | debian-trixie | 14
2026-04-04 10:11:52.030479 | debian-trixie | 15 - name: Starting download of file
2026-04-04 10:11:52.030661 | debian-trixie | 16   ansible.builtin.debug:
2026-04-04 10:11:52.030841 | debian-trixie |      ^ column 3
2026-04-04 10:11:52.031007 | debian-trixie |
2026-04-04 10:11:52.031188 | debian-trixie | <<< caused by >>>
2026-04-04 10:11:52.031355 | debian-trixie |
2026-04-04 10:11:52.031538 | debian-trixie | Error while resolving value for 'msg'.
2026-04-04 10:11:52.031738 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10
2026-04-04 10:11:52.031905 | debian-trixie |
2026-04-04 10:11:52.032092 | debian-trixie | 15 - name: Starting download of file
2026-04-04 10:11:52.032274 | debian-trixie | 16   ansible.builtin.debug:
2026-04-04 10:11:52.032459 | debian-trixie | 17     msg: "{{ download_artifact_url }}"
2026-04-04 10:11:52.032639 | debian-trixie |             ^ column 10
2026-04-04 10:11:52.032810 | debian-trixie |
2026-04-04 10:11:52.032991 | debian-trixie | <<< caused by >>>
2026-04-04 10:11:52.033191 | debian-trixie |
2026-04-04 10:11:52.033386 | debian-trixie | object of type 'NoneType' has no attribute 'keys'
2026-04-04 10:11:52.033671 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22
2026-04-04 10:11:52.033873 | debian-trixie |
2026-04-04 10:11:52.034065 | debian-trixie | 13 # under the License.
2026-04-04 10:11:52.034257 | debian-trixie | 14
2026-04-04 10:11:52.034464 | debian-trixie | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}"
2026-04-04 10:11:52.034632 | debian-trixie |                         ^ column 22
2026-04-04 10:11:52.034782 | debian-trixie |
2026-04-04 10:11:52.034985 | 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-04 10:11:52.035094 | debian-trixie |
2026-04-04 10:11:52.035209 | debian-trixie | PLAY RECAP *********************************************************************
2026-04-04 10:11:52.035336 | debian-trixie | debian-trixie              : ok=7    changed=2    unreachable=0    failed=1    skipped=3    rescued=0    ignored=0
2026-04-04 10:11:52.035440 | debian-trixie |
2026-04-04 10:11:52.035547 | debian-trixie |
2026-04-04 10:11:52.035672 | debian-trixie | TASKS RECAP ********************************************************************
2026-04-04 10:11:52.035793 | debian-trixie | Saturday 04 April 2026  10:11:52 +0000 (0:00:00.064)       0:00:04.356 ********
2026-04-04 10:11:52.035908 | debian-trixie | ===============================================================================
2026-04-04 10:11:52.036024 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.06s
2026-04-04 10:11:52.036142 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.97s
2026-04-04 10:11:52.036296 | debian-trixie | vexxhost.containers.download_artifact : Download item ------------------- 0.84s
2026-04-04 10:11:52.036466 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-04-04 10:11:52.036598 | debian-trixie | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s
2026-04-04 10:11:52.036717 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.30s
2026-04-04 10:11:52.036834 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.10s
2026-04-04 10:11:52.036952 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s
2026-04-04 10:11:52.037070 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s
2026-04-04 10:11:52.037215 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.03s
2026-04-04 10:11:52.037334 | debian-trixie | vexxhost.containers.download_artifact : Extract archive ----------------- 0.02s
2026-04-04 10:11:52.135638 | 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-04 10:11:52.135785 | debian-trixie | ERROR    [docker > converge] Executed: Failed
2026-04-04 10:11:52.135909 | 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-04 10:11:52.334980 | debian-trixie | ERROR
2026-04-04 10:11:52.335249 | debian-trixie | {
2026-04-04 10:11:52.335292 | debian-trixie |   "delta": "0:00:23.601510",
2026-04-04 10:11:52.335322 | debian-trixie |   "end": "2026-04-04 10:11:52.214868",
2026-04-04 10:11:52.335348 | debian-trixie |   "msg": "non-zero return code",
2026-04-04 10:11:52.335373 | debian-trixie |   "rc": 2,
2026-04-04 10:11:52.335405 | debian-trixie |   "start": "2026-04-04 10:11:28.613358"
2026-04-04 10:11:52.335430 | debian-trixie | }
failure
2026-04-04 10:11:52.339209 | 
2026-04-04 10:11:52.339260 | PLAY RECAP
2026-04-04 10:11:52.339305 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-04-04 10:11:52.339328 | 
2026-04-04 10:11:52.591238 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-04 10:11:52.592832 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-04 10:11:53.183913 | 
2026-04-04 10:11:53.284208 | PLAY [all]
2026-04-04 10:11:53.301259 | 
2026-04-04 10:11:53.301360 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-04 10:11:53.356625 | debian-trixie | skipping: Conditional result was False
2026-04-04 10:11:53.366595 | 
2026-04-04 10:11:53.366690 | TASK [fetch-output : Set log path for single node]
2026-04-04 10:11:53.409144 | debian-trixie | ok
2026-04-04 10:11:53.416156 | 
2026-04-04 10:11:53.416264 | LOOP [fetch-output : Ensure local output dirs]
2026-04-04 10:11:54.376063 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/logs"
2026-04-04 10:11:54.612550 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/artifacts"
2026-04-04 10:11:54.821876 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/45b1bf9284c74ddeb844c6891f5acf76/work/docs"
2026-04-04 10:11:54.837905 | 
2026-04-04 10:11:54.838031 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-04 10:11:55.508625 | debian-trixie | changed: .d..t...... ./
2026-04-04 10:11:55.508814 | debian-trixie | changed: All items complete
2026-04-04 10:11:55.508842 | 
2026-04-04 10:11:56.510097 | debian-trixie | changed: .d..t...... ./
2026-04-04 10:11:57.019568 | debian-trixie | changed: .d..t...... ./
2026-04-04 10:11:57.039888 | 
2026-04-04 10:11:57.040162 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-04 10:11:57.663956 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.010867
2026-04-04 10:11:57.956449 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.008813
2026-04-04 10:11:57.970021 | 
2026-04-04 10:11:57.970156 | PLAY [all]
2026-04-04 10:11:57.977068 | 
2026-04-04 10:11:57.977133 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-04 10:11:58.455253 | debian-trixie | changed
2026-04-04 10:11:58.462085 | 
2026-04-04 10:11:58.462153 | PLAY RECAP
2026-04-04 10:11:58.462214 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-04 10:11:58.462249 | 
2026-04-04 10:11:58.654128 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-04 10:11:58.664719 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-04 10:11:59.326786 | 
2026-04-04 10:11:59.326930 | PLAY [localhost]
2026-04-04 10:11:59.343024 | 
2026-04-04 10:11:59.343223 | TASK [Generate Zuul manifest]
2026-04-04 10:11:59.363928 | localhost | ok
2026-04-04 10:11:59.383592 | 
2026-04-04 10:11:59.383767 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-04 10:11:59.731850 | localhost | changed
2026-04-04 10:11:59.757042 | 
2026-04-04 10:11:59.757194 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-04 10:11:59.800773 | localhost | ok
2026-04-04 10:11:59.810263 | 
2026-04-04 10:11:59.810336 | TASK [Upload logs]
2026-04-04 10:11:59.830727 | localhost | ok
2026-04-04 10:11:59.931041 | 
2026-04-04 10:11:59.940242 | TASK [Set zuul-log-path fact]
2026-04-04 10:11:59.965703 | localhost | ok
2026-04-04 10:11:59.978790 | 
2026-04-04 10:11:59.978878 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-04 10:12:00.010394 | localhost | ok
2026-04-04 10:12:00.019879 | 
2026-04-04 10:12:00.019965 | TASK [upload-logs : Create log directories]
2026-04-04 10:12:00.498904 | localhost | changed
2026-04-04 10:12:00.503821 | 
2026-04-04 10:12:00.503904 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-04 10:12:00.980582 | localhost -> localhost | ok: Runtime: 0:00:00.005851
2026-04-04 10:12:00.987204 | 
2026-04-04 10:12:00.987292 | TASK [upload-logs : Upload logs to log server]
2026-04-04 10:12:01.539492 | localhost | Output suppressed because no_log was given
2026-04-04 10:12:01.545412 | 
2026-04-04 10:12:01.545491 | LOOP [upload-logs : Compress console log and json output]
2026-04-04 10:12:01.593274 | localhost | skipping: Conditional result was False
2026-04-04 10:12:01.601105 | localhost | skipping: Conditional result was False
2026-04-04 10:12:01.618441 | 
2026-04-04 10:12:01.618618 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-04 10:12:01.661383 | localhost | skipping: Conditional result was False
2026-04-04 10:12:01.661664 | 
2026-04-04 10:12:01.667363 | localhost | skipping: Conditional result was False
2026-04-04 10:12:01.683043 | 
2026-04-04 10:12:01.683277 | LOOP [upload-logs : Upload console log and json output]