2026-04-28 01:03:58.821269 | Job console starting
2026-04-28 01:03:58.830620 | Updating git repos
2026-04-28 01:03:58.853812 | Cloning repos into workspace
2026-04-28 01:03:59.100321 | Restoring repo states
2026-04-28 01:03:59.109948 | Merging changes
2026-04-28 01:03:59.369426 | Checking out repos
2026-04-28 01:03:59.413831 | Preparing playbooks
2026-04-28 01:04:00.539452 | Running Ansible setup
2026-04-28 01:04:05.012938 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 01:04:05.609730 | 
2026-04-28 01:04:05.609878 | PLAY [localhost]
2026-04-28 01:04:05.617539 | 
2026-04-28 01:04:05.617629 | TASK [Gathering Facts]
2026-04-28 01:04:07.103269 | localhost | ok
2026-04-28 01:04:07.111734 | 
2026-04-28 01:04:07.111843 | TASK [Setup log path fact]
2026-04-28 01:04:07.137347 | localhost | ok
2026-04-28 01:04:07.149662 | 
2026-04-28 01:04:07.149764 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 01:04:07.182798 | localhost | ok
2026-04-28 01:04:07.191688 | 
2026-04-28 01:04:07.191763 | TASK [emit-job-header : Print job information]
2026-04-28 01:04:07.233368 | # Job Information
2026-04-28 01:04:07.233608 | Ansible Version: 2.16.16
2026-04-28 01:04:07.233667 | Job: ansible-collection-containers-molecule-docker-debian-trixie
2026-04-28 01:04:07.233701 | Pipeline: check
2026-04-28 01:04:07.233730 | Executor: 0a8996d2b663
2026-04-28 01:04:07.233756 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/125
2026-04-28 01:04:07.233787 | Event ID: 07f9bf70-429e-11f1-8b75-3e63c4c208bf
2026-04-28 01:04:07.238290 | 
2026-04-28 01:04:07.238382 | LOOP [emit-job-header : Print node information]
2026-04-28 01:04:07.333945 | localhost | ok:
2026-04-28 01:04:07.334128 | localhost | # Node Information
2026-04-28 01:04:07.334174 | localhost | Inventory Hostname: debian-trixie
2026-04-28 01:04:07.334204 | localhost | Hostname: np0000170745
2026-04-28 01:04:07.334229 | localhost | Username: zuul
2026-04-28 01:04:07.334259 | localhost | Distro: Debian 13.4
2026-04-28 01:04:07.334285 | localhost | Provider: yul1
2026-04-28 01:04:07.334310 | localhost | Region: ca-ymq-1
2026-04-28 01:04:07.334336 | localhost | Label: debian-trixie
2026-04-28 01:04:07.334362 | localhost | Product Name: OpenStack Nova
2026-04-28 01:04:07.334387 | localhost | Interface IP: 199.204.45.144
2026-04-28 01:04:07.354918 | 
2026-04-28 01:04:07.355036 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-28 01:04:08.276557 | localhost -> localhost | changed
2026-04-28 01:04:08.283225 | 
2026-04-28 01:04:08.283346 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-28 01:04:09.576256 | localhost -> localhost | changed
2026-04-28 01:04:09.584381 | 
2026-04-28 01:04:09.584457 | PLAY [all]
2026-04-28 01:04:09.591548 | 
2026-04-28 01:04:09.591620 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-28 01:04:10.213940 | debian-trixie -> localhost | ok
2026-04-28 01:04:10.224165 | 
2026-04-28 01:04:10.224231 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-28 01:04:10.253849 | debian-trixie | ok
2026-04-28 01:04:10.270074 | debian-trixie | included: /var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-28 01:04:10.274953 | 
2026-04-28 01:04:10.275016 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-28 01:04:12.550743 | debian-trixie -> localhost | Generating public/private rsa key pair.
2026-04-28 01:04:12.551279 | debian-trixie -> localhost | Your identification has been saved in /var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/39a8dbc5c0b942e297f62dd399f4427f_id_rsa
2026-04-28 01:04:12.551338 | debian-trixie -> localhost | Your public key has been saved in /var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/39a8dbc5c0b942e297f62dd399f4427f_id_rsa.pub
2026-04-28 01:04:12.551404 | debian-trixie -> localhost | The key fingerprint is:
2026-04-28 01:04:12.551447 | debian-trixie -> localhost | SHA256:I8xfxRGWvuhuLVnTejeg2y0RrDmsPm0+hauGwOmgd+w zuul-build-sshkey
2026-04-28 01:04:12.551494 | debian-trixie -> localhost | The key's randomart image is:
2026-04-28 01:04:12.551526 | debian-trixie -> localhost | +---[RSA 3072]----+
2026-04-28 01:04:12.551566 | debian-trixie -> localhost | |            +o   |
2026-04-28 01:04:12.552227 | debian-trixie -> localhost | |           o..   |
2026-04-28 01:04:12.552291 | debian-trixie -> localhost | |           .+    |
2026-04-28 01:04:12.552327 | debian-trixie -> localhost | |     o     ..o   |
2026-04-28 01:04:12.552358 | debian-trixie -> localhost | |    . = S o.+o.  |
2026-04-28 01:04:12.552388 | debian-trixie -> localhost | |   . + o o.*++.  |
2026-04-28 01:04:12.552443 | debian-trixie -> localhost | |  . + . o.o+=oo  |
2026-04-28 01:04:12.552497 | debian-trixie -> localhost | | . . + . +=*+.o..|
2026-04-28 01:04:12.552532 | debian-trixie -> localhost | |  . oE  o=*+oo.o.|
2026-04-28 01:04:12.552562 | debian-trixie -> localhost | +----[SHA256]-----+
2026-04-28 01:04:12.552649 | debian-trixie -> localhost | ok: Runtime: 0:00:01.627960
2026-04-28 01:04:12.561538 | 
2026-04-28 01:04:12.561632 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-28 01:04:12.591755 | debian-trixie | ok
2026-04-28 01:04:12.599668 | debian-trixie | included: /var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-28 01:04:12.606242 | 
2026-04-28 01:04:12.606317 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-28 01:04:12.630762 | debian-trixie | skipping: Conditional result was False
2026-04-28 01:04:12.635755 | 
2026-04-28 01:04:12.635828 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-28 01:04:13.296834 | debian-trixie | changed
2026-04-28 01:04:13.397634 | 
2026-04-28 01:04:13.398272 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-28 01:04:13.630110 | debian-trixie | ok
2026-04-28 01:04:13.634319 | 
2026-04-28 01:04:13.634382 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-28 01:04:14.161605 | debian-trixie | changed
2026-04-28 01:04:14.166224 | 
2026-04-28 01:04:14.166293 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-28 01:04:14.696087 | debian-trixie | changed
2026-04-28 01:04:14.819654 | 
2026-04-28 01:04:14.819789 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-28 01:04:14.854589 | debian-trixie | skipping: Conditional result was False
2026-04-28 01:04:14.859528 | 
2026-04-28 01:04:14.859607 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-28 01:04:15.515611 | debian-trixie -> localhost | changed
2026-04-28 01:04:15.524829 | 
2026-04-28 01:04:15.524912 | TASK [add-build-sshkey : Add back temp key]
2026-04-28 01:04:15.890219 | debian-trixie -> localhost | Identity added: /var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/39a8dbc5c0b942e297f62dd399f4427f_id_rsa (zuul-build-sshkey)
2026-04-28 01:04:15.890412 | debian-trixie -> localhost | ok: Runtime: 0:00:00.024125
2026-04-28 01:04:15.895144 | 
2026-04-28 01:04:15.895227 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-28 01:04:16.234814 | debian-trixie | ok
2026-04-28 01:04:16.459662 | 
2026-04-28 01:04:16.459808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-28 01:04:16.484351 | debian-trixie | skipping: Conditional result was False
2026-04-28 01:04:16.497829 | 
2026-04-28 01:04:16.497902 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-28 01:04:16.893703 | debian-trixie | ok
2026-04-28 01:04:16.900366 | 
2026-04-28 01:04:16.900443 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-28 01:04:17.848230 | debian-trixie | Output suppressed because no_log was given
2026-04-28 01:04:17.855098 | 
2026-04-28 01:04:17.855175 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-28 01:04:18.070755 | debian-trixie | ok: "logs"
2026-04-28 01:04:18.071038 | debian-trixie | ok: All items complete
2026-04-28 01:04:18.071082 | 
2026-04-28 01:04:18.245720 | debian-trixie | ok: "artifacts"
2026-04-28 01:04:18.427017 | debian-trixie | ok: "docs"
2026-04-28 01:04:18.435786 | 
2026-04-28 01:04:18.435920 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-28 01:04:18.649367 | debian-trixie | changed: "logs"
2026-04-28 01:04:18.833139 | debian-trixie | changed: "artifacts"
2026-04-28 01:04:19.018064 | debian-trixie | changed: "docs"
2026-04-28 01:04:19.031962 | 
2026-04-28 01:04:19.032078 | PLAY RECAP
2026-04-28 01:04:19.032122 | debian-trixie | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-28 01:04:19.032153 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:04:19.032180 | 
2026-04-28 01:04:19.164985 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-28 01:04:19.166089 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-28 01:04:19.767407 | 
2026-04-28 01:04:19.767565 | PLAY [all]
2026-04-28 01:04:19.777863 | 
2026-04-28 01:04:19.777943 | TASK [setup-uv : Extract archive]
2026-04-28 01:04:22.066163 | debian-trixie | changed
2026-04-28 01:04:22.071230 | 
2026-04-28 01:04:22.071312 | TASK [setup-uv : Print version]
2026-04-28 01:04:22.441672 | debian-trixie | uv 0.8.13
2026-04-28 01:04:22.602109 | debian-trixie | ok: Runtime: 0:00:00.011824
2026-04-28 01:04:22.608114 | 
2026-04-28 01:04:22.608164 | PLAY RECAP
2026-04-28 01:04:22.608215 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:04:22.608240 | 
2026-04-28 01:04:22.738017 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-28 01:04:22.739179 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-28 01:04:23.393646 | 
2026-04-28 01:04:23.393787 | PLAY [all]
2026-04-28 01:04:23.403998 | 
2026-04-28 01:04:23.404071 | TASK [Copy inventory file for Zuul]
2026-04-28 01:04:24.316506 | debian-trixie | changed
2026-04-28 01:04:24.322424 | 
2026-04-28 01:04:24.322544 | TASK [Switch "ansible_host" to private IP]
2026-04-28 01:04:24.654296 | debian-trixie | changed: 1 replacements made
2026-04-28 01:04:24.661190 | 
2026-04-28 01:04:24.661253 | TASK [Run Molecule scenario]
2026-04-28 01:04:25.088940 | debian-trixie | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-04-28 01:04:25.089035 | debian-trixie | Creating virtual environment at: .venv
2026-04-28 01:04:25.346653 | debian-trixie | Downloading pygments (1.2MiB)
2026-04-28 01:04:25.346838 | debian-trixie | Downloading ansible-core (2.3MiB)
2026-04-28 01:04:25.351282 | debian-trixie | Downloading cryptography (4.3MiB)
2026-04-28 01:04:25.492258 | debian-trixie |  Downloading cryptography
2026-04-28 01:04:25.547037 | debian-trixie |  Downloading pygments
2026-04-28 01:04:25.741106 | debian-trixie |  Downloading ansible-core
2026-04-28 01:04:25.787935 | debian-trixie | Installed 36 packages in 46ms
2026-04-28 01:04:26.482690 | debian-trixie | INFO     Collection 'vexxhost.containers' detected.
2026-04-28 01:04:26.482760 | debian-trixie | INFO     Scenarios will be used from 'extensions/molecule'
2026-04-28 01:04:27.337372 | debian-trixie | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-04-28 01:04:27.337426 | debian-trixie | INFO     default scenario not found, disabling shared state.
2026-04-28 01:04:27.337506 | debian-trixie | INFO     [docker > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-04-28 01:04:27.337567 | debian-trixie | INFO     [docker > prerun] Performing prerun with role_name_check=0...
2026-04-28 01:04:39.195212 | debian-trixie | INFO     [docker > dependency] Executing
2026-04-28 01:04:39.195528 | debian-trixie | WARNING  [docker > dependency] Missing roles requirements file: requirements.yml
2026-04-28 01:04:39.195813 | debian-trixie | WARNING  [docker > dependency] Missing collections requirements file: collections.yml
2026-04-28 01:04:39.195933 | debian-trixie | WARNING  [docker > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-04-28 01:04:39.203384 | debian-trixie | INFO     [docker > cleanup] Executing
2026-04-28 01:04:39.203750 | debian-trixie | WARNING  [docker > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-28 01:04:39.209168 | debian-trixie | INFO     [docker > destroy] Executing
2026-04-28 01:04:39.209199 | debian-trixie | WARNING  [docker > destroy] Skipping, '--destroy=never' requested.
2026-04-28 01:04:39.209243 | debian-trixie | INFO     [docker > destroy] Executed: Successful
2026-04-28 01:04:39.214843 | debian-trixie | INFO     [docker > syntax] Executing
2026-04-28 01:04:39.716139 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-28 01:04:39.716354 | 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-28 01:04:39.716597 | 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-28 01:04:39.716787 | debian-trixie |
2026-04-28 01:04:40.168565 | debian-trixie |
2026-04-28 01:04:40.168739 | debian-trixie | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker/converge.yml
2026-04-28 01:04:40.234324 | debian-trixie | INFO     [docker > syntax] Executed: Successful
2026-04-28 01:04:40.243924 | debian-trixie | INFO     [docker > create] Executing
2026-04-28 01:04:40.245984 | debian-trixie | WARNING  [docker > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-04-28 01:04:40.251279 | debian-trixie | INFO     [docker > prepare] Executing
2026-04-28 01:04:40.719164 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-28 01:04:40.719375 | 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-28 01:04:40.719612 | 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-28 01:04:40.719782 | debian-trixie |
2026-04-28 01:04:41.080029 | debian-trixie |
2026-04-28 01:04:41.080238 | debian-trixie | PLAY [Prepare] *****************************************************************
2026-04-28 01:04:41.080413 | debian-trixie |
2026-04-28 01:04:41.080616 | debian-trixie | TASK [Gathering Facts] *********************************************************
2026-04-28 01:04:41.080863 | debian-trixie | Tuesday 28 April 2026  01:04:41 +0000 (0:00:00.028)       0:00:00.028 *********
2026-04-28 01:04:42.327419 | 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-28 01:04:42.327779 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:42.327857 | debian-trixie |
2026-04-28 01:04:42.327943 | debian-trixie | TASK [Update "apt" cache] ******************************************************
2026-04-28 01:04:42.328036 | debian-trixie | Tuesday 28 April 2026  01:04:42 +0000 (0:00:01.248)       0:00:01.277 *********
2026-04-28 01:04:47.064766 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:47.064875 | debian-trixie |
2026-04-28 01:04:47.065068 | debian-trixie | PLAY RECAP *********************************************************************
2026-04-28 01:04:47.065328 | debian-trixie | debian-trixie              : ok=2    changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-04-28 01:04:47.065547 | debian-trixie |
2026-04-28 01:04:47.065677 | debian-trixie |
2026-04-28 01:04:47.065873 | debian-trixie | TASKS RECAP ********************************************************************
2026-04-28 01:04:47.066087 | debian-trixie | Tuesday 28 April 2026  01:04:47 +0000 (0:00:04.736)       0:00:06.014 *********
2026-04-28 01:04:47.066264 | debian-trixie | ===============================================================================
2026-04-28 01:04:47.066447 | debian-trixie | Update "apt" cache ------------------------------------------------------ 4.74s
2026-04-28 01:04:47.066634 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.25s
2026-04-28 01:04:47.153517 | debian-trixie | INFO     [docker > prepare] Executed: Successful
2026-04-28 01:04:47.162158 | debian-trixie | INFO     [docker > converge] Executing
2026-04-28 01:04:47.649001 | debian-trixie | [WARNING]: Deprecation warnings can be disabled by setting `deprecation_warnings=False` in ansible.cfg.
2026-04-28 01:04:47.649175 | 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-28 01:04:47.649381 | 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-28 01:04:47.649551 | debian-trixie |
2026-04-28 01:04:48.067503 | debian-trixie |
2026-04-28 01:04:48.067607 | debian-trixie | PLAY [Converge] ****************************************************************
2026-04-28 01:04:48.067830 | debian-trixie |
2026-04-28 01:04:48.068000 | debian-trixie | TASK [Gathering Facts] *********************************************************
2026-04-28 01:04:48.068200 | debian-trixie | Tuesday 28 April 2026  01:04:48 +0000 (0:00:00.017)       0:00:00.017 *********
2026-04-28 01:04:49.127400 | 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-28 01:04:49.130714 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:49.130924 | debian-trixie |
2026-04-28 01:04:49.131216 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-28 01:04:49.131651 | debian-trixie | Tuesday 28 April 2026  01:04:49 +0000 (0:00:01.065)       0:00:01.083 *********
2026-04-28 01:04:49.621898 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:49.622065 | debian-trixie |
2026-04-28 01:04:49.622268 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-28 01:04:49.622458 | debian-trixie | Tuesday 28 April 2026  01:04:49 +0000 (0:00:00.491)       0:00:01.574 *********
2026-04-28 01:04:49.654018 | debian-trixie | skipping: [debian-trixie]
2026-04-28 01:04:49.654184 | debian-trixie |
2026-04-28 01:04:49.654383 | debian-trixie | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-04-28 01:04:49.654580 | debian-trixie | Tuesday 28 April 2026  01:04:49 +0000 (0:00:00.032)       0:00:01.606 *********
2026-04-28 01:04:50.071528 | debian-trixie | changed: [debian-trixie]
2026-04-28 01:04:50.071705 | debian-trixie |
2026-04-28 01:04:50.071914 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-28 01:04:50.072113 | debian-trixie | Tuesday 28 April 2026  01:04:50 +0000 (0:00:00.416)       0:00:02.023 *********
2026-04-28 01:04:50.176083 | debian-trixie | ok: [debian-trixie] => {
2026-04-28 01:04:50.176277 | debian-trixie |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-04-28 01:04:50.176455 | debian-trixie | }
2026-04-28 01:04:50.176629 | debian-trixie |
2026-04-28 01:04:50.176828 | debian-trixie | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-04-28 01:04:50.177019 | debian-trixie | Tuesday 28 April 2026  01:04:50 +0000 (0:00:00.105)       0:00:02.128 *********
2026-04-28 01:04:51.019729 | 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-28 01:04:51.024918 | debian-trixie | changed: [debian-trixie]
2026-04-28 01:04:51.024998 | debian-trixie |
2026-04-28 01:04:51.025092 | debian-trixie | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-04-28 01:04:51.025183 | debian-trixie | Tuesday 28 April 2026  01:04:51 +0000 (0:00:00.849)       0:00:02.977 *********
2026-04-28 01:04:51.051654 | debian-trixie | skipping: [debian-trixie]
2026-04-28 01:04:51.051721 | debian-trixie |
2026-04-28 01:04:51.051823 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-28 01:04:51.051931 | debian-trixie | Tuesday 28 April 2026  01:04:51 +0000 (0:00:00.026)       0:00:03.004 *********
2026-04-28 01:04:51.090320 | debian-trixie | skipping: [debian-trixie]
2026-04-28 01:04:51.090479 | debian-trixie |
2026-04-28 01:04:51.090692 | debian-trixie | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-04-28 01:04:51.090921 | debian-trixie | Tuesday 28 April 2026  01:04:51 +0000 (0:00:00.037)       0:00:03.042 *********
2026-04-28 01:04:51.403005 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:51.403141 | debian-trixie |
2026-04-28 01:04:51.403554 | debian-trixie | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-04-28 01:04:51.403778 | debian-trixie | Tuesday 28 April 2026  01:04:51 +0000 (0:00:00.312)       0:00:03.355 *********
2026-04-28 01:04:52.393103 | debian-trixie | ok: [debian-trixie]
2026-04-28 01:04:52.393148 | debian-trixie |
2026-04-28 01:04:52.393297 | debian-trixie | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-04-28 01:04:52.393425 | debian-trixie | Tuesday 28 April 2026  01:04:52 +0000 (0:00:00.989)       0:00:04.345 *********
2026-04-28 01:04:52.457676 | 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-28 01:04:52.457853 | debian-trixie |
2026-04-28 01:04:52.458060 | debian-trixie | Task failed.
2026-04-28 01:04:52.458264 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:15:3
2026-04-28 01:04:52.458432 | debian-trixie |
2026-04-28 01:04:52.458645 | debian-trixie | 13 # under the License.
2026-04-28 01:04:52.458815 | debian-trixie | 14
2026-04-28 01:04:52.459043 | debian-trixie | 15 - name: Starting download of file
2026-04-28 01:04:52.459286 | debian-trixie |      ^ column 3
2026-04-28 01:04:52.459682 | debian-trixie |
2026-04-28 01:04:52.459917 | debian-trixie | <<< caused by >>>
2026-04-28 01:04:52.460111 | debian-trixie |
2026-04-28 01:04:52.460299 | debian-trixie | Finalization of task args for 'ansible.builtin.debug' failed.
2026-04-28 01:04:52.460502 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:16:3
2026-04-28 01:04:52.460693 | debian-trixie |
2026-04-28 01:04:52.460864 | debian-trixie | 14
2026-04-28 01:04:52.461046 | debian-trixie | 15 - name: Starting download of file
2026-04-28 01:04:52.461230 | debian-trixie | 16   ansible.builtin.debug:
2026-04-28 01:04:52.461408 | debian-trixie |      ^ column 3
2026-04-28 01:04:52.461597 | debian-trixie |
2026-04-28 01:04:52.461761 | debian-trixie | <<< caused by >>>
2026-04-28 01:04:52.461969 | debian-trixie |
2026-04-28 01:04:52.462138 | debian-trixie | Error while resolving value for 'msg'.
2026-04-28 01:04:52.462331 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:17:10
2026-04-28 01:04:52.462496 | debian-trixie |
2026-04-28 01:04:52.462679 | debian-trixie | 15 - name: Starting download of file
2026-04-28 01:04:52.462859 | debian-trixie | 16   ansible.builtin.debug:
2026-04-28 01:04:52.463043 | debian-trixie | 17     msg: "{{ download_artifact_url }}"
2026-04-28 01:04:52.463224 | debian-trixie |             ^ column 10
2026-04-28 01:04:52.463464 | debian-trixie |
2026-04-28 01:04:52.463628 | debian-trixie | <<< caused by >>>
2026-04-28 01:04:52.463791 | debian-trixie |
2026-04-28 01:04:52.463976 | debian-trixie | object of type 'NoneType' has no attribute 'keys'
2026-04-28 01:04:52.464173 | debian-trixie | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/containerd/defaults/main.yml:15:22
2026-04-28 01:04:52.464339 | debian-trixie |
2026-04-28 01:04:52.464519 | debian-trixie | 13 # under the License.
2026-04-28 01:04:52.464702 | debian-trixie | 14
2026-04-28 01:04:52.464954 | debian-trixie | 15 containerd_versions: "{{ containerd_archive_checksums['amd64'].keys() | list | community.general.version_sort }}"
2026-04-28 01:04:52.465131 | debian-trixie |                         ^ column 22
2026-04-28 01:04:52.465300 | debian-trixie |
2026-04-28 01:04:52.465622 | 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-28 01:04:52.465804 | debian-trixie |
2026-04-28 01:04:52.466049 | debian-trixie | PLAY RECAP *********************************************************************
2026-04-28 01:04:52.466277 | debian-trixie | debian-trixie              : ok=7    changed=2    unreachable=0    failed=1    skipped=3    rescued=0    ignored=0
2026-04-28 01:04:52.466451 | debian-trixie |
2026-04-28 01:04:52.466527 | debian-trixie |
2026-04-28 01:04:52.466613 | debian-trixie | TASKS RECAP ********************************************************************
2026-04-28 01:04:52.466694 | debian-trixie | Tuesday 28 April 2026  01:04:52 +0000 (0:00:00.067)       0:00:04.413 *********
2026-04-28 01:04:52.466774 | debian-trixie | ===============================================================================
2026-04-28 01:04:52.466858 | debian-trixie | Gathering Facts --------------------------------------------------------- 1.07s
2026-04-28 01:04:52.466943 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.99s
2026-04-28 01:04:52.467029 | debian-trixie | vexxhost.containers.download_artifact : Download item ------------------- 0.85s
2026-04-28 01:04:52.467114 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.49s
2026-04-28 01:04:52.467200 | debian-trixie | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s
2026-04-28 01:04:52.467284 | debian-trixie | vexxhost.containers.forget_package : Forget package --------------------- 0.31s
2026-04-28 01:04:52.467404 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.11s
2026-04-28 01:04:52.467482 | debian-trixie | vexxhost.containers.download_artifact : Starting download of file ------- 0.07s
2026-04-28 01:04:52.467586 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.04s
2026-04-28 01:04:52.467664 | debian-trixie | vexxhost.containers.package : Update state for tar ---------------------- 0.03s
2026-04-28 01:04:52.467747 | debian-trixie | vexxhost.containers.download_artifact : Extract archive ----------------- 0.03s
2026-04-28 01:04:52.571187 | 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-28 01:04:52.571311 | debian-trixie | ERROR    [docker > converge] Executed: Failed
2026-04-28 01:04:52.571492 | 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-28 01:04:52.740794 | debian-trixie | ERROR
2026-04-28 01:04:52.741078 | debian-trixie | {
2026-04-28 01:04:52.741149 | debian-trixie |   "delta": "0:00:27.651067",
2026-04-28 01:04:52.741198 | debian-trixie |   "end": "2026-04-28 01:04:52.666303",
2026-04-28 01:04:52.741242 | debian-trixie |   "msg": "non-zero return code",
2026-04-28 01:04:52.741285 | debian-trixie |   "rc": 2,
2026-04-28 01:04:52.741336 | debian-trixie |   "start": "2026-04-28 01:04:25.015236"
2026-04-28 01:04:52.741379 | debian-trixie | }
failure
2026-04-28 01:04:52.746291 | 
2026-04-28 01:04:52.746355 | PLAY RECAP
2026-04-28 01:04:52.746417 | debian-trixie | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-04-28 01:04:52.746445 | 
2026-04-28 01:04:52.863322 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-04-28 01:04:52.865442 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 01:04:53.437115 | 
2026-04-28 01:04:53.437253 | PLAY [all]
2026-04-28 01:04:53.447402 | 
2026-04-28 01:04:53.447499 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-28 01:04:53.493460 | debian-trixie | skipping: Conditional result was False
2026-04-28 01:04:53.502239 | 
2026-04-28 01:04:53.502404 | TASK [fetch-output : Set log path for single node]
2026-04-28 01:04:53.545354 | debian-trixie | ok
2026-04-28 01:04:53.552189 | 
2026-04-28 01:04:53.552255 | LOOP [fetch-output : Ensure local output dirs]
2026-04-28 01:04:53.931028 | debian-trixie -> localhost | ok: "/var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/logs"
2026-04-28 01:04:54.134511 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/artifacts"
2026-04-28 01:04:54.330640 | debian-trixie -> localhost | changed: "/var/lib/zuul/builds/39a8dbc5c0b942e297f62dd399f4427f/work/docs"
2026-04-28 01:04:54.349041 | 
2026-04-28 01:04:54.349196 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-28 01:04:55.000938 | debian-trixie | changed: .d..t...... ./
2026-04-28 01:04:55.001231 | debian-trixie | changed: All items complete
2026-04-28 01:04:55.001275 | 
2026-04-28 01:04:55.488672 | debian-trixie | changed: .d..t...... ./
2026-04-28 01:04:55.989563 | debian-trixie | changed: .d..t...... ./
2026-04-28 01:04:56.014409 | 
2026-04-28 01:04:56.014617 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-28 01:04:56.463565 | debian-trixie -> localhost | ok: Item: artifacts Runtime: 0:00:00.008701
2026-04-28 01:04:56.688891 | debian-trixie -> localhost | ok: Item: docs Runtime: 0:00:00.008213
2026-04-28 01:04:56.703007 | 
2026-04-28 01:04:56.703161 | PLAY [all]
2026-04-28 01:04:56.709629 | 
2026-04-28 01:04:56.709693 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-28 01:04:57.168113 | debian-trixie | changed
2026-04-28 01:04:57.173651 | 
2026-04-28 01:04:57.173703 | PLAY RECAP
2026-04-28 01:04:57.173749 | debian-trixie | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-28 01:04:57.173771 | 
2026-04-28 01:04:57.296286 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-28 01:04:57.298953 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-28 01:04:57.858976 | 
2026-04-28 01:04:57.859108 | PLAY [localhost]
2026-04-28 01:04:57.868850 | 
2026-04-28 01:04:57.868924 | TASK [Generate Zuul manifest]
2026-04-28 01:04:57.886898 | localhost | ok
2026-04-28 01:04:57.900676 | 
2026-04-28 01:04:57.900759 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-28 01:04:58.215111 | localhost | changed
2026-04-28 01:04:58.227105 | 
2026-04-28 01:04:58.227194 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-28 01:04:58.411797 | localhost | ok
2026-04-28 01:04:58.420433 | 
2026-04-28 01:04:58.420503 | TASK [Upload logs]
2026-04-28 01:04:58.442485 | localhost | ok
2026-04-28 01:04:58.499963 | 
2026-04-28 01:04:58.500098 | TASK [Set zuul-log-path fact]
2026-04-28 01:04:58.522082 | localhost | ok
2026-04-28 01:04:58.539776 | 
2026-04-28 01:04:58.539857 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-28 01:04:58.572109 | localhost | ok
2026-04-28 01:04:58.579327 | 
2026-04-28 01:04:58.579391 | TASK [upload-logs : Create log directories]
2026-04-28 01:04:59.025044 | localhost | changed
2026-04-28 01:04:59.031918 | 
2026-04-28 01:04:59.032022 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-28 01:04:59.444937 | localhost -> localhost | ok: Runtime: 0:00:00.005247
2026-04-28 01:04:59.451819 | 
2026-04-28 01:04:59.451924 | TASK [upload-logs : Upload logs to log server]
2026-04-28 01:05:00.260356 | localhost | Output suppressed because no_log was given
2026-04-28 01:05:00.265407 | 
2026-04-28 01:05:00.265495 | LOOP [upload-logs : Compress console log and json output]
2026-04-28 01:05:00.327391 | localhost | skipping: Conditional result was False
2026-04-28 01:05:00.339201 | localhost | skipping: Conditional result was False
2026-04-28 01:05:00.350066 | 
2026-04-28 01:05:00.350258 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-28 01:05:00.398474 | localhost | skipping: Conditional result was False
2026-04-28 01:05:00.398901 | 
2026-04-28 01:05:00.402771 | localhost | skipping: Conditional result was False
2026-04-28 01:05:00.414339 | 
2026-04-28 01:05:00.414518 | LOOP [upload-logs : Upload console log and json output]