2026-02-18 21:59:13.162957 | Job console starting
2026-02-18 21:59:13.171174 | Updating git repos
2026-02-18 21:59:14.194246 | Cloning repos into workspace
2026-02-18 21:59:16.446100 | Restoring repo states
2026-02-18 21:59:16.542935 | Merging changes
2026-02-18 21:59:17.122950 | Checking out repos
2026-02-18 21:59:19.922050 | Preparing playbooks
2026-02-18 21:59:21.806889 | Running Ansible setup
2026-02-18 21:59:25.216278 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-18 21:59:25.811844 | 
2026-02-18 21:59:25.811981 | PLAY [localhost]
2026-02-18 21:59:25.819622 | 
2026-02-18 21:59:25.819691 | TASK [Gathering Facts]
2026-02-18 21:59:26.649139 | localhost | ok
2026-02-18 21:59:26.658626 | 
2026-02-18 21:59:26.658706 | TASK [Setup log path fact]
2026-02-18 21:59:26.679426 | localhost | ok
2026-02-18 21:59:26.691520 | 
2026-02-18 21:59:26.691585 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-18 21:59:26.721406 | localhost | ok
2026-02-18 21:59:26.729928 | 
2026-02-18 21:59:26.729997 | TASK [emit-job-header : Print job information]
2026-02-18 21:59:26.770868 | # Job Information
2026-02-18 21:59:26.771080 | Ansible Version: 2.16.15
2026-02-18 21:59:26.771150 | Job: manila-grenade
2026-02-18 21:59:26.771197 | Pipeline: check
2026-02-18 21:59:26.771241 | Executor: 3a2793d2bd32
2026-02-18 21:59:26.771285 | Triggered by: https://github.com/vexxhost/manila/pull/1
2026-02-18 21:59:26.771335 | Event ID: a33a73e0-0d14-11f1-94d3-35c656f98fe6
2026-02-18 21:59:26.775258 | 
2026-02-18 21:59:26.775327 | LOOP [emit-job-header : Print node information]
2026-02-18 21:59:26.866458 | localhost | ok:
2026-02-18 21:59:26.866749 | localhost | # Node Information
2026-02-18 21:59:26.866812 | localhost | Inventory Hostname: controller
2026-02-18 21:59:26.866862 | localhost | Hostname: np0000156397
2026-02-18 21:59:26.866907 | localhost | Username: zuul
2026-02-18 21:59:26.866959 | localhost | Distro: Ubuntu 22.04
2026-02-18 21:59:26.867005 | localhost | Provider: yul1
2026-02-18 21:59:26.867048 | localhost | Region: ca-ymq-1
2026-02-18 21:59:26.867090 | localhost | Label: ubuntu-jammy
2026-02-18 21:59:26.867132 | localhost | Product Name: OpenStack Nova
2026-02-18 21:59:26.867174 | localhost | Interface IP: 199.204.45.6
2026-02-18 21:59:26.884144 | 
2026-02-18 21:59:26.884318 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-18 21:59:27.252787 | localhost -> localhost | changed
2026-02-18 21:59:27.263867 | 
2026-02-18 21:59:27.263978 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-18 21:59:28.109788 | localhost -> localhost | changed
2026-02-18 21:59:28.120229 | 
2026-02-18 21:59:28.120312 | PLAY [all]
2026-02-18 21:59:28.129401 | 
2026-02-18 21:59:28.129468 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-18 21:59:28.366886 | controller -> localhost | ok
2026-02-18 21:59:28.376286 | 
2026-02-18 21:59:28.376373 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-18 21:59:28.409439 | controller | ok
2026-02-18 21:59:28.423167 | controller | included: /var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-18 21:59:28.428494 | 
2026-02-18 21:59:28.428557 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-18 21:59:29.089945 | controller -> localhost | Generating public/private rsa key pair.
2026-02-18 21:59:29.090130 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/3e6797e815444558a1d22e2284e14ec8_id_rsa
2026-02-18 21:59:29.090158 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/3e6797e815444558a1d22e2284e14ec8_id_rsa.pub
2026-02-18 21:59:29.090180 | controller -> localhost | The key fingerprint is:
2026-02-18 21:59:29.090201 | controller -> localhost | SHA256:f127jVBKMwP1sHRdcQVzjV18q3iqFJ+27Gdx97GBcyw zuul-build-sshkey
2026-02-18 21:59:29.090232 | controller -> localhost | The key's randomart image is:
2026-02-18 21:59:29.090253 | controller -> localhost | +---[RSA 3072]----+
2026-02-18 21:59:29.090278 | controller -> localhost | |            + +B%|
2026-02-18 21:59:29.090299 | controller -> localhost | |           o =.oB|
2026-02-18 21:59:29.090318 | controller -> localhost | |          . . . o|
2026-02-18 21:59:29.090338 | controller -> localhost | |           .   . |
2026-02-18 21:59:29.090358 | controller -> localhost | |        S.  * = .|
2026-02-18 21:59:29.090378 | controller -> localhost | |         .oo.E Bo|
2026-02-18 21:59:29.090397 | controller -> localhost | |         ..+* B.*|
2026-02-18 21:59:29.090417 | controller -> localhost | |        . oo.+ o+|
2026-02-18 21:59:29.090439 | controller -> localhost | |         .o+o ...|
2026-02-18 21:59:29.090459 | controller -> localhost | +----[SHA256]-----+
2026-02-18 21:59:29.090500 | controller -> localhost | ok: Runtime: 0:00:00.250843
2026-02-18 21:59:29.095374 | 
2026-02-18 21:59:29.095436 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-18 21:59:29.127635 | controller | ok
2026-02-18 21:59:29.139068 | controller | included: /var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-18 21:59:29.146196 | 
2026-02-18 21:59:29.146256 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-18 21:59:29.171033 | controller | skipping: Conditional result was False
2026-02-18 21:59:29.181729 | 
2026-02-18 21:59:29.181790 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-18 21:59:29.704583 | controller | changed
2026-02-18 21:59:29.710276 | 
2026-02-18 21:59:29.710342 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-18 21:59:29.916464 | controller | ok
2026-02-18 21:59:29.924781 | 
2026-02-18 21:59:29.924845 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-18 21:59:30.394064 | controller | changed
2026-02-18 21:59:30.399901 | 
2026-02-18 21:59:30.399962 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-18 21:59:30.873126 | controller | changed
2026-02-18 21:59:30.878514 | 
2026-02-18 21:59:30.878577 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-18 21:59:30.905596 | controller | skipping: Conditional result was False
2026-02-18 21:59:30.914931 | 
2026-02-18 21:59:30.915018 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-18 21:59:31.272772 | controller -> localhost | changed
2026-02-18 21:59:31.291081 | 
2026-02-18 21:59:31.291151 | TASK [add-build-sshkey : Add back temp key]
2026-02-18 21:59:31.569050 | controller -> localhost | Identity added: /var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/3e6797e815444558a1d22e2284e14ec8_id_rsa (zuul-build-sshkey)
2026-02-18 21:59:31.569337 | controller -> localhost | ok: Runtime: 0:00:00.015730
2026-02-18 21:59:31.576555 | 
2026-02-18 21:59:31.576621 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-18 21:59:31.904461 | controller | ok
2026-02-18 21:59:31.910053 | 
2026-02-18 21:59:31.910121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-18 21:59:31.935823 | controller | skipping: Conditional result was False
2026-02-18 21:59:31.997827 | 
2026-02-18 21:59:31.997970 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-18 21:59:32.287178 | controller | ok
2026-02-18 21:59:32.293175 | 
2026-02-18 21:59:32.293238 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-18 21:59:53.329273 | controller | Output suppressed because no_log was given
2026-02-18 21:59:53.338084 | 
2026-02-18 21:59:53.338149 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-18 21:59:53.527160 | controller | ok: "logs"
2026-02-18 21:59:53.527519 | controller | ok: All items complete
2026-02-18 21:59:53.527559 | 
2026-02-18 21:59:53.665276 | controller | ok: "artifacts"
2026-02-18 21:59:54.322023 | controller | ok: "docs"
2026-02-18 21:59:54.333767 | 
2026-02-18 21:59:54.333864 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-18 21:59:54.548210 | controller | changed: "logs"
2026-02-18 21:59:55.287030 | controller | changed: "artifacts"
2026-02-18 21:59:55.439136 | controller | changed: "docs"
2026-02-18 21:59:55.458818 | 
2026-02-18 21:59:55.458949 | PLAY RECAP
2026-02-18 21:59:55.459002 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-18 21:59:55.459031 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-18 21:59:55.459054 | 
2026-02-18 21:59:55.636143 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-18 21:59:55.645381 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/multinode/pre.yaml@master]
2026-02-18 21:59:56.236886 | 
2026-02-18 21:59:56.237049 | PLAY [Configure a multi node environment]
2026-02-18 21:59:56.246587 | 
2026-02-18 21:59:56.246659 | TASK [Set up multi-node known hosts]
2026-02-18 21:59:56.269580 | controller | ok
2026-02-18 21:59:56.287211 | 
2026-02-18 21:59:56.287288 | TASK [multi-node-known-hosts : Get known_hosts facts]
2026-02-18 21:59:56.929923 | controller | ok
2026-02-18 21:59:56.955061 | 
2026-02-18 21:59:56.955130 | LOOP [multi-node-known-hosts : Add default known_host record for every user]
2026-02-18 21:59:57.347721 | controller | changed:
2026-02-18 21:59:57.347947 | controller | {
2026-02-18 21:59:57.347976 | controller |   "key": "199.204.45.6 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHBN3CTFMc1hiKdFYtTIJ99i0X0BhMmUvNYOPi7Przd6znFGGwePPj2jQJzppSp1JF2cooENOdjqbzM727lOcDM=",
2026-02-18 21:59:57.347998 | controller |   "name": "199.204.45.6"
2026-02-18 21:59:57.348018 | controller | }
2026-02-18 21:59:58.075111 | controller | changed:
2026-02-18 21:59:58.075376 | controller | {
2026-02-18 21:59:58.075441 | controller |   "key": "199.204.45.6 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJwgRSa9LgB9Khy/uWliEXIAjyA3qvfbPheA/w+MQz1z",
2026-02-18 21:59:58.075487 | controller |   "name": "199.204.45.6"
2026-02-18 21:59:58.075532 | controller | }
2026-02-18 21:59:58.268316 | controller | changed:
2026-02-18 21:59:58.268436 | controller | {
2026-02-18 21:59:58.268490 | controller |   "key": "199.204.45.6 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCXQMv3NGw+VAhEgnBTKbhpZBCmVhTYK+bmliVi8bI1Z1K1twrTNzxML/0EUECkk5+1MUuIp+r22vSrJibaULtMmwZpPraleHTsd6mCa5e5U5XMDlZNzvAmoie2Fq/tVpq9YH3MtRbwPiCN0T2+smkpHyFGhgcapeoSByV7eZFDXTpBvlr3aLoEv32NaIWSJ9/kFdUzBfL5iNvmw81Xv8bIem/C4y9OAbRteMKcvKt9T25gRh3O+H7uuN7MXQrIt/i6rsUqBYMXOnZ+zpHeZZQmQsu9/GIGWznteL6xeevk6fjEL6PIJu9JxitNbzIM5ABuhj+DKGMS14jdMPV2Exa/E9X62sG1A/C9JR35l3Y+g/D1Te6duFu6/5Sm+nAImPJHap889H4w6D9XXT97xN53/BlYixnZt+k7y548SsUvzyuJ6jgC2q0mUcNOFAgw8+KbNxhk6DD8/VrWmHqzcNVPcgYbWbJsJZU0FL3s2i7a2OqbM1vx5DRvXAdbeNEoSvc=",
2026-02-18 21:59:58.268519 | controller |   "name": "199.204.45.6"
2026-02-18 21:59:58.268545 | controller | }
2026-02-18 21:59:58.519833 | controller | changed:
2026-02-18 21:59:58.519984 | controller | {
2026-02-18 21:59:58.520039 | controller |   "key": "2604:e100:1:0:f816:3eff:fed8:ff57 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHBN3CTFMc1hiKdFYtTIJ99i0X0BhMmUvNYOPi7Przd6znFGGwePPj2jQJzppSp1JF2cooENOdjqbzM727lOcDM=",
2026-02-18 21:59:58.520091 | controller |   "name": "2604:e100:1:0:f816:3eff:fed8:ff57"
2026-02-18 21:59:58.520133 | controller | }
2026-02-18 21:59:59.338235 | controller | changed:
2026-02-18 21:59:59.338435 | controller | {
2026-02-18 21:59:59.338506 | controller |   "key": "2604:e100:1:0:f816:3eff:fed8:ff57 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJwgRSa9LgB9Khy/uWliEXIAjyA3qvfbPheA/w+MQz1z",
2026-02-18 21:59:59.338567 | controller |   "name": "2604:e100:1:0:f816:3eff:fed8:ff57"
2026-02-18 21:59:59.338601 | controller | }
2026-02-18 21:59:59.512324 | controller | changed:
2026-02-18 21:59:59.512451 | controller | {
2026-02-18 21:59:59.512483 | controller |   "key": "2604:e100:1:0:f816:3eff:fed8:ff57 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCXQMv3NGw+VAhEgnBTKbhpZBCmVhTYK+bmliVi8bI1Z1K1twrTNzxML/0EUECkk5+1MUuIp+r22vSrJibaULtMmwZpPraleHTsd6mCa5e5U5XMDlZNzvAmoie2Fq/tVpq9YH3MtRbwPiCN0T2+smkpHyFGhgcapeoSByV7eZFDXTpBvlr3aLoEv32NaIWSJ9/kFdUzBfL5iNvmw81Xv8bIem/C4y9OAbRteMKcvKt9T25gRh3O+H7uuN7MXQrIt/i6rsUqBYMXOnZ+zpHeZZQmQsu9/GIGWznteL6xeevk6fjEL6PIJu9JxitNbzIM5ABuhj+DKGMS14jdMPV2Exa/E9X62sG1A/C9JR35l3Y+g/D1Te6duFu6/5Sm+nAImPJHap889H4w6D9XXT97xN53/BlYixnZt+k7y548SsUvzyuJ6jgC2q0mUcNOFAgw8+KbNxhk6DD8/VrWmHqzcNVPcgYbWbJsJZU0FL3s2i7a2OqbM1vx5DRvXAdbeNEoSvc=",
2026-02-18 21:59:59.512593 | controller |   "name": "2604:e100:1:0:f816:3eff:fed8:ff57"
2026-02-18 21:59:59.512624 | controller | }
2026-02-18 22:00:00.029673 | controller | changed:
2026-02-18 22:00:00.029892 | controller | {
2026-02-18 22:00:00.029943 | controller |   "key": "fe80::f816:3eff:fed8:ff57 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHBN3CTFMc1hiKdFYtTIJ99i0X0BhMmUvNYOPi7Przd6znFGGwePPj2jQJzppSp1JF2cooENOdjqbzM727lOcDM=",
2026-02-18 22:00:00.030002 | controller |   "name": "fe80::f816:3eff:fed8:ff57"
2026-02-18 22:00:00.030033 | controller | }
2026-02-18 22:00:00.194114 | controller | changed:
2026-02-18 22:00:00.194373 | controller | {
2026-02-18 22:00:00.194427 | controller |   "key": "fe80::f816:3eff:fed8:ff57 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJwgRSa9LgB9Khy/uWliEXIAjyA3qvfbPheA/w+MQz1z",
2026-02-18 22:00:00.194463 | controller |   "name": "fe80::f816:3eff:fed8:ff57"
2026-02-18 22:00:00.194493 | controller | }
2026-02-18 22:00:00.360748 | controller | changed:
2026-02-18 22:00:00.360900 | controller | {
2026-02-18 22:00:00.360932 | controller |   "key": "fe80::f816:3eff:fed8:ff57 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCXQMv3NGw+VAhEgnBTKbhpZBCmVhTYK+bmliVi8bI1Z1K1twrTNzxML/0EUECkk5+1MUuIp+r22vSrJibaULtMmwZpPraleHTsd6mCa5e5U5XMDlZNzvAmoie2Fq/tVpq9YH3MtRbwPiCN0T2+smkpHyFGhgcapeoSByV7eZFDXTpBvlr3aLoEv32NaIWSJ9/kFdUzBfL5iNvmw81Xv8bIem/C4y9OAbRteMKcvKt9T25gRh3O+H7uuN7MXQrIt/i6rsUqBYMXOnZ+zpHeZZQmQsu9/GIGWznteL6xeevk6fjEL6PIJu9JxitNbzIM5ABuhj+DKGMS14jdMPV2Exa/E9X62sG1A/C9JR35l3Y+g/D1Te6duFu6/5Sm+nAImPJHap889H4w6D9XXT97xN53/BlYixnZt+k7y548SsUvzyuJ6jgC2q0mUcNOFAgw8+KbNxhk6DD8/VrWmHqzcNVPcgYbWbJsJZU0FL3s2i7a2OqbM1vx5DRvXAdbeNEoSvc=",
2026-02-18 22:00:00.360985 | controller |   "name": "fe80::f816:3eff:fed8:ff57"
2026-02-18 22:00:00.361017 | controller | }
2026-02-18 22:00:00.532683 | controller | changed:
2026-02-18 22:00:00.532817 | controller | {
2026-02-18 22:00:00.532848 | controller |   "key": "np0000156397 ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBHBN3CTFMc1hiKdFYtTIJ99i0X0BhMmUvNYOPi7Przd6znFGGwePPj2jQJzppSp1JF2cooENOdjqbzM727lOcDM=",
2026-02-18 22:00:00.532877 | controller |   "name": "np0000156397"
2026-02-18 22:00:00.532902 | controller | }
2026-02-18 22:00:00.702123 | controller | changed:
2026-02-18 22:00:00.702171 | controller | {
2026-02-18 22:00:00.702195 | controller |   "key": "np0000156397 ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIJwgRSa9LgB9Khy/uWliEXIAjyA3qvfbPheA/w+MQz1z",
2026-02-18 22:00:00.702215 | controller |   "name": "np0000156397"
2026-02-18 22:00:00.702235 | controller | }
2026-02-18 22:00:00.878298 | controller | changed:
2026-02-18 22:00:00.878495 | controller | {
2026-02-18 22:00:00.878535 | controller |   "key": "np0000156397 ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQCXQMv3NGw+VAhEgnBTKbhpZBCmVhTYK+bmliVi8bI1Z1K1twrTNzxML/0EUECkk5+1MUuIp+r22vSrJibaULtMmwZpPraleHTsd6mCa5e5U5XMDlZNzvAmoie2Fq/tVpq9YH3MtRbwPiCN0T2+smkpHyFGhgcapeoSByV7eZFDXTpBvlr3aLoEv32NaIWSJ9/kFdUzBfL5iNvmw81Xv8bIem/C4y9OAbRteMKcvKt9T25gRh3O+H7uuN7MXQrIt/i6rsUqBYMXOnZ+zpHeZZQmQsu9/GIGWznteL6xeevk6fjEL6PIJu9JxitNbzIM5ABuhj+DKGMS14jdMPV2Exa/E9X62sG1A/C9JR35l3Y+g/D1Te6duFu6/5Sm+nAImPJHap889H4w6D9XXT97xN53/BlYixnZt+k7y548SsUvzyuJ6jgC2q0mUcNOFAgw8+KbNxhk6DD8/VrWmHqzcNVPcgYbWbJsJZU0FL3s2i7a2OqbM1vx5DRvXAdbeNEoSvc=",
2026-02-18 22:00:00.878572 | controller |   "name": "np0000156397"
2026-02-18 22:00:00.878600 | controller | }
2026-02-18 22:00:00.906487 | 
2026-02-18 22:00:00.906644 | TASK [Set up multi-node hosts file]
2026-02-18 22:00:00.976090 | controller | ok
2026-02-18 22:00:01.000405 | 
2026-02-18 22:00:01.000521 | TASK [multi-node-hosts-file : Set up the list of hosts and addresses]
2026-02-18 22:00:01.044854 | controller | ok
2026-02-18 22:00:01.049698 | 
2026-02-18 22:00:01.049761 | LOOP [multi-node-hosts-file : Add inventory hostnames to the hosts file]
2026-02-18 22:00:01.351424 | controller | changed: line added
2026-02-18 22:00:01.351814 | controller | changed: All items complete
2026-02-18 22:00:01.351847 | 
2026-02-18 22:00:01.500397 | controller | changed: line added
2026-02-18 22:00:01.519472 | 
2026-02-18 22:00:01.519597 | TASK [Set up multi-node firewall]
2026-02-18 22:00:01.541692 | controller | ok
2026-02-18 22:00:01.564679 | 
2026-02-18 22:00:01.564773 | LOOP [multi-node-firewall : Include operating system specific vars]
2026-02-18 22:00:01.604143 | controller | ok: "/var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/multi-node-firewall/vars/default.yaml"
2026-02-18 22:00:01.617110 | 
2026-02-18 22:00:01.617234 | TASK [multi-node-firewall : Ensure iptables]
2026-02-18 22:00:02.251402 | controller | ERROR
2026-02-18 22:00:02.251749 | controller | {
2026-02-18 22:00:02.251780 | controller |   "msg": "No package matching 'iptables' is available"
2026-02-18 22:00:02.251802 | controller | }
failure
2026-02-18 22:00:02.253449 | 
2026-02-18 22:00:02.253569 | PLAY RECAP
2026-02-18 22:00:02.253625 | controller | ok: 5 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-18 22:00:02.253647 | 
2026-02-18 22:00:02.396770 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/multinode/pre.yaml@master]
2026-02-18 22:00:02.405329 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-18 22:00:02.999998 | 
2026-02-18 22:00:03.000149 | PLAY [all]
2026-02-18 22:00:03.011385 | 
2026-02-18 22:00:03.011476 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-18 22:00:03.057436 | controller | skipping: Conditional result was False
2026-02-18 22:00:03.068594 | 
2026-02-18 22:00:03.068701 | TASK [fetch-output : Set log path for single node]
2026-02-18 22:00:03.113959 | controller | ok
2026-02-18 22:00:03.119355 | 
2026-02-18 22:00:03.119428 | LOOP [fetch-output : Ensure local output dirs]
2026-02-18 22:00:03.504416 | controller -> localhost | ok: "/var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/logs"
2026-02-18 22:00:03.713514 | controller -> localhost | changed: "/var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/artifacts"
2026-02-18 22:00:03.929836 | controller -> localhost | changed: "/var/lib/zuul/builds/3e6797e815444558a1d22e2284e14ec8/work/docs"
2026-02-18 22:00:03.950118 | 
2026-02-18 22:00:03.950273 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-18 22:00:04.587821 | controller | changed: .d..t...... ./
2026-02-18 22:00:04.588066 | controller | changed: All items complete
2026-02-18 22:00:04.588094 | 
2026-02-18 22:00:05.059109 | controller | changed: .d..t...... ./
2026-02-18 22:00:05.499306 | controller | changed: .d..t...... ./
2026-02-18 22:00:05.525496 | 
2026-02-18 22:00:05.525652 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-18 22:00:05.944866 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008520
2026-02-18 22:00:06.157987 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007973
2026-02-18 22:00:06.174807 | 
2026-02-18 22:00:06.174964 | PLAY [all]
2026-02-18 22:00:06.182348 | 
2026-02-18 22:00:06.182414 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-18 22:00:07.253023 | controller | changed
2026-02-18 22:00:07.259089 | 
2026-02-18 22:00:07.259142 | PLAY RECAP
2026-02-18 22:00:07.259201 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-18 22:00:07.259223 | 
2026-02-18 22:00:07.392043 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-18 22:00:07.398011 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-18 22:00:07.982426 | 
2026-02-18 22:00:07.982581 | PLAY [localhost]
2026-02-18 22:00:07.994104 | 
2026-02-18 22:00:07.994178 | TASK [Generate Zuul manifest]
2026-02-18 22:00:08.016791 | localhost | ok
2026-02-18 22:00:08.032624 | 
2026-02-18 22:00:08.032714 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-18 22:00:08.409965 | localhost | changed
2026-02-18 22:00:08.423493 | 
2026-02-18 22:00:08.423575 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-18 22:00:08.457706 | localhost | ok
2026-02-18 22:00:08.467041 | 
2026-02-18 22:00:08.467131 | TASK [Upload logs]
2026-02-18 22:00:08.491080 | localhost | ok
2026-02-18 22:00:08.554736 | 
2026-02-18 22:00:08.554895 | TASK [Set zuul-log-path fact]
2026-02-18 22:00:08.578587 | localhost | ok
2026-02-18 22:00:08.591887 | 
2026-02-18 22:00:08.591973 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-18 22:00:08.623784 | localhost | ok
2026-02-18 22:00:08.676708 | 
2026-02-18 22:00:08.679515 | TASK [upload-logs : Create log directories]
2026-02-18 22:00:09.047391 | localhost | changed
2026-02-18 22:00:09.053804 | 
2026-02-18 22:00:09.053907 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-18 22:00:09.419035 | localhost -> localhost | ok: Runtime: 0:00:00.005902
2026-02-18 22:00:09.426218 | 
2026-02-18 22:00:09.426316 | TASK [upload-logs : Upload logs to log server]
2026-02-18 22:00:09.849957 | localhost | Output suppressed because no_log was given
2026-02-18 22:00:09.853674 | 
2026-02-18 22:00:09.853738 | LOOP [upload-logs : Compress console log and json output]
2026-02-18 22:00:09.898678 | localhost | skipping: Conditional result was False
2026-02-18 22:00:09.904227 | localhost | skipping: Conditional result was False
2026-02-18 22:00:09.917638 | 
2026-02-18 22:00:09.917775 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-18 22:00:09.960255 | localhost | skipping: Conditional result was False
2026-02-18 22:00:09.960725 | 
2026-02-18 22:00:09.963085 | localhost | skipping: Conditional result was False
2026-02-18 22:00:09.971754 | 
2026-02-18 22:00:09.971870 | LOOP [upload-logs : Upload console log and json output]