2026-09-25 00:55:08.120241 | Job console starting
2026-09-25 00:55:08.130002 | Updating git repos
2026-09-25 00:55:08.157169 | Cloning repos into workspace
2026-09-25 00:55:08.204743 | Restoring repo states
2026-09-25 00:55:08.211804 | Merging changes
2026-09-25 00:55:08.965433 | Checking out repos
2026-09-25 00:55:09.006550 | Preparing playbooks
2026-09-25 00:55:10.498001 | Running Ansible setup
2026-09-25 00:55:14.090521 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-25 00:55:14.650015 | 
2026-09-25 00:55:14.650146 | PLAY [localhost]
2026-09-25 00:55:14.657218 | 
2026-09-25 00:55:14.657284 | TASK [Gathering Facts]
2026-09-25 00:55:16.505038 | localhost | ok
2026-09-25 00:55:16.510850 | 
2026-09-25 00:55:16.510921 | TASK [Setup log path fact]
2026-09-25 00:55:16.526768 | localhost | ok
2026-09-25 00:55:16.535356 | 
2026-09-25 00:55:16.535413 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-25 00:55:16.560784 | localhost | ok
2026-09-25 00:55:16.565651 | 
2026-09-25 00:55:16.565712 | TASK [emit-job-header : Print job information]
2026-09-25 00:55:16.603053 | # Job Information
2026-09-25 00:55:16.603192 | Ansible Version: 2.16.18
2026-09-25 00:55:16.603285 | Job: ansible-collection-containers-molecule-docker-upgrade-rockylinux-9
2026-09-25 00:55:16.603318 | Pipeline: check
2026-09-25 00:55:16.603344 | Executor: 2d72f0692154
2026-09-25 00:55:16.603368 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/149
2026-09-25 00:55:16.603396 | Event ID: 370be290-b87b-11f1-8216-00cbc496f9a1
2026-09-25 00:55:16.606656 | 
2026-09-25 00:55:16.606781 | LOOP [emit-job-header : Print node information]
2026-09-25 00:55:16.710444 | localhost | ok:
2026-09-25 00:55:16.710684 | localhost | # Node Information
2026-09-25 00:55:16.710753 | localhost | Inventory Hostname: rockylinux-9
2026-09-25 00:55:16.710797 | localhost | Hostname: np0000193893
2026-09-25 00:55:16.710836 | localhost | Username: zuul
2026-09-25 00:55:16.710879 | localhost | Distro: Rocky 9.7
2026-09-25 00:55:16.710917 | localhost | Provider: yul1
2026-09-25 00:55:16.710955 | localhost | Region: ca-ymq-1
2026-09-25 00:55:16.710991 | localhost | Label: rockylinux-9
2026-09-25 00:55:16.711027 | localhost | Product Name: OpenStack Nova
2026-09-25 00:55:16.711062 | localhost | Interface IP: 199.19.213.33
2026-09-25 00:55:16.722568 | 
2026-09-25 00:55:16.722735 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-25 00:55:17.158603 | localhost -> localhost | changed
2026-09-25 00:55:17.164640 | 
2026-09-25 00:55:17.164724 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-25 00:55:18.021616 | localhost -> localhost | changed
2026-09-25 00:55:18.028447 | 
2026-09-25 00:55:18.028553 | PLAY [all]
2026-09-25 00:55:18.047392 | 
2026-09-25 00:55:18.048014 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-25 00:55:18.274972 | rockylinux-9 -> localhost | ok
2026-09-25 00:55:18.282480 | 
2026-09-25 00:55:18.282579 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-25 00:55:18.310925 | rockylinux-9 | ok
2026-09-25 00:55:18.322251 | rockylinux-9 | included: /var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-25 00:55:18.327754 | 
2026-09-25 00:55:18.327813 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-25 00:55:19.629121 | rockylinux-9 -> localhost | Generating public/private rsa key pair.
2026-09-25 00:55:19.629326 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/2a744ef8d1814385b73b13bdf98388dd_id_rsa
2026-09-25 00:55:19.629355 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/2a744ef8d1814385b73b13bdf98388dd_id_rsa.pub
2026-09-25 00:55:19.629375 | rockylinux-9 -> localhost | The key fingerprint is:
2026-09-25 00:55:19.629394 | rockylinux-9 -> localhost | SHA256:q/XSi5XpybXgKaFzw6jsN+U44M54ZvgMfIacTGmPKQs zuul-build-sshkey
2026-09-25 00:55:19.629431 | rockylinux-9 -> localhost | The key's randomart image is:
2026-09-25 00:55:19.629450 | rockylinux-9 -> localhost | +---[RSA 3072]----+
2026-09-25 00:55:19.629477 | rockylinux-9 -> localhost | |                 |
2026-09-25 00:55:19.629497 | rockylinux-9 -> localhost | |                 |
2026-09-25 00:55:19.629515 | rockylinux-9 -> localhost | |                 |
2026-09-25 00:55:19.629533 | rockylinux-9 -> localhost | |   .             |
2026-09-25 00:55:19.629551 | rockylinux-9 -> localhost | |  +     S        |
2026-09-25 00:55:19.629568 | rockylinux-9 -> localhost | | * *.   o. o     |
2026-09-25 00:55:19.629586 | rockylinux-9 -> localhost | |E Xo+. Boo= .    |
2026-09-25 00:55:19.629603 | rockylinux-9 -> localhost | |.o.O= OoBB.= .   |
2026-09-25 00:55:19.629623 | rockylinux-9 -> localhost | |. .BOo.=.+O..    |
2026-09-25 00:55:19.629641 | rockylinux-9 -> localhost | +----[SHA256]-----+
2026-09-25 00:55:19.629689 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.872315
2026-09-25 00:55:19.633950 | 
2026-09-25 00:55:19.634011 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-25 00:55:19.653010 | rockylinux-9 | ok
2026-09-25 00:55:19.660928 | rockylinux-9 | included: /var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-25 00:55:19.667087 | 
2026-09-25 00:55:19.667156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-25 00:55:19.680588 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:19.687256 | 
2026-09-25 00:55:19.687349 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-25 00:55:20.140136 | rockylinux-9 | changed
2026-09-25 00:55:20.144412 | 
2026-09-25 00:55:20.144479 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-25 00:55:20.410511 | rockylinux-9 | ok
2026-09-25 00:55:20.419278 | 
2026-09-25 00:55:20.419408 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-25 00:55:21.396602 | rockylinux-9 | changed
2026-09-25 00:55:21.400635 | 
2026-09-25 00:55:21.400699 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-25 00:55:22.323303 | rockylinux-9 | changed
2026-09-25 00:55:22.331873 | 
2026-09-25 00:55:22.332007 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-25 00:55:22.376842 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:22.387735 | 
2026-09-25 00:55:22.387907 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-25 00:55:22.788929 | rockylinux-9 -> localhost | changed
2026-09-25 00:55:22.804534 | 
2026-09-25 00:55:22.804669 | TASK [add-build-sshkey : Add back temp key]
2026-09-25 00:55:23.139875 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/2a744ef8d1814385b73b13bdf98388dd_id_rsa (zuul-build-sshkey)
2026-09-25 00:55:23.140179 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014939
2026-09-25 00:55:23.149148 | 
2026-09-25 00:55:23.149276 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-25 00:55:23.549296 | rockylinux-9 | ok
2026-09-25 00:55:23.553555 | 
2026-09-25 00:55:23.553618 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-25 00:55:23.577152 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:23.587221 | 
2026-09-25 00:55:23.587302 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-25 00:55:24.028714 | rockylinux-9 | ok
2026-09-25 00:55:24.034550 | 
2026-09-25 00:55:24.034630 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-25 00:55:24.950453 | rockylinux-9 | Output suppressed because no_log was given
2026-09-25 00:55:24.968055 | 
2026-09-25 00:55:24.968208 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-25 00:55:25.259815 | rockylinux-9 | ok: "logs"
2026-09-25 00:55:25.260405 | rockylinux-9 | ok: All items complete
2026-09-25 00:55:25.260590 | 
2026-09-25 00:55:25.515659 | rockylinux-9 | ok: "artifacts"
2026-09-25 00:55:25.787461 | rockylinux-9 | ok: "docs"
2026-09-25 00:55:25.810177 | 
2026-09-25 00:55:25.810347 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-25 00:55:26.103520 | rockylinux-9 | changed: "logs"
2026-09-25 00:55:26.370757 | rockylinux-9 | changed: "artifacts"
2026-09-25 00:55:26.661158 | rockylinux-9 | changed: "docs"
2026-09-25 00:55:26.678221 | 
2026-09-25 00:55:26.678327 | PLAY RECAP
2026-09-25 00:55:26.678401 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-25 00:55:26.678456 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-25 00:55:26.678496 | 
2026-09-25 00:55:26.797079 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-25 00:55:26.798827 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-25 00:55:27.476265 | 
2026-09-25 00:55:27.476423 | PLAY [all]
2026-09-25 00:55:27.488415 | 
2026-09-25 00:55:27.488598 | TASK [setup-uv : Extract archive]
2026-09-25 00:55:30.463732 | rockylinux-9 | changed
2026-09-25 00:55:30.473608 | 
2026-09-25 00:55:30.474083 | TASK [setup-uv : Print version]
2026-09-25 00:55:30.507388 | [rockylinux-9] Waiting on logger
2026-09-25 00:55:31.021752 | rockylinux-9 | ok: Runtime: 0:00:00.019004
2026-09-25 00:55:31.036265 | 
2026-09-25 00:55:31.036389 | TASK [Install Ansible collection siblings]
2026-09-25 00:55:31.500962 | rockylinux-9 | ok:
2026-09-25 00:55:31.501309 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling
2026-09-25 00:55:31.501397 | rockylinux-9 | Skipping community.general: no checked-out sibling
2026-09-25 00:55:31.504865 | 
2026-09-25 00:55:31.504973 | PLAY RECAP
2026-09-25 00:55:31.505075 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-25 00:55:31.505170 | 
2026-09-25 00:55:31.629337 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-25 00:55:31.631427 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-25 00:55:32.191607 | 
2026-09-25 00:55:32.191715 | PLAY [all]
2026-09-25 00:55:32.201540 | 
2026-09-25 00:55:32.201606 | LOOP [Check inventory directories]
2026-09-25 00:55:32.606371 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers"
2026-09-25 00:55:32.849564 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/molecule/docker-upgrade/inventory"
2026-09-25 00:55:33.105990 | rockylinux-9 | ok: "src/github.com/vexxhost/ansible-collection-containers/extensions/molecule/docker-upgrade/inventory"
2026-09-25 00:55:33.124884 | 
2026-09-25 00:55:33.125209 | LOOP [Copy inventory file for Zuul]
2026-09-25 00:55:34.499250 | rockylinux-9 | changed:
2026-09-25 00:55:34.499403 | rockylinux-9 | {
2026-09-25 00:55:34.499428 | rockylinux-9 |   "ansible_loop_var": "item",
2026-09-25 00:55:34.499448 | rockylinux-9 |   "changed": false,
2026-09-25 00:55:34.499466 | rockylinux-9 |   "failed": false,
2026-09-25 00:55:34.499491 | rockylinux-9 |   "invocation": {
2026-09-25 00:55:34.499511 | rockylinux-9 |     "module_args": {
2026-09-25 00:55:34.499528 | rockylinux-9 |       "checksum_algorithm": "sha1",
2026-09-25 00:55:34.499544 | rockylinux-9 |       "follow": true,
2026-09-25 00:55:34.499560 | rockylinux-9 |       "get_attributes": true,
2026-09-25 00:55:34.499577 | rockylinux-9 |       "get_checksum": true,
2026-09-25 00:55:34.499593 | rockylinux-9 |       "get_mime": true,
2026-09-25 00:55:34.499608 | rockylinux-9 |       "path": "src/github.com/vexxhost/ansible-collection-containers"
2026-09-25 00:55:34.499625 | rockylinux-9 |     }
2026-09-25 00:55:34.499640 | rockylinux-9 |   },
2026-09-25 00:55:34.499656 | rockylinux-9 |   "item": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-25 00:55:34.499681 | rockylinux-9 |   "stat": {
2026-09-25 00:55:34.499697 | rockylinux-9 |     "atime": 1790297724.697,
2026-09-25 00:55:34.499713 | rockylinux-9 |     "attr_flags": "e",
2026-09-25 00:55:34.499729 | rockylinux-9 |     "attributes": [
2026-09-25 00:55:34.499744 | rockylinux-9 |       "extents"
2026-09-25 00:55:34.499760 | rockylinux-9 |     ],
2026-09-25 00:55:34.499775 | rockylinux-9 |     "block_size": 4096,
2026-09-25 00:55:34.499790 | rockylinux-9 |     "blocks": 8,
2026-09-25 00:55:34.499806 | rockylinux-9 |     "charset": "binary",
2026-09-25 00:55:34.499823 | rockylinux-9 |     "ctime": 1790297724.722,
2026-09-25 00:55:34.499838 | rockylinux-9 |     "dev": 64513,
2026-09-25 00:55:34.499854 | rockylinux-9 |     "device_type": 0,
2026-09-25 00:55:34.499870 | rockylinux-9 |     "executable": true,
2026-09-25 00:55:34.499885 | rockylinux-9 |     "exists": true,
2026-09-25 00:55:34.499907 | rockylinux-9 |     "gid": 1000,
2026-09-25 00:55:34.499924 | rockylinux-9 |     "gr_name": "zuul",
2026-09-25 00:55:34.499955 | rockylinux-9 |     "inode": 525401,
2026-09-25 00:55:34.499971 | rockylinux-9 |     "isblk": false,
2026-09-25 00:55:34.499991 | rockylinux-9 |     "ischr": false,
2026-09-25 00:55:34.500011 | rockylinux-9 |     "isdir": true,
2026-09-25 00:55:34.500036 | rockylinux-9 |     "isfifo": false,
2026-09-25 00:55:34.500074 | rockylinux-9 |     "isgid": false,
2026-09-25 00:55:34.500120 | rockylinux-9 |     "islnk": false,
2026-09-25 00:55:34.500169 | rockylinux-9 |     "isreg": false,
2026-09-25 00:55:34.500200 | rockylinux-9 |     "issock": false,
2026-09-25 00:55:34.500229 | rockylinux-9 |     "isuid": false,
2026-09-25 00:55:34.500258 | rockylinux-9 |     "mimetype": "inode/directory",
2026-09-25 00:55:34.500288 | rockylinux-9 |     "mode": "0755",
2026-09-25 00:55:34.500317 | rockylinux-9 |     "mtime": 1790297708.2395523,
2026-09-25 00:55:34.500347 | rockylinux-9 |     "nlink": 11,
2026-09-25 00:55:34.500376 | rockylinux-9 |     "path": "src/github.com/vexxhost/ansible-collection-containers",
2026-09-25 00:55:34.500406 | rockylinux-9 |     "pw_name": "zuul",
2026-09-25 00:55:34.500438 | rockylinux-9 |     "readable": true,
2026-09-25 00:55:34.500469 | rockylinux-9 |     "rgrp": true,
2026-09-25 00:55:34.500847 | rockylinux-9 |     "roth": true,
2026-09-25 00:55:34.500897 | rockylinux-9 |     "rusr": true,
2026-09-25 00:55:34.500929 | rockylinux-9 |     "size": 4096,
2026-09-25 00:55:34.500959 | rockylinux-9 |     "uid": 1000,
2026-09-25 00:55:34.500988 | rockylinux-9 |     "version": "2627046845",
2026-09-25 00:55:34.501017 | rockylinux-9 |     "wgrp": false,
2026-09-25 00:55:34.501047 | rockylinux-9 |     "woth": false,
2026-09-25 00:55:34.501077 | rockylinux-9 |     "writeable": true,
2026-09-25 00:55:34.501105 | rockylinux-9 |     "wusr": true,
2026-09-25 00:55:34.501154 | rockylinux-9 |     "xgrp": true,
2026-09-25 00:55:34.501186 | rockylinux-9 |     "xoth": true,
2026-09-25 00:55:34.501215 | rockylinux-9 |     "xusr": true
2026-09-25 00:55:34.501242 | rockylinux-9 |   }
2026-09-25 00:55:34.501270 | rockylinux-9 | }
2026-09-25 00:55:34.501323 | rockylinux-9 | ok: All items complete
2026-09-25 00:55:34.501361 | 
2026-09-25 00:55:34.502926 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:34.510102 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:34.527004 | 
2026-09-25 00:55:34.527201 | LOOP [Switch "ansible_host" to private IP]
2026-09-25 00:55:34.972442 | rockylinux-9 | changed: 1 replacements made
2026-09-25 00:55:34.974652 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:34.979050 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 00:55:34.993696 | 
2026-09-25 00:55:34.993870 | TASK [Run Molecule scenario]
2026-09-25 00:55:35.023879 | [rockylinux-9] Waiting on logger
2026-09-25 00:55:42.153642 | [rockylinux-9] Waiting on logger
2026-09-25 00:55:52.325680 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:02.501542 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:11.653600 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:21.833534 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:32.005352 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:42.181643 | [rockylinux-9] Waiting on logger
2026-09-25 00:56:52.357742 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:01.519867 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:11.685311 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:21.861836 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:32.037748 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:42.213477 | [rockylinux-9] Waiting on logger
2026-09-25 00:57:52.389600 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:01.551049 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:11.717503 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:21.893675 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:32.069735 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:42.245425 | [rockylinux-9] Waiting on logger
2026-09-25 00:58:52.421665 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:01.582940 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:11.749513 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:21.925674 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:32.101389 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:42.277514 | [rockylinux-9] Waiting on logger
2026-09-25 00:59:52.453448 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:01.610924 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:11.785510 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:21.957585 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:32.133999 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:42.309540 | [rockylinux-9] Waiting on logger
2026-09-25 01:00:52.485660 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:01.637475 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:11.813687 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:22.085885 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:32.261572 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:41.989419 | [rockylinux-9] Waiting on logger
2026-09-25 01:01:51.653447 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:01.989563 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:12.165512 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:22.341472 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:32.517668 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:41.673487 | [rockylinux-9] Waiting on logger
2026-09-25 01:02:51.845878 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:02.021767 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:12.197927 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:22.373599 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:31.531778 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:41.701333 | [rockylinux-9] Waiting on logger
2026-09-25 01:03:51.877569 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:02.053606 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:12.229638 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:22.405342 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:31.563212 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:41.733784 | [rockylinux-9] Waiting on logger
2026-09-25 01:04:51.909512 | [rockylinux-9] Waiting on logger
2026-09-25 01:05:02.085547 | [rockylinux-9] Waiting on logger
2026-09-25 01:05:12.261451 | [rockylinux-9] Waiting on logger
2026-09-25 01:05:20.206447 | rockylinux-9 | ok: Runtime: 0:09:44.188140
2026-09-25 01:05:20.232256 | 
2026-09-25 01:05:20.232580 | PLAY RECAP
2026-09-25 01:05:20.232655 | rockylinux-9 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-25 01:05:20.232678 | 
2026-09-25 01:05:20.396864 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-25 01:05:20.400911 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-25 01:05:20.961216 | 
2026-09-25 01:05:20.961599 | PLAY [all]
2026-09-25 01:05:20.971970 | 
2026-09-25 01:05:20.972072 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-25 01:05:21.025587 | rockylinux-9 | skipping: Conditional result was False
2026-09-25 01:05:21.031091 | 
2026-09-25 01:05:21.031189 | TASK [fetch-output : Set log path for single node]
2026-09-25 01:05:21.082453 | rockylinux-9 | ok
2026-09-25 01:05:21.090218 | 
2026-09-25 01:05:21.090354 | LOOP [fetch-output : Ensure local output dirs]
2026-09-25 01:05:21.502238 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/logs"
2026-09-25 01:05:21.724335 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/artifacts"
2026-09-25 01:05:21.935639 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/2a744ef8d1814385b73b13bdf98388dd/work/docs"
2026-09-25 01:05:21.954130 | 
2026-09-25 01:05:21.954299 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-25 01:05:22.719908 | rockylinux-9 | changed: .d..t...... ./
2026-09-25 01:05:22.720868 | rockylinux-9 | changed: All items complete
2026-09-25 01:05:22.720945 | 
2026-09-25 01:05:23.315415 | rockylinux-9 | changed: .d..t...... ./
2026-09-25 01:05:23.909845 | rockylinux-9 | changed: .d..t...... ./
2026-09-25 01:05:23.933782 | 
2026-09-25 01:05:23.933924 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-25 01:05:24.375489 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007264
2026-09-25 01:05:24.625625 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008424
2026-09-25 01:05:24.644861 | 
2026-09-25 01:05:24.645060 | PLAY [all]
2026-09-25 01:05:24.655859 | 
2026-09-25 01:05:24.655992 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-25 01:05:25.192544 | rockylinux-9 | changed
2026-09-25 01:05:25.205519 | 
2026-09-25 01:05:25.205617 | PLAY RECAP
2026-09-25 01:05:25.206261 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-25 01:05:25.206341 | 
2026-09-25 01:05:25.409909 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-25 01:05:25.411954 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-25 01:05:25.995657 | 
2026-09-25 01:05:25.995789 | PLAY [localhost]
2026-09-25 01:05:26.005715 | 
2026-09-25 01:05:26.005791 | TASK [Generate Zuul manifest]
2026-09-25 01:05:26.021641 | localhost | ok
2026-09-25 01:05:26.036150 | 
2026-09-25 01:05:26.036239 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-25 01:05:26.417978 | localhost | changed
2026-09-25 01:05:26.431368 | 
2026-09-25 01:05:26.431488 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-25 01:05:26.474587 | localhost | ok
2026-09-25 01:05:26.488607 | 
2026-09-25 01:05:26.488765 | TASK [Upload logs]
2026-09-25 01:05:26.511626 | localhost | ok
2026-09-25 01:05:26.593618 | 
2026-09-25 01:05:26.593733 | TASK [Set zuul-log-path fact]
2026-09-25 01:05:26.610219 | localhost | ok
2026-09-25 01:05:26.619828 | 
2026-09-25 01:05:26.619891 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-25 01:05:26.657792 | localhost | ok
2026-09-25 01:05:26.666981 | 
2026-09-25 01:05:26.667094 | TASK [upload-logs : Create log directories]
2026-09-25 01:05:27.082907 | localhost | changed
2026-09-25 01:05:27.093454 | 
2026-09-25 01:05:27.093584 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-25 01:05:27.550342 | localhost -> localhost | ok: Runtime: 0:00:00.004966
2026-09-25 01:05:27.559365 | 
2026-09-25 01:05:27.559495 | TASK [upload-logs : Upload logs to log server]
2026-09-25 01:05:28.020594 | localhost | Output suppressed because no_log was given
2026-09-25 01:05:28.027961 | 
2026-09-25 01:05:28.028137 | LOOP [upload-logs : Compress console log and json output]
2026-09-25 01:05:28.091467 | localhost | skipping: Conditional result was False
2026-09-25 01:05:28.100795 | localhost | skipping: Conditional result was False
2026-09-25 01:05:28.109123 | 
2026-09-25 01:05:28.109282 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-25 01:05:28.164071 | localhost | skipping: Conditional result was False
2026-09-25 01:05:28.164451 | 
2026-09-25 01:05:28.169836 | localhost | skipping: Conditional result was False
2026-09-25 01:05:28.185159 | 
2026-09-25 01:05:28.185391 | LOOP [upload-logs : Upload console log and json output]