2025-12-03 16:27:29.453377 | Job console starting... 2025-12-03 16:27:29.466227 | Updating repositories 2025-12-03 16:27:29.494332 | Preparing job workspace 2025-12-03 16:27:34.850376 | Running Ansible setup... 2025-12-03 16:27:38.603187 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-03 16:27:39.241039 | 2025-12-03 16:27:39.241273 | PLAY [localhost] 2025-12-03 16:27:39.252390 | 2025-12-03 16:27:39.252465 | TASK [Gathering Facts] 2025-12-03 16:27:40.252988 | localhost | ok 2025-12-03 16:27:40.268187 | 2025-12-03 16:27:40.268273 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-03 16:27:40.737189 | localhost -> localhost | changed 2025-12-03 16:27:40.744666 | 2025-12-03 16:27:40.744763 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-03 16:27:41.685071 | localhost -> localhost | changed 2025-12-03 16:27:41.694215 | 2025-12-03 16:27:41.694284 | TASK [Setup log path fact] 2025-12-03 16:27:41.723164 | localhost | ok 2025-12-03 16:27:41.739638 | 2025-12-03 16:27:41.739832 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-03 16:27:41.770256 | localhost | ok 2025-12-03 16:27:41.778164 | 2025-12-03 16:27:41.778235 | TASK [emit-job-header : Print job information] 2025-12-03 16:27:41.816410 | # Job Information 2025-12-03 16:27:41.816564 | Ansible Version: 2.15.12 2025-12-03 16:27:41.816590 | Job: vexxhost-hotstack-sno-2-bm 2025-12-03 16:27:41.816609 | Pipeline: github-experimental-trigger 2025-12-03 16:27:41.816628 | Executor: ze04.softwarefactory-project.io 2025-12-03 16:27:41.816646 | Triggered by: https://github.com/openstack-k8s-operators/hotstack/pull/235 2025-12-03 16:27:41.816665 | Log URL (when completed): https://logserver.rdoproject.org/fb2/rdoproject.org/fb229be766ea4a8181050429cce946b6/ 2025-12-03 16:27:41.816705 | Event ID: d741dc10-d064-11f0-92f6-fb5adb39988e 2025-12-03 16:27:41.820362 | 2025-12-03 16:27:41.820431 | LOOP [emit-job-header : Print node information] 2025-12-03 16:27:41.919356 | localhost | ok: 2025-12-03 16:27:41.919920 | localhost | # Node Information 2025-12-03 16:27:41.919954 | localhost | Inventory Hostname: hotstack 2025-12-03 16:27:41.919977 | localhost | Hostname: np0005544418 2025-12-03 16:27:41.919996 | localhost | Username: zuul 2025-12-03 16:27:41.920016 | localhost | Distro: CentOS 9 2025-12-03 16:27:41.920034 | localhost | Provider: vexxhost-nodepool-tripleo 2025-12-03 16:27:41.920051 | localhost | Region: RegionOne 2025-12-03 16:27:41.920067 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2025-12-03 16:27:41.920084 | localhost | Product Name: OpenStack Nova 2025-12-03 16:27:41.920100 | localhost | Interface IP: 38.102.83.199 2025-12-03 16:27:41.970846 | 2025-12-03 16:27:41.971015 | PLAY [all] 2025-12-03 16:27:41.980924 | 2025-12-03 16:27:41.981014 | TASK [Gather network facts] 2025-12-03 16:27:42.412361 | hotstack | ok 2025-12-03 16:27:42.426922 | 2025-12-03 16:27:42.427002 | TASK [include_role : start-zuul-console] 2025-12-03 16:27:42.457436 | hotstack | ok 2025-12-03 16:27:42.469314 | 2025-12-03 16:27:42.469380 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-03 16:27:42.881587 | hotstack | ok 2025-12-03 16:27:42.901403 | 2025-12-03 16:27:42.901511 | TASK [include_role : add-build-sshkey] 2025-12-03 16:27:42.934249 | hotstack | ok 2025-12-03 16:27:42.952972 | 2025-12-03 16:27:42.953061 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-03 16:27:43.245843 | hotstack -> localhost | ok 2025-12-03 16:27:43.252147 | 2025-12-03 16:27:43.252217 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-03 16:27:43.283181 | hotstack | ok 2025-12-03 16:27:43.298187 | hotstack | included: /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-03 16:27:43.304236 | 2025-12-03 16:27:43.304365 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-03 16:27:44.011930 | hotstack -> localhost | Generating public/private rsa key pair. 2025-12-03 16:27:44.012181 | hotstack -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/fb229be766ea4a8181050429cce946b6_id_rsa. 2025-12-03 16:27:44.012214 | hotstack -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/fb229be766ea4a8181050429cce946b6_id_rsa.pub. 2025-12-03 16:27:44.012242 | hotstack -> localhost | The key fingerprint is: 2025-12-03 16:27:44.012262 | hotstack -> localhost | SHA256:eg5aOB9pZRhngVec343wtDHsO8ghLD3C/eVEObRbHoo zuul-build-sshkey 2025-12-03 16:27:44.012283 | hotstack -> localhost | The key's randomart image is: 2025-12-03 16:27:44.012301 | hotstack -> localhost | +---[RSA 3072]----+ 2025-12-03 16:27:44.012320 | hotstack -> localhost | | ..o.. o.. | 2025-12-03 16:27:44.012340 | hotstack -> localhost | | . ..o . O. | 2025-12-03 16:27:44.012358 | hotstack -> localhost | | .oo+ . B.O.| 2025-12-03 16:27:44.012376 | hotstack -> localhost | | =+ * + X+o| 2025-12-03 16:27:44.012394 | hotstack -> localhost | | . So E B...| 2025-12-03 16:27:44.012412 | hotstack -> localhost | | . = + + | 2025-12-03 16:27:44.012429 | hotstack -> localhost | | o B . . | 2025-12-03 16:27:44.012447 | hotstack -> localhost | | * = | 2025-12-03 16:27:44.012464 | hotstack -> localhost | | . . . | 2025-12-03 16:27:44.012480 | hotstack -> localhost | +----[SHA256]-----+ 2025-12-03 16:27:44.012563 | hotstack -> localhost | ok: Runtime: 0:00:00.300654 2025-12-03 16:27:44.019208 | 2025-12-03 16:27:44.019274 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-03 16:27:44.050179 | hotstack | ok 2025-12-03 16:27:44.060752 | hotstack | included: /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-03 16:27:44.069112 | 2025-12-03 16:27:44.069171 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-03 16:27:44.097180 | hotstack | skipping: Conditional result was False 2025-12-03 16:27:44.104165 | 2025-12-03 16:27:44.104236 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-03 16:27:44.581017 | hotstack | changed 2025-12-03 16:27:44.597935 | 2025-12-03 16:27:44.598148 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-03 16:27:44.850457 | hotstack | ok 2025-12-03 16:27:44.861397 | 2025-12-03 16:27:44.861508 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-03 16:27:45.592021 | hotstack | changed 2025-12-03 16:27:45.597319 | 2025-12-03 16:27:45.597386 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-03 16:27:46.400276 | hotstack | changed 2025-12-03 16:27:46.412791 | 2025-12-03 16:27:46.412988 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-03 16:27:46.442382 | hotstack | skipping: Conditional result was False 2025-12-03 16:27:46.453256 | 2025-12-03 16:27:46.453351 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-03 16:27:46.856429 | hotstack -> localhost | changed 2025-12-03 16:27:46.871939 | 2025-12-03 16:27:46.872121 | TASK [add-build-sshkey : Add back temp key] 2025-12-03 16:27:47.190872 | hotstack -> localhost | Identity added: /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/fb229be766ea4a8181050429cce946b6_id_rsa (zuul-build-sshkey) 2025-12-03 16:27:47.191192 | hotstack -> localhost | ok: Runtime: 0:00:00.010758 2025-12-03 16:27:47.198040 | 2025-12-03 16:27:47.198126 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-03 16:27:47.604922 | hotstack | ok 2025-12-03 16:27:47.620802 | 2025-12-03 16:27:47.620937 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-03 16:27:47.677097 | hotstack | skipping: Conditional result was False 2025-12-03 16:27:47.737052 | 2025-12-03 16:27:47.737198 | TASK [include_role : validate-host] 2025-12-03 16:27:47.767429 | hotstack | ok 2025-12-03 16:27:47.788188 | 2025-12-03 16:27:47.788280 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-03 16:27:47.829996 | hotstack | ok 2025-12-03 16:27:47.835125 | 2025-12-03 16:27:47.835203 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-03 16:27:48.109143 | hotstack -> localhost | ok 2025-12-03 16:27:48.116269 | 2025-12-03 16:27:48.116334 | TASK [validate-host : Collect information about the host] 2025-12-03 16:27:48.808721 | hotstack | ok 2025-12-03 16:27:48.822527 | 2025-12-03 16:27:48.822618 | TASK [validate-host : Sanitize hostname] 2025-12-03 16:27:48.907573 | hotstack | ok 2025-12-03 16:27:48.915220 | 2025-12-03 16:27:48.915323 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-03 16:27:49.427879 | hotstack -> localhost | changed 2025-12-03 16:27:49.434816 | 2025-12-03 16:27:49.434885 | TASK [validate-host : Collect information about zuul worker] 2025-12-03 16:27:49.859367 | hotstack | ok 2025-12-03 16:27:49.871540 | 2025-12-03 16:27:49.871717 | TASK [validate-host : Write out all zuul information for each host] 2025-12-03 16:27:50.397086 | hotstack -> localhost | changed 2025-12-03 16:27:50.410577 | 2025-12-03 16:27:50.410822 | TASK [include_role : prepare-workspace-openshift] 2025-12-03 16:27:50.427274 | hotstack | skipping: Conditional result was False 2025-12-03 16:27:50.434724 | 2025-12-03 16:27:50.434931 | TASK [include_role : remove-zuul-sshkey] 2025-12-03 16:27:50.462732 | hotstack | skipping: Conditional result was False 2025-12-03 16:27:50.470111 | 2025-12-03 16:27:50.470192 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-03 16:27:50.753739 | hotstack | ok: "logs" 2025-12-03 16:27:50.754182 | hotstack | ok: All items complete 2025-12-03 16:27:50.754238 | 2025-12-03 16:27:50.997127 | hotstack | ok: "artifacts" 2025-12-03 16:27:51.193904 | hotstack | ok: "docs" 2025-12-03 16:27:51.215653 | 2025-12-03 16:27:51.219914 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-03 16:27:51.492898 | hotstack | changed: "logs" 2025-12-03 16:27:51.766280 | hotstack | changed: "artifacts" 2025-12-03 16:27:51.990844 | hotstack | changed: "docs" 2025-12-03 16:27:52.030150 | 2025-12-03 16:27:52.030327 | PLAY RECAP 2025-12-03 16:27:52.030391 | hotstack | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-03 16:27:52.030426 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-03 16:27:52.030451 | 2025-12-03 16:27:52.187124 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-03 16:27:52.193569 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-12-03 16:27:52.861299 | 2025-12-03 16:27:52.861443 | PLAY [Create necessary files to deploy hotstack scenario] 2025-12-03 16:27:52.882962 | 2025-12-03 16:27:52.883065 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-03 16:27:53.327403 | hotstack | ok 2025-12-03 16:27:53.349813 | 2025-12-03 16:27:53.349949 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-03 16:27:56.707873 | hotstack | Output suppressed because no_log was given 2025-12-03 16:27:56.719760 | 2025-12-03 16:27:56.719837 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-12-03 16:27:57.193224 | hotstack | changed: 2025-12-03 16:27:57.193627 | hotstack | { 2025-12-03 16:27:57.193732 | hotstack | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDCINPOs6XsfMVQMqjmiduT3Bxhogy7MbAFOWlR+9LlKkTW1kV6glsCXY5svtggd2zRtc40UWalHaj9jC+yEkZdI35h2PkK+Sww52u4nczqgNpIFNt7Dm2xtYKbTolAV9jSeNkRlGMCq9EBzQlwiV0HkHx1CdNR/zzXbyNZLmOybFkXqR150H01kUhdv0v6AMWTDZjMEWO/PaWCOgzZhH9ztXjy+rwa7pdaI4+0Pb9Kib+d8/IrgNsLB/sCazqD+9/COI6AHqzTDS1aU9/gMQrUN1ronzMEQhzzOuoI8WeLqU++j+0dT2UWVPlQqoln+RYu7dUn/DSZDrsYenudT5+P" 2025-12-03 16:27:57.193784 | hotstack | } 2025-12-03 16:27:57.231094 | 2025-12-03 16:27:57.231255 | TASK [Assert cloud name and cloud secret] 2025-12-03 16:27:57.280784 | hotstack | Output suppressed because no_log was given 2025-12-03 16:27:57.293007 | 2025-12-03 16:27:57.293141 | TASK [Ensure openstack release repo is installed] 2025-12-03 16:28:04.274619 | hotstack | changed 2025-12-03 16:28:04.286076 | 2025-12-03 16:28:04.286209 | TASK [Install openstack client packages] 2025-12-03 16:28:20.773634 | hotstack | changed 2025-12-03 16:28:20.782184 | 2025-12-03 16:28:20.782277 | TASK [Ensure HotStack work dir] 2025-12-03 16:28:21.195597 | hotstack | changed 2025-12-03 16:28:21.203745 | 2025-12-03 16:28:21.203840 | LOOP [Ensure etc directories] 2025-12-03 16:28:21.509373 | hotstack | changed: "/etc/openstack" 2025-12-03 16:28:21.509667 | hotstack | changed: All items complete 2025-12-03 16:28:21.509714 | 2025-12-03 16:28:21.748109 | hotstack | changed: "/etc/hotstack" 2025-12-03 16:28:21.767896 | 2025-12-03 16:28:21.768040 | TASK [Ensure .ssh dir exists] 2025-12-03 16:28:22.012725 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:22.024282 | 2025-12-03 16:28:22.024418 | TASK [Ensure ssh keypair exists] 2025-12-03 16:28:32.587013 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:32.599459 | 2025-12-03 16:28:32.599593 | TASK [Generate CA cert file] 2025-12-03 16:28:32.638379 | hotstack | skipping: Conditional result was False 2025-12-03 16:28:32.650772 | 2025-12-03 16:28:32.650901 | TASK [Update CA certs] 2025-12-03 16:28:33.201268 | hotstack | skipping: Conditional result was False 2025-12-03 16:28:33.216816 | 2025-12-03 16:28:33.216978 | TASK [Set _auth_type fact] 2025-12-03 16:28:33.279060 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:33.290504 | 2025-12-03 16:28:33.290638 | TASK [Write clouds.yaml - user/password] 2025-12-03 16:28:34.502809 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:34.517378 | 2025-12-03 16:28:34.517475 | TASK [Create application credential for sushy-emulator] 2025-12-03 16:28:38.066309 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:38.077416 | 2025-12-03 16:28:38.077541 | TASK [Read application credential from file] 2025-12-03 16:28:38.493825 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:38.507233 | 2025-12-03 16:28:38.507367 | TASK [Delete temporary application credential file] 2025-12-03 16:28:38.793762 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:38.805441 | 2025-12-03 16:28:38.805580 | TASK [Assert application credential id and secret] 2025-12-03 16:28:38.902736 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:38.909747 | 2025-12-03 16:28:38.909830 | TASK [Write new clouds.yaml with application credentials] 2025-12-03 16:28:39.818579 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:39.830225 | 2025-12-03 16:28:39.830371 | TASK [Write hotstack cloud-secret.yaml] 2025-12-03 16:28:40.655844 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:40.666367 | 2025-12-03 16:28:40.666493 | TASK [Write clouds.yaml with application credentials] 2025-12-03 16:28:40.708221 | 2025-12-03 16:28:40.708503 | TASK [Write hotstack cloud-secret.yaml] 2025-12-03 16:28:40.898205 | 2025-12-03 16:28:40.898423 | PLAY RECAP 2025-12-03 16:28:40.898477 | hotstack | ok: 18 changed: 11 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-03 16:28:40.898498 | 2025-12-03 16:28:41.037762 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-12-03 16:28:41.041673 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-12-03 16:28:41.723902 | 2025-12-03 16:28:41.724086 | PLAY [Create hotstack scenario] 2025-12-03 16:28:41.750244 | 2025-12-03 16:28:41.750435 | TASK [Assert scenario is defined] 2025-12-03 16:28:41.813432 | hotstack | ok: All assertions passed 2025-12-03 16:28:41.821947 | 2025-12-03 16:28:41.822056 | TASK [Fetch bootstrap vars from remote to zuul executor] 2025-12-03 16:28:42.292993 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:42.305064 | 2025-12-03 16:28:42.305227 | TASK [Load bootstrap vars with template resolution] 2025-12-03 16:28:42.358378 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:42.369906 | 2025-12-03 16:28:42.370044 | TASK [Fetch automation vars from remote to zuul executor] 2025-12-03 16:28:42.777034 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:42.790304 | 2025-12-03 16:28:42.790451 | TASK [Load automation vars with template resolution] 2025-12-03 16:28:42.894100 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:42.901552 | 2025-12-03 16:28:42.901644 | TASK [Slurp zuul-build-sshkey from file] 2025-12-03 16:28:43.320122 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:43.333221 | 2025-12-03 16:28:43.333334 | TASK [Set up infrastructure (Heat stack)] 2025-12-03 16:28:43.364829 | hotstack | Output suppressed because no_log was given 2025-12-03 16:28:43.415995 | 2025-12-03 16:28:43.416117 | TASK [dataplane_ssh_keys : Ensure Dataplane ssh keypair exists] 2025-12-03 16:28:44.050342 | hotstack | changed 2025-12-03 16:28:44.065360 | 2025-12-03 16:28:44.065502 | TASK [dataplane_ssh_keys : Ensure Nova migration ssh keypair exists] 2025-12-03 16:28:44.482911 | hotstack | changed 2025-12-03 16:28:44.490776 | 2025-12-03 16:28:44.490865 | TASK [dataplane_ssh_keys : Set SSH public key facts] 2025-12-03 16:28:44.533228 | hotstack | ok 2025-12-03 16:28:44.541242 | 2025-12-03 16:28:44.541332 | TASK [dataplane_ssh_keys : Store SSH public key facts in file] 2025-12-03 16:28:45.509152 | hotstack | changed 2025-12-03 16:28:45.548457 | 2025-12-03 16:28:45.548741 | TASK [heat_stack : Assert config is defined] 2025-12-03 16:28:45.646222 | hotstack | ok: All assertions passed 2025-12-03 16:28:45.654027 | 2025-12-03 16:28:45.654122 | TASK [heat_stack : Get latest snapset and update stack parameters] 2025-12-03 16:28:45.691615 | hotstack | skipping: Conditional result was False 2025-12-03 16:28:45.707997 | 2025-12-03 16:28:45.708149 | TASK [heat_stack : Debug latest snapset information] 2025-12-03 16:28:45.746808 | hotstack | skipping: Conditional result was False 2025-12-03 16:28:45.761100 | 2025-12-03 16:28:45.761246 | TASK [heat_stack : Create stack] 2025-12-03 16:29:54.374087 | hotstack | changed 2025-12-03 16:29:54.389016 | 2025-12-03 16:29:54.389122 | TASK [heat_stack : Wait for stack to complete] 2025-12-03 16:29:56.075811 | hotstack | ok 2025-12-03 16:29:56.088917 | 2025-12-03 16:29:56.089076 | TASK [heat_stack : Debug - stack_info] 2025-12-03 16:29:56.121181 | hotstack | skipping: Conditional result was False 2025-12-03 16:29:56.135255 | 2025-12-03 16:29:56.135390 | TASK [heat_stack : Stop if stack not complete] 2025-12-03 16:29:56.163851 | hotstack | skipping: Conditional result was False 2025-12-03 16:29:56.177067 | 2025-12-03 16:29:56.177210 | TASK [heat_stack : Get stack outputs] 2025-12-03 16:29:57.918553 | hotstack | changed 2025-12-03 16:29:57.933066 | 2025-12-03 16:29:57.933206 | TASK [heat_stack : Set stack outputs facts] 2025-12-03 16:29:57.983111 | hotstack | ok 2025-12-03 16:29:57.996755 | 2025-12-03 16:29:57.996887 | TASK [heat_stack : Store stack outputs in file] 2025-12-03 16:29:58.850431 | hotstack | changed 2025-12-03 16:29:58.867242 | 2025-12-03 16:29:58.867331 | TASK [Fetch stack outputs from remote to zuul executor] 2025-12-03 16:29:59.252308 | hotstack | Output suppressed because no_log was given 2025-12-03 16:29:59.262786 | 2025-12-03 16:29:59.262920 | TASK [Load stack output vars with template resolution] 2025-12-03 16:29:59.327288 | hotstack | Output suppressed because no_log was given 2025-12-03 16:29:59.337903 | 2025-12-03 16:29:59.338035 | TASK [Fetch cloud secrets from remote to zuul executor] 2025-12-03 16:29:59.716418 | hotstack | Output suppressed because no_log was given 2025-12-03 16:29:59.727289 | 2025-12-03 16:29:59.727425 | TASK [Load hotstack cloud secret vars with template resolution] 2025-12-03 16:29:59.779883 | hotstack | Output suppressed because no_log was given 2025-12-03 16:29:59.791571 | 2025-12-03 16:29:59.791753 | TASK [Add Hotstack controller-0 to ansible inventory] 2025-12-03 16:29:59.846869 | hotstack | Output suppressed because no_log was given 2025-12-03 16:29:59.859877 | 2025-12-03 16:29:59.860190 | TASK [Wait for Hotstack controller-0 to be ready] 2025-12-03 16:35:06.634848 | hotstack -> 38.102.83.23 | Output suppressed because no_log was given failure 2025-12-03 16:35:06.637507 | 2025-12-03 16:35:06.637587 | PLAY RECAP 2025-12-03 16:35:06.637664 | hotstack | ok: 21 changed: 11 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2025-12-03 16:35:06.637739 | 2025-12-03 16:35:06.781946 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-12-03 16:35:06.785271 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-12-03 16:35:07.351103 | 2025-12-03 16:35:07.351236 | PLAY [Collect hotstack logs and clean up environment] 2025-12-03 16:35:07.373547 | 2025-12-03 16:35:07.373661 | TASK [Fetch stack outputs from remote to zuul executor] 2025-12-03 16:35:07.961555 | hotstack | Output suppressed because no_log was given 2025-12-03 16:35:07.972791 | 2025-12-03 16:35:07.972956 | TASK [Load stack output vars with template resolution] 2025-12-03 16:35:08.020853 | hotstack | Output suppressed because no_log was given 2025-12-03 16:35:08.031718 | 2025-12-03 16:35:08.031859 | TASK [Add Hotstack controller-0 to ansible inventory] 2025-12-03 16:35:08.078810 | hotstack | Output suppressed because no_log was given 2025-12-03 16:35:08.090933 | 2025-12-03 16:35:08.091090 | TASK [Wait for Hotstack controller-0 to be ready] 2025-12-03 16:40:15.956015 | hotstack -> 38.102.83.23 | Output suppressed because no_log was given 2025-12-03 16:40:15.974154 | 2025-12-03 16:40:15.974346 | TASK [Print message that log collection failed] 2025-12-03 16:40:16.017835 | hotstack | ok: WARNING: Log collection failed and may be incomplete. Continue with cleanup ... 2025-12-03 16:40:16.033117 | 2025-12-03 16:40:16.033250 | TASK [Set _auth_type fact] 2025-12-03 16:40:16.100270 | hotstack | Output suppressed because no_log was given 2025-12-03 16:40:16.109390 | 2025-12-03 16:40:16.109496 | TASK [Write clouds.yaml] 2025-12-03 16:40:17.365118 | hotstack | Output suppressed because no_log was given 2025-12-03 16:40:17.377282 | 2025-12-03 16:40:17.377417 | TASK [Delete application credentials] 2025-12-03 16:40:19.928612 | hotstack | changed 2025-12-03 16:40:19.941584 | 2025-12-03 16:40:19.941763 | TASK [Print message that application credential failed to delete] 2025-12-03 16:40:19.969082 | hotstack | skipping: Conditional result was False 2025-12-03 16:40:19.982058 | 2025-12-03 16:40:19.982192 | TASK [Print message that application credential deleted successfully] 2025-12-03 16:40:20.029427 | hotstack | ok: Application credential deleted successfully. 2025-12-03 16:40:20.039851 | 2025-12-03 16:40:20.039981 | TASK [Write clouds.yaml with application credentials] 2025-12-03 16:40:20.078058 | 2025-12-03 16:40:20.078343 | TASK [Delete the heat stack] 2025-12-03 11:40:45.017437 | hotstack | 2025-12-03 16:40:24Z [hs-fb229be766ea4a8181050429cce946b6]: DELETE_IN_PROGRESS Stack DELETE started 2025-12-03 11:40:45.017553 | hotstack | 2025-12-03 16:40:25Z [hs-fb229be766ea4a8181050429cce946b6.ironic-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017573 | hotstack | 2025-12-03 16:40:26Z [hs-fb229be766ea4a8181050429cce946b6.controller-floating-ip]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017587 | hotstack | 2025-12-03 16:40:27Z [hs-fb229be766ea4a8181050429cce946b6.controller-floating-ip]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017601 | hotstack | 2025-12-03 16:40:27Z [hs-fb229be766ea4a8181050429cce946b6.machine-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017615 | hotstack | 2025-12-03 16:40:27Z [hs-fb229be766ea4a8181050429cce946b6.ironic0]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017629 | hotstack | 2025-12-03 16:40:27Z [hs-fb229be766ea4a8181050429cce946b6.ironic-net-router-interface]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017642 | hotstack | 2025-12-03 16:40:28Z [hs-fb229be766ea4a8181050429cce946b6.ironic1]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017656 | hotstack | 2025-12-03 16:40:29Z [hs-fb229be766ea4a8181050429cce946b6.machine-net-router-interface]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017669 | hotstack | 2025-12-03 16:40:29Z [hs-fb229be766ea4a8181050429cce946b6.controller]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017682 | hotstack | 2025-12-03 16:40:30Z [hs-fb229be766ea4a8181050429cce946b6.master0]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017695 | hotstack | 2025-12-03 16:40:31Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017709 | hotstack | 2025-12-03 16:40:32Z [hs-fb229be766ea4a8181050429cce946b6.ironic1]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017722 | hotstack | 2025-12-03 16:40:32Z [hs-fb229be766ea4a8181050429cce946b6.ironic1-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017735 | hotstack | 2025-12-03 16:40:33Z [hs-fb229be766ea4a8181050429cce946b6.ironic1-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017748 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.ironic0]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017762 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.ironic0-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017775 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-net-router-interface]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017788 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.router]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017801 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017814 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-init]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017827 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-init]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017840 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-write-files]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017853 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-runcmd]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017867 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.ironic0-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017880 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller_users]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017893 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-write-files]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017906 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller-runcmd]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017919 | hotstack | 2025-12-03 16:40:34Z [hs-fb229be766ea4a8181050429cce946b6.controller_users]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017932 | hotstack | 2025-12-03 16:40:35Z [hs-fb229be766ea4a8181050429cce946b6.router]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017959 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0]: DELETE_COMPLETE state changed 2025-12-03 11:40:45.017973 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-machine-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.017989 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol0]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.018003 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol1]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.018016 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-lvms-vol0]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.018032 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-trunk0]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.018046 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol2]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:45.018070 | hotstack | 2025-12-03 16:40:39Z [hs-fb229be766ea4a8181050429cce946b6.master0-ironic-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110189 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-ironic-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110387 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.ironic-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110427 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-machine-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110442 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.extra-dhcp-opts-value]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110456 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.extra-dhcp-opts-value]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110470 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.controller-machine-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110483 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-lvms-vol0]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110496 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol0]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110510 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol2]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110523 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.ironic-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110536 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-trunk0]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110549 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.ironic-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110562 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110580 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-tenant-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110599 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-cinder-vol1]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110613 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110627 | hotstack | 2025-12-03 16:40:40Z [hs-fb229be766ea4a8181050429cce946b6.master0-storage-port]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110640 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.master0-storage-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110653 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.storage-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110666 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.controller-machine-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110679 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.machine-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110706 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.master0-internal-api-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110720 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.master0-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110733 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.internal-api-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110746 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110760 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.ironic-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110782 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.storage-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110795 | hotstack | 2025-12-03 16:40:41Z [hs-fb229be766ea4a8181050429cce946b6.storage-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110808 | hotstack | 2025-12-03 16:40:42Z [hs-fb229be766ea4a8181050429cce946b6.internal-api-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110821 | hotstack | 2025-12-03 16:40:42Z [hs-fb229be766ea4a8181050429cce946b6.internal-api-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110835 | hotstack | 2025-12-03 16:40:42Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110848 | hotstack | 2025-12-03 16:40:42Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110861 | hotstack | 2025-12-03 16:40:43Z [hs-fb229be766ea4a8181050429cce946b6.master0-tenant-port]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110874 | hotstack | 2025-12-03 16:40:44Z [hs-fb229be766ea4a8181050429cce946b6.tenant-subnet]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110887 | hotstack | 2025-12-03 16:40:44Z [hs-fb229be766ea4a8181050429cce946b6.storage-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110901 | hotstack | 2025-12-03 16:40:44Z [hs-fb229be766ea4a8181050429cce946b6.tenant-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110914 | hotstack | 2025-12-03 16:40:44Z [hs-fb229be766ea4a8181050429cce946b6.tenant-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.110927 | hotstack | 2025-12-03 16:40:45Z [hs-fb229be766ea4a8181050429cce946b6.machine-subnet]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.110950 | hotstack | 2025-12-03 16:40:45Z [hs-fb229be766ea4a8181050429cce946b6.machine-net]: DELETE_IN_PROGRESS state changed 2025-12-03 11:40:50.206862 | hotstack | 2025-12-03 16:40:46Z [hs-fb229be766ea4a8181050429cce946b6.internal-api-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.207005 | hotstack | 2025-12-03 16:40:46Z [hs-fb229be766ea4a8181050429cce946b6.ctlplane-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.207018 | hotstack | 2025-12-03 16:40:46Z [hs-fb229be766ea4a8181050429cce946b6.tenant-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.207028 | hotstack | 2025-12-03 16:40:46Z [hs-fb229be766ea4a8181050429cce946b6.machine-net]: DELETE_COMPLETE state changed 2025-12-03 11:40:50.207037 | hotstack | 2025-12-03 16:40:47Z [hs-fb229be766ea4a8181050429cce946b6]: DELETE_COMPLETE Stack DELETE completed successfully 2025-12-03 16:40:50.408977 | hotstack | changed 2025-12-03 16:40:50.424384 | 2025-12-03 16:40:50.424583 | TASK [Print message that stack failed to delete] 2025-12-03 16:40:50.454854 | hotstack | skipping: Conditional result was False 2025-12-03 16:40:50.469004 | 2025-12-03 16:40:50.469154 | TASK [Print message that stack deleted successfully] 2025-12-03 16:40:50.522335 | hotstack | ok: Stack deleted successfully. 2025-12-03 16:40:50.535066 | 2025-12-03 16:40:50.535199 | TASK [Delete clouds.yaml] 2025-12-03 16:40:50.975559 | hotstack | Output suppressed because no_log was given 2025-12-03 16:40:51.016460 | 2025-12-03 16:40:51.016613 | PLAY RECAP 2025-12-03 16:40:51.016706 | hotstack | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 1 ignored: 0 2025-12-03 16:40:51.016741 | 2025-12-03 16:40:51.180835 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-12-03 16:40:51.183871 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-03 16:40:51.759127 | 2025-12-03 16:40:51.759255 | PLAY [all] 2025-12-03 16:40:51.778197 | 2025-12-03 16:40:51.778273 | TASK [include_role : fetch-output] 2025-12-03 16:40:51.828197 | hotstack | ok 2025-12-03 16:40:51.845399 | 2025-12-03 16:40:51.845472 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-03 16:40:51.900823 | hotstack | skipping: Conditional result was False 2025-12-03 16:40:51.906974 | 2025-12-03 16:40:51.907044 | TASK [fetch-output : Set log path for single node] 2025-12-03 16:40:51.967824 | hotstack | ok 2025-12-03 16:40:51.974860 | 2025-12-03 16:40:51.974951 | LOOP [fetch-output : Ensure local output dirs] 2025-12-03 16:40:52.454439 | hotstack -> localhost | ok: "/var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/logs" 2025-12-03 16:40:52.701918 | hotstack -> localhost | changed: "/var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/artifacts" 2025-12-03 16:40:52.936963 | hotstack -> localhost | changed: "/var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/docs" 2025-12-03 16:40:52.957769 | 2025-12-03 16:40:52.958063 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-03 16:40:53.730590 | hotstack | changed: .d..t...... ./ 2025-12-03 16:40:53.731228 | hotstack | changed: All items complete 2025-12-03 16:40:53.731294 | 2025-12-03 16:40:54.292671 | hotstack | changed: .d..t...... ./ 2025-12-03 16:40:54.836200 | hotstack | changed: .d..t...... ./ 2025-12-03 16:40:54.862622 | 2025-12-03 16:40:54.862844 | TASK [include_role : fetch-output-openshift] 2025-12-03 16:40:54.889928 | hotstack | skipping: Conditional result was False 2025-12-03 16:40:54.898652 | 2025-12-03 16:40:54.898792 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-03 16:40:55.403797 | hotstack -> localhost | ok: Item: artifacts Runtime: 0:00:00.016728 2025-12-03 16:40:55.705959 | hotstack -> localhost | ok: Item: docs Runtime: 0:00:00.011816 2025-12-03 16:40:55.738754 | 2025-12-03 16:40:55.738924 | PLAY [all] 2025-12-03 16:40:55.754090 | 2025-12-03 16:40:55.754167 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-03 16:40:56.450566 | hotstack | changed 2025-12-03 16:40:56.496499 | 2025-12-03 16:40:56.496639 | PLAY RECAP 2025-12-03 16:40:56.496726 | hotstack | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-12-03 16:40:56.496761 | 2025-12-03 16:40:56.661423 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-03 16:40:56.667626 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-12-03 16:40:57.356215 | 2025-12-03 16:40:57.356425 | PLAY [localhost] 2025-12-03 16:40:57.374793 | 2025-12-03 16:40:57.374876 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-03 16:40:57.843911 | localhost | changed 2025-12-03 16:40:57.854880 | 2025-12-03 16:40:57.855044 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-03 16:40:57.902400 | localhost | ok 2025-12-03 16:40:57.921084 | 2025-12-03 16:40:57.921235 | TASK [add-fileserver : Create SSH private key tempfile] 2025-12-03 16:40:58.358232 | localhost | changed 2025-12-03 16:40:58.366733 | 2025-12-03 16:40:58.366849 | TASK [add-fileserver : Create SSH private key from secret] 2025-12-03 16:40:59.186600 | localhost | changed 2025-12-03 16:40:59.198456 | 2025-12-03 16:40:59.198601 | TASK [add-fileserver : Add fileserver ssh key] 2025-12-03 16:40:59.694530 | localhost | Identity added: /var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/tmp/ansible.lwpg_vyb (/var/lib/zuul/builds/fb229be766ea4a8181050429cce946b6/work/tmp/ansible.lwpg_vyb) 2025-12-03 16:40:59.694954 | localhost | ok: Runtime: 0:00:00.014413 2025-12-03 16:40:59.705081 | 2025-12-03 16:40:59.705325 | TASK [add-fileserver : Remove SSH private key from disk] 2025-12-03 16:41:00.031031 | localhost | ok: Runtime: 0:00:00.010035 2025-12-03 16:41:00.043324 | 2025-12-03 16:41:00.043464 | TASK [add-fileserver : Add fileserver to inventory] 2025-12-03 16:41:00.097878 | localhost | changed 2025-12-03 16:41:00.105277 | 2025-12-03 16:41:00.105368 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-12-03 16:41:00.544419 | localhost | changed 2025-12-03 16:41:00.573889 | 2025-12-03 16:41:00.573968 | PLAY [localhost] 2025-12-03 16:41:00.624235 | 2025-12-03 16:41:00.624394 | TASK [Generate bulk log download script] 2025-12-03 16:41:00.644891 | localhost | ok 2025-12-03 16:41:00.657305 | 2025-12-03 16:41:00.657447 | TASK [local-log-download : Check API endpoint is defined] 2025-12-03 16:41:00.709730 | localhost | ok: All assertions passed 2025-12-03 16:41:00.716637 | 2025-12-03 16:41:00.716747 | TASK [local-log-download : Create download script] 2025-12-03 16:41:01.259768 | localhost -> localhost | changed 2025-12-03 16:41:01.279294 | 2025-12-03 16:41:01.279425 | TASK [Register quick-download link] 2025-12-03 16:41:01.317073 | localhost | ok 2025-12-03 16:41:01.335360 | 2025-12-03 16:41:01.335469 | PLAY [logserver.rdoproject.org] 2025-12-03 16:41:01.345500 | 2025-12-03 16:41:01.345569 | TASK [Set zuul-log-path fact] 2025-12-03 16:41:01.367247 | logserver.rdoproject.org | ok 2025-12-03 16:41:01.386379 | 2025-12-03 16:41:01.386513 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-03 16:41:01.429094 | logserver.rdoproject.org | ok 2025-12-03 16:41:01.441305 | 2025-12-03 16:41:01.441444 | TASK [upload-logs : Create log directories] 2025-12-03 16:41:02.290952 | logserver.rdoproject.org | changed 2025-12-03 16:41:02.298669 | 2025-12-03 16:41:02.298863 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-03 16:41:02.643652 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.009401 2025-12-03 16:41:02.653432 | 2025-12-03 16:41:02.653563 | TASK [upload-logs : Upload logs to log server] 2025-12-03 16:41:03.420541 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-12-03 16:41:03.426868 | 2025-12-03 16:41:03.427000 | LOOP [upload-logs : Compress console log and json output] 2025-12-03 16:41:03.498003 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-03 16:41:03.509409 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-03 16:41:03.522777 | 2025-12-03 16:41:03.522951 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-03 16:41:03.593970 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-03 16:41:03.594360 | 2025-12-03 16:41:03.598890 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-03 16:41:03.608997 | 2025-12-03 16:41:03.609162 | LOOP [upload-logs : Upload console log and json output]