2025-10-12 16:35:01.138182 | Job console starting... 2025-10-12 16:35:01.148548 | Updating repositories 2025-10-12 16:35:01.173004 | Preparing job workspace 2025-10-12 16:35:07.010549 | Running Ansible setup... 2025-10-12 16:35:11.037191 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-12 16:35:11.594488 | 2025-10-12 16:35:11.594630 | PLAY [localhost] 2025-10-12 16:35:11.603146 | 2025-10-12 16:35:11.603217 | TASK [Gathering Facts] 2025-10-12 16:35:12.549985 | localhost | ok 2025-10-12 16:35:12.563290 | 2025-10-12 16:35:12.563382 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 16:35:12.993855 | localhost -> localhost | changed 2025-10-12 16:35:13.005076 | 2025-10-12 16:35:13.005219 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 16:35:13.899651 | localhost -> localhost | changed 2025-10-12 16:35:13.917817 | 2025-10-12 16:35:13.917957 | TASK [Setup log path fact] 2025-10-12 16:35:13.943536 | localhost | ok 2025-10-12 16:35:13.969454 | 2025-10-12 16:35:13.969598 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 16:35:14.000467 | localhost | ok 2025-10-12 16:35:14.010847 | 2025-10-12 16:35:14.010935 | TASK [emit-job-header : Print job information] 2025-10-12 16:35:14.064766 | # Job Information 2025-10-12 16:35:14.065028 | Ansible Version: 2.15.12 2025-10-12 16:35:14.065130 | Job: vexxhost-hotstack-secret-rotate 2025-10-12 16:35:14.065185 | Pipeline: github-experimental-trigger 2025-10-12 16:35:14.065227 | Executor: ze04.softwarefactory-project.io 2025-10-12 16:35:14.065268 | Triggered by: https://github.com/openstack-k8s-operators/hotstack/pull/256 2025-10-12 16:35:14.065312 | Log URL (when completed): https://logserver.rdoproject.org/e96/rdoproject.org/e966dfec0ed64013a9fb918d42588279/ 2025-10-12 16:35:14.065354 | Event ID: 64be4c40-a784-11f0-99a8-934b44ac6230 2025-10-12 16:35:14.073296 | 2025-10-12 16:35:14.073434 | LOOP [emit-job-header : Print node information] 2025-10-12 16:35:14.204923 | localhost | ok: 2025-10-12 16:35:14.205251 | localhost | # Node Information 2025-10-12 16:35:14.205311 | localhost | Inventory Hostname: hotstack 2025-10-12 16:35:14.205359 | localhost | Hostname: np0005481620 2025-10-12 16:35:14.205401 | localhost | Username: zuul 2025-10-12 16:35:14.205445 | localhost | Distro: CentOS 9 2025-10-12 16:35:14.205484 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-12 16:35:14.205520 | localhost | Region: RegionOne 2025-10-12 16:35:14.205556 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2025-10-12 16:35:14.205592 | localhost | Product Name: OpenStack Nova 2025-10-12 16:35:14.205627 | localhost | Interface IP: 38.102.83.97 2025-10-12 16:35:14.251550 | 2025-10-12 16:35:14.251745 | PLAY [all] 2025-10-12 16:35:14.265464 | 2025-10-12 16:35:14.265594 | TASK [Gather network facts] 2025-10-12 16:35:14.823652 | hotstack | ok 2025-10-12 16:35:14.855980 | 2025-10-12 16:35:14.856127 | TASK [include_role : start-zuul-console] 2025-10-12 16:35:14.879944 | hotstack | ok 2025-10-12 16:35:14.896152 | 2025-10-12 16:35:14.896239 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 16:35:15.348936 | hotstack | ok 2025-10-12 16:35:15.367655 | 2025-10-12 16:35:15.367810 | TASK [include_role : add-build-sshkey] 2025-10-12 16:35:15.404066 | hotstack | ok 2025-10-12 16:35:15.431087 | 2025-10-12 16:35:15.431226 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 16:35:15.711426 | hotstack -> localhost | ok 2025-10-12 16:35:15.724170 | 2025-10-12 16:35:15.724334 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 16:35:15.752336 | hotstack | ok 2025-10-12 16:35:15.777669 | hotstack | included: /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 16:35:15.785411 | 2025-10-12 16:35:15.785495 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 16:35:16.383985 | hotstack -> localhost | Generating public/private rsa key pair. 2025-10-12 16:35:16.384352 | hotstack -> localhost | Your identification has been saved in /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/e966dfec0ed64013a9fb918d42588279_id_rsa. 2025-10-12 16:35:16.384420 | hotstack -> localhost | Your public key has been saved in /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/e966dfec0ed64013a9fb918d42588279_id_rsa.pub. 2025-10-12 16:35:16.384469 | hotstack -> localhost | The key fingerprint is: 2025-10-12 16:35:16.384512 | hotstack -> localhost | SHA256:IIEfikDFcBfpTROFeTAJBIWGS+WoXASfLYqQW/Ie2Wg zuul-build-sshkey 2025-10-12 16:35:16.384554 | hotstack -> localhost | The key's randomart image is: 2025-10-12 16:35:16.384595 | hotstack -> localhost | +---[RSA 3072]----+ 2025-10-12 16:35:16.384635 | hotstack -> localhost | |.+BB**++B. | 2025-10-12 16:35:16.384674 | hotstack -> localhost | |.+B+=o *.. | 2025-10-12 16:35:16.384779 | hotstack -> localhost | |*o+Ooo+ o | 2025-10-12 16:35:16.384821 | hotstack -> localhost | |**++oo o | 2025-10-12 16:35:16.384861 | hotstack -> localhost | |+oE . S | 2025-10-12 16:35:16.384901 | hotstack -> localhost | | o . | 2025-10-12 16:35:16.384939 | hotstack -> localhost | | . | 2025-10-12 16:35:16.384982 | hotstack -> localhost | | | 2025-10-12 16:35:16.385022 | hotstack -> localhost | | | 2025-10-12 16:35:16.385061 | hotstack -> localhost | +----[SHA256]-----+ 2025-10-12 16:35:16.385147 | hotstack -> localhost | ok: Runtime: 0:00:00.115463 2025-10-12 16:35:16.397355 | 2025-10-12 16:35:16.397500 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 16:35:16.424023 | hotstack | ok 2025-10-12 16:35:16.442209 | hotstack | included: /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 16:35:16.453529 | 2025-10-12 16:35:16.453610 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 16:35:16.467959 | hotstack | skipping: Conditional result was False 2025-10-12 16:35:16.475396 | 2025-10-12 16:35:16.475478 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 16:35:16.951046 | hotstack | changed 2025-10-12 16:35:16.961407 | 2025-10-12 16:35:16.961539 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 16:35:17.231622 | hotstack | ok 2025-10-12 16:35:17.242481 | 2025-10-12 16:35:17.242623 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 16:35:18.247470 | hotstack | changed 2025-10-12 16:35:18.257969 | 2025-10-12 16:35:18.258101 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 16:35:19.255075 | hotstack | changed 2025-10-12 16:35:19.265569 | 2025-10-12 16:35:19.265754 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 16:35:19.291507 | hotstack | skipping: Conditional result was False 2025-10-12 16:35:19.303258 | 2025-10-12 16:35:19.303391 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 16:35:19.717546 | hotstack -> localhost | changed 2025-10-12 16:35:19.738380 | 2025-10-12 16:35:19.738529 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 16:35:20.049738 | hotstack -> localhost | Identity added: /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/e966dfec0ed64013a9fb918d42588279_id_rsa (zuul-build-sshkey) 2025-10-12 16:35:20.049955 | hotstack -> localhost | ok: Runtime: 0:00:00.013364 2025-10-12 16:35:20.055317 | 2025-10-12 16:35:20.055380 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 16:35:20.477020 | hotstack | ok 2025-10-12 16:35:20.521108 | 2025-10-12 16:35:20.521249 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 16:35:20.556584 | hotstack | skipping: Conditional result was False 2025-10-12 16:35:20.576901 | 2025-10-12 16:35:20.577025 | TASK [include_role : validate-host] 2025-10-12 16:35:20.612919 | hotstack | ok 2025-10-12 16:35:20.646394 | 2025-10-12 16:35:20.646483 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 16:35:20.687012 | hotstack | ok 2025-10-12 16:35:20.693046 | 2025-10-12 16:35:20.693126 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 16:35:20.983540 | hotstack -> localhost | ok 2025-10-12 16:35:20.995240 | 2025-10-12 16:35:20.995372 | TASK [validate-host : Collect information about the host] 2025-10-12 16:35:22.838108 | hotstack | ok 2025-10-12 16:35:22.856729 | 2025-10-12 16:35:22.856887 | TASK [validate-host : Sanitize hostname] 2025-10-12 16:35:22.933714 | hotstack | ok 2025-10-12 16:35:22.945568 | 2025-10-12 16:35:22.945727 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 16:35:23.459352 | hotstack -> localhost | changed 2025-10-12 16:35:23.465309 | 2025-10-12 16:35:23.465373 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 16:35:23.948392 | hotstack | ok 2025-10-12 16:35:23.970776 | 2025-10-12 16:35:23.971043 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 16:35:24.431931 | hotstack -> localhost | changed 2025-10-12 16:35:24.452797 | 2025-10-12 16:35:24.452926 | TASK [include_role : prepare-workspace-openshift] 2025-10-12 16:35:24.479497 | hotstack | skipping: Conditional result was False 2025-10-12 16:35:24.490303 | 2025-10-12 16:35:24.490428 | TASK [include_role : remove-zuul-sshkey] 2025-10-12 16:35:24.516841 | hotstack | skipping: Conditional result was False 2025-10-12 16:35:24.527939 | 2025-10-12 16:35:24.528074 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-12 16:35:24.845713 | hotstack | ok: "logs" 2025-10-12 16:35:24.846164 | hotstack | ok: All items complete 2025-10-12 16:35:24.846224 | 2025-10-12 16:35:25.105815 | hotstack | ok: "artifacts" 2025-10-12 16:35:25.374051 | hotstack | ok: "docs" 2025-10-12 16:35:25.393517 | 2025-10-12 16:35:25.393727 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-12 16:35:25.704582 | hotstack | changed: "logs" 2025-10-12 16:35:25.936600 | hotstack | changed: "artifacts" 2025-10-12 16:35:26.195243 | hotstack | changed: "docs" 2025-10-12 16:35:26.244797 | 2025-10-12 16:35:26.244919 | PLAY RECAP 2025-10-12 16:35:26.244975 | hotstack | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-12 16:35:26.245008 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-12 16:35:26.245032 | 2025-10-12 16:35:26.356247 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-12 16:35:26.361793 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-10-12 16:35:26.985541 | 2025-10-12 16:35:26.985716 | PLAY [Create necessary files to deploy hotstack scenario] 2025-10-12 16:35:27.005786 | 2025-10-12 16:35:27.005863 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-12 16:35:27.488454 | hotstack | ok 2025-10-12 16:35:27.501064 | 2025-10-12 16:35:27.501224 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-12 16:35:30.170527 | hotstack | Output suppressed because no_log was given 2025-10-12 16:35:30.193655 | 2025-10-12 16:35:30.193768 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-12 16:35:30.680107 | hotstack | changed: 2025-10-12 16:35:30.680452 | hotstack | { 2025-10-12 16:35:30.680520 | 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-10-12 16:35:30.680574 | hotstack | } 2025-10-12 16:35:30.703181 | 2025-10-12 16:35:30.703313 | TASK [Assert cloud name and cloud secret] 2025-10-12 16:35:30.771395 | hotstack | Output suppressed because no_log was given 2025-10-12 16:35:30.782018 | 2025-10-12 16:35:30.782153 | TASK [Ensure openstack release repo is installed] 2025-10-12 16:35:34.905440 | hotstack | changed 2025-10-12 16:35:34.917091 | 2025-10-12 16:35:34.917230 | TASK [Install openstack client packages] 2025-10-12 16:35:51.024668 | hotstack | changed 2025-10-12 16:35:51.035661 | 2025-10-12 16:35:51.035823 | TASK [Ensure HotStack work dir] 2025-10-12 16:35:51.481348 | hotstack | changed 2025-10-12 16:35:51.493096 | 2025-10-12 16:35:51.493224 | LOOP [Ensure etc directories] 2025-10-12 16:35:51.860823 | hotstack | changed: "/etc/openstack" 2025-10-12 16:35:51.861265 | hotstack | changed: All items complete 2025-10-12 16:35:51.861321 | 2025-10-12 16:35:52.137334 | hotstack | changed: "/etc/hotstack" 2025-10-12 16:35:52.157664 | 2025-10-12 16:35:52.157909 | TASK [Ensure .ssh dir exists] 2025-10-12 16:35:52.439400 | hotstack | Output suppressed because no_log was given 2025-10-12 16:35:52.452141 | 2025-10-12 16:35:52.452265 | TASK [Ensure ssh keypair exists] 2025-10-12 16:36:03.014310 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:03.026075 | 2025-10-12 16:36:03.026211 | TASK [Generate CA cert file] 2025-10-12 16:36:03.062794 | hotstack | skipping: Conditional result was False 2025-10-12 16:36:03.074922 | 2025-10-12 16:36:03.075063 | TASK [Update CA certs] 2025-10-12 16:36:03.623074 | hotstack | skipping: Conditional result was False 2025-10-12 16:36:03.636355 | 2025-10-12 16:36:03.636487 | TASK [Set _auth_type fact] 2025-10-12 16:36:03.693405 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:03.703601 | 2025-10-12 16:36:03.703776 | TASK [Write clouds.yaml - user/password] 2025-10-12 16:36:04.911723 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:04.922376 | 2025-10-12 16:36:04.922503 | TASK [Create application credential for sushy-emulator] 2025-10-12 16:36:06.989740 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:07.000010 | 2025-10-12 16:36:07.000132 | TASK [Read application credential from file] 2025-10-12 16:36:07.405220 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:07.415772 | 2025-10-12 16:36:07.415904 | TASK [Delete temporary application credential file] 2025-10-12 16:36:07.667922 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:07.679219 | 2025-10-12 16:36:07.679347 | TASK [Assert application credential id and secret] 2025-10-12 16:36:07.767363 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:07.777723 | 2025-10-12 16:36:07.777851 | TASK [Write new clouds.yaml with application credentials] 2025-10-12 16:36:08.681755 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:08.692162 | 2025-10-12 16:36:08.692295 | TASK [Write hotstack cloud-secret.yaml] 2025-10-12 16:36:09.688261 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:09.698859 | 2025-10-12 16:36:09.698989 | TASK [Write clouds.yaml with application credentials] 2025-10-12 16:36:09.739133 | 2025-10-12 16:36:09.739381 | TASK [Write hotstack cloud-secret.yaml] 2025-10-12 16:36:09.807786 | 2025-10-12 16:36:09.807931 | PLAY RECAP 2025-10-12 16:36:09.807992 | hotstack | ok: 18 changed: 11 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-12 16:36:09.808022 | 2025-10-12 16:36:09.918156 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-10-12 16:36:09.923671 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-10-12 16:36:10.514500 | 2025-10-12 16:36:10.514604 | PLAY [Create hotstack scenario] 2025-10-12 16:36:10.535205 | 2025-10-12 16:36:10.535277 | TASK [Assert scenario is defined] 2025-10-12 16:36:10.617529 | hotstack | ok: All assertions passed 2025-10-12 16:36:10.624359 | 2025-10-12 16:36:10.624470 | TASK [Fetch bootstrap vars from remote to zuul executor] 2025-10-12 16:36:11.159280 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:11.170291 | 2025-10-12 16:36:11.170429 | TASK [Load bootstrap vars with template resolution] 2025-10-12 16:36:11.217631 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:11.229986 | 2025-10-12 16:36:11.230118 | TASK [Fetch automation vars from remote to zuul executor] 2025-10-12 16:36:11.674620 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:11.684828 | 2025-10-12 16:36:11.684963 | TASK [Load automation vars with template resolution] 2025-10-12 16:36:11.742171 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:11.752242 | 2025-10-12 16:36:11.752361 | TASK [Slurp zuul-build-sshkey from file] 2025-10-12 16:36:12.126424 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:12.138354 | 2025-10-12 16:36:12.138500 | TASK [Set up infrastructure (Heat stack)] 2025-10-12 16:36:12.166716 | hotstack | Output suppressed because no_log was given 2025-10-12 16:36:12.215286 | 2025-10-12 16:36:12.215393 | TASK [dataplane_ssh_keys : Ensure Dataplane ssh keypair exists] 2025-10-12 16:36:12.854335 | hotstack | changed 2025-10-12 16:36:12.865510 | 2025-10-12 16:36:12.865632 | TASK [dataplane_ssh_keys : Ensure Nova migration ssh keypair exists] 2025-10-12 16:36:13.280168 | hotstack | changed 2025-10-12 16:36:13.292063 | 2025-10-12 16:36:13.292197 | TASK [dataplane_ssh_keys : Set SSH public key facts] 2025-10-12 16:36:13.340407 | hotstack | ok 2025-10-12 16:36:13.352329 | 2025-10-12 16:36:13.352459 | TASK [dataplane_ssh_keys : Store SSH public key facts in file] 2025-10-12 16:36:14.418347 | hotstack | changed 2025-10-12 16:36:14.440105 | 2025-10-12 16:36:14.440276 | TASK [heat_stack : Assert config is defined] 2025-10-12 16:36:14.549650 | hotstack | ok: All assertions passed 2025-10-12 16:36:14.561925 | 2025-10-12 16:36:14.562061 | TASK [heat_stack : Get latest snapset and update stack parameters] 2025-10-12 16:36:14.599947 | hotstack | skipping: Conditional result was False 2025-10-12 16:36:14.613659 | 2025-10-12 16:36:14.613876 | TASK [heat_stack : Debug latest snapset information] 2025-10-12 16:36:14.650782 | hotstack | skipping: Conditional result was False 2025-10-12 16:36:14.659138 | 2025-10-12 16:36:14.659224 | TASK [heat_stack : Create stack] 2025-10-12 16:38:41.230738 | hotstack | changed 2025-10-12 16:38:41.248476 | 2025-10-12 16:38:41.248602 | TASK [heat_stack : Wait for stack to complete] 2025-10-12 16:38:42.900859 | hotstack | ok 2025-10-12 16:38:42.912602 | 2025-10-12 16:38:42.912760 | TASK [heat_stack : Debug - stack_info] 2025-10-12 16:38:42.939761 | hotstack | skipping: Conditional result was False 2025-10-12 16:38:42.953236 | 2025-10-12 16:38:42.953370 | TASK [heat_stack : Stop if stack not complete] 2025-10-12 16:38:42.979843 | hotstack | skipping: Conditional result was False 2025-10-12 16:38:42.991558 | 2025-10-12 16:38:42.991731 | TASK [heat_stack : Get stack outputs] 2025-10-12 16:38:45.579843 | hotstack | changed 2025-10-12 16:38:45.596090 | 2025-10-12 16:38:45.596225 | TASK [heat_stack : Set stack outputs facts] 2025-10-12 16:38:45.657670 | hotstack | ok 2025-10-12 16:38:45.673085 | 2025-10-12 16:38:45.673221 | TASK [heat_stack : Store stack outputs in file] 2025-10-12 16:38:46.566369 | hotstack | changed 2025-10-12 16:38:46.586881 | 2025-10-12 16:38:46.587009 | TASK [Fetch stack outputs from remote to zuul executor] 2025-10-12 16:38:46.959748 | hotstack | Output suppressed because no_log was given 2025-10-12 16:38:46.969653 | 2025-10-12 16:38:46.969810 | TASK [Load stack output vars with template resolution] 2025-10-12 16:38:47.009037 | hotstack | Output suppressed because no_log was given 2025-10-12 16:38:47.020777 | 2025-10-12 16:38:47.020901 | TASK [Fetch cloud secrets from remote to zuul executor] 2025-10-12 16:38:47.363625 | hotstack | Output suppressed because no_log was given 2025-10-12 16:38:47.373720 | 2025-10-12 16:38:47.373847 | TASK [Load hotstack cloud secret vars with template resolution] 2025-10-12 16:38:47.420611 | hotstack | Output suppressed because no_log was given 2025-10-12 16:38:47.431243 | 2025-10-12 16:38:47.431363 | TASK [Add Hotstack controller-0 to ansible inventory] 2025-10-12 16:38:47.478584 | hotstack | Output suppressed because no_log was given 2025-10-12 16:38:47.491554 | 2025-10-12 16:38:47.491704 | TASK [Wait for Hotstack controller-0 to be ready] 2025-10-12 16:45:07.114384 | hotstack -> 38.102.83.80 | Output suppressed because no_log was given failure 2025-10-12 16:45:07.116921 | 2025-10-12 16:45:07.117022 | PLAY RECAP 2025-10-12 16:45:07.117102 | hotstack | ok: 21 changed: 11 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2025-10-12 16:45:07.117145 | 2025-10-12 16:45:07.234920 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-10-12 16:45:07.240829 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-10-12 16:45:07.815534 | 2025-10-12 16:45:07.815670 | PLAY [Collect hotstack logs and clean up environment] 2025-10-12 16:45:07.838478 | 2025-10-12 16:45:07.838578 | TASK [Fetch stack outputs from remote to zuul executor] 2025-10-12 16:45:08.507612 | hotstack | Output suppressed because no_log was given 2025-10-12 16:45:08.519984 | 2025-10-12 16:45:08.520147 | TASK [Load stack output vars with template resolution] 2025-10-12 16:45:08.569469 | hotstack | Output suppressed because no_log was given 2025-10-12 16:45:08.580851 | 2025-10-12 16:45:08.580997 | TASK [Add Hotstack controller-0 to ansible inventory] 2025-10-12 16:45:08.629030 | hotstack | Output suppressed because no_log was given 2025-10-12 16:45:08.640990 | 2025-10-12 16:45:08.641137 | TASK [Wait for Hotstack controller-0 to be ready] 2025-10-12 16:51:28.249118 | hotstack -> 38.102.83.80 | Output suppressed because no_log was given 2025-10-12 16:51:28.260836 | 2025-10-12 16:51:28.260961 | TASK [Print message that log collection failed] 2025-10-12 16:51:28.297195 | hotstack | ok: WARNING: Log collection failed and may be incomplete. Continue with cleanup ... 2025-10-12 16:51:28.308213 | 2025-10-12 16:51:28.308344 | TASK [Set _auth_type fact] 2025-10-12 16:51:28.364813 | hotstack | Output suppressed because no_log was given 2025-10-12 16:51:28.374098 | 2025-10-12 16:51:28.374180 | TASK [Write clouds.yaml] 2025-10-12 16:51:29.663089 | hotstack | Output suppressed because no_log was given 2025-10-12 16:51:29.674281 | 2025-10-12 16:51:29.674440 | TASK [Delete application credentials] 2025-10-12 16:51:31.726564 | hotstack | changed 2025-10-12 16:51:31.737450 | 2025-10-12 16:51:31.737574 | TASK [Print message that application credential failed to delete] 2025-10-12 16:51:31.764364 | hotstack | skipping: Conditional result was False 2025-10-12 16:51:31.776168 | 2025-10-12 16:51:31.776294 | TASK [Print message that application credential deleted successfully] 2025-10-12 16:51:31.822737 | hotstack | ok: Application credential deleted successfully. 2025-10-12 16:51:31.833912 | 2025-10-12 16:51:31.834036 | TASK [Write clouds.yaml with application credentials] 2025-10-12 16:51:31.870931 | 2025-10-12 16:51:31.871172 | TASK [Delete the heat stack] 2025-10-12 12:51:54.224598 | hotstack | 2025-10-12 16:51:34Z [hs-e966dfec0ed64013a9fb918d42588279]: DELETE_IN_PROGRESS Stack DELETE started 2025-10-12 12:51:54.224735 | hotstack | 2025-10-12 16:51:34Z [hs-e966dfec0ed64013a9fb918d42588279.master1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224755 | hotstack | 2025-10-12 16:51:35Z [hs-e966dfec0ed64013a9fb918d42588279.compute1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224768 | hotstack | 2025-10-12 16:51:36Z [hs-e966dfec0ed64013a9fb918d42588279.networker2]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224782 | hotstack | 2025-10-12 16:51:37Z [hs-e966dfec0ed64013a9fb918d42588279.networker1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224795 | hotstack | 2025-10-12 16:51:38Z [hs-e966dfec0ed64013a9fb918d42588279.controller-floating-ip]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224809 | hotstack | 2025-10-12 16:51:39Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224822 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.controller]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224835 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.networker2]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.224848 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224861 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.224874 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.controller-floating-ip]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.224887 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1_init]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224900 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224913 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.machine-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224926 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1_init]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.224939 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1_hostname]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224952 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.compute1_hostname]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.224965 | hotstack | 2025-10-12 16:51:41Z [hs-e966dfec0ed64013a9fb918d42588279.networker0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224978 | hotstack | 2025-10-12 16:51:42Z [hs-e966dfec0ed64013a9fb918d42588279.master2]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.224991 | hotstack | 2025-10-12 16:51:42Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225004 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225018 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225031 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225044 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225057 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-storage-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225070 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225083 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225203 | hotstack | 2025-10-12 16:51:43Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225233 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225272 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225289 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-net-router-interface]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225307 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-init]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225320 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-init]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225333 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:51:54.225346 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller_users]: DELETE_IN_PROGRESS state changed 2025-10-12 12:51:54.225411 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller_users]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.521895 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-runcmd]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522013 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-write-files]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522053 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-runcmd]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522075 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.controller-write-files]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522165 | hotstack | 2025-10-12 16:51:44Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522216 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.compute0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522232 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522246 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.networker2-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522259 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-storage-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522273 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522286 | hotstack | 2025-10-12 16:51:45Z [hs-e966dfec0ed64013a9fb918d42588279.machine-net-router-interface]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522299 | hotstack | 2025-10-12 16:51:46Z [hs-e966dfec0ed64013a9fb918d42588279.master0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522317 | hotstack | 2025-10-12 16:51:47Z [hs-e966dfec0ed64013a9fb918d42588279.compute1-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522330 | hotstack | 2025-10-12 16:51:48Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-net-router-interface]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522343 | hotstack | 2025-10-12 16:51:48Z [hs-e966dfec0ed64013a9fb918d42588279.router]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522357 | hotstack | 2025-10-12 16:51:49Z [hs-e966dfec0ed64013a9fb918d42588279.networker1]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522370 | hotstack | 2025-10-12 16:51:49Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522401 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker0]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522416 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522429 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker_init]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522442 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522455 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker_init]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522484 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522498 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.router]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522511 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522525 | hotstack | 2025-10-12 16:51:50Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522538 | hotstack | 2025-10-12 16:51:51Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522558 | hotstack | 2025-10-12 16:51:51Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522572 | hotstack | 2025-10-12 16:51:51Z [hs-e966dfec0ed64013a9fb918d42588279.networker1-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522585 | hotstack | 2025-10-12 16:51:52Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522600 | hotstack | 2025-10-12 16:51:52Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522618 | hotstack | 2025-10-12 16:51:52Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522636 | hotstack | 2025-10-12 16:51:52Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522653 | hotstack | 2025-10-12 16:51:52Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522670 | hotstack | 2025-10-12 16:51:53Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522686 | hotstack | 2025-10-12 16:51:53Z [hs-e966dfec0ed64013a9fb918d42588279.networker0-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522703 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522719 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0_init]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522736 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0_init]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522753 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522769 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0_hostname]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522784 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.dataplane_users]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522800 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.compute0_hostname]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522816 | hotstack | 2025-10-12 16:51:54Z [hs-e966dfec0ed64013a9fb918d42588279.dataplane_users]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522831 | hotstack | 2025-10-12 16:51:55Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522846 | hotstack | 2025-10-12 16:51:55Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522866 | hotstack | 2025-10-12 16:51:55Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-storage-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522882 | hotstack | 2025-10-12 16:51:55Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522898 | hotstack | 2025-10-12 16:51:55Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:09.522915 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-storage-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522941 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522955 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:09.522980 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.compute0-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657326 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.master1]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657425 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.master1-lvms-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657443 | hotstack | 2025-10-12 16:51:56Z [hs-e966dfec0ed64013a9fb918d42588279.master1-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657456 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657469 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657483 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-ironic-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657496 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol2]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657509 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-machine-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657523 | hotstack | 2025-10-12 16:51:57Z [hs-e966dfec0ed64013a9fb918d42588279.master1-lvms-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657536 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-ironic-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657548 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657561 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol1]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657574 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657587 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657600 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657613 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-cinder-vol2]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657625 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-octavia-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657638 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657651 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-storage-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657664 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-machine-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657677 | hotstack | 2025-10-12 16:51:58Z [hs-e966dfec0ed64013a9fb918d42588279.master1-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657690 | hotstack | 2025-10-12 16:51:59Z [hs-e966dfec0ed64013a9fb918d42588279.master1-storage-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657703 | hotstack | 2025-10-12 16:51:59Z [hs-e966dfec0ed64013a9fb918d42588279.master1-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657716 | hotstack | 2025-10-12 16:51:59Z [hs-e966dfec0ed64013a9fb918d42588279.master1-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657729 | hotstack | 2025-10-12 16:51:59Z [hs-e966dfec0ed64013a9fb918d42588279.master1-octavia-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657742 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657778 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657804 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-lvms-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657817 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-machine-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657830 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol2]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657843 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657856 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-ironic-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657890 | hotstack | 2025-10-12 16:52:04Z [hs-e966dfec0ed64013a9fb918d42588279.master2-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.657904 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-machine-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657917 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-ironic-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657930 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657943 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-lvms-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657956 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol2]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657969 | hotstack | 2025-10-12 16:52:05Z [hs-e966dfec0ed64013a9fb918d42588279.master2-cinder-vol1]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657982 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.657994 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658007 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-octavia-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658020 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658033 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658046 | hotstack | 2025-10-12 16:52:06Z [hs-e966dfec0ed64013a9fb918d42588279.master2-storage-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658059 | hotstack | 2025-10-12 16:52:07Z [hs-e966dfec0ed64013a9fb918d42588279.master2-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658072 | hotstack | 2025-10-12 16:52:07Z [hs-e966dfec0ed64013a9fb918d42588279.master2-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658085 | hotstack | 2025-10-12 16:52:07Z [hs-e966dfec0ed64013a9fb918d42588279.master2-octavia-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658202 | hotstack | 2025-10-12 16:52:07Z [hs-e966dfec0ed64013a9fb918d42588279.master2-storage-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658216 | hotstack | 2025-10-12 16:52:07Z [hs-e966dfec0ed64013a9fb918d42588279.master2-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658230 | hotstack | 2025-10-12 16:52:08Z [hs-e966dfec0ed64013a9fb918d42588279.master0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658243 | hotstack | 2025-10-12 16:52:08Z [hs-e966dfec0ed64013a9fb918d42588279.master0-trunk0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658255 | hotstack | 2025-10-12 16:52:08Z [hs-e966dfec0ed64013a9fb918d42588279.master0-machine-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658268 | hotstack | 2025-10-12 16:52:08Z [hs-e966dfec0ed64013a9fb918d42588279.master0-ironic-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658281 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.master0-lvms-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658304 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol2]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658317 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol0]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658330 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol1]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658343 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.master0-machine-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658356 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.extra-dhcp-opts-value]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658369 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.extra-dhcp-opts-value]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658382 | hotstack | 2025-10-12 16:52:09Z [hs-e966dfec0ed64013a9fb918d42588279.controller-machine-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658395 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-lvms-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658407 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol2]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658420 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658434 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-cinder-vol1]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658449 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.controller-machine-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658464 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.machine-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658518 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-ironic-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658534 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658550 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-trunk0]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658565 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658587 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-storage-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658602 | hotstack | 2025-10-12 16:52:10Z [hs-e966dfec0ed64013a9fb918d42588279.master0-tenant-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658617 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.master0-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658632 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658647 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.master0-octavia-port]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658662 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658677 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.machine-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658692 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.machine-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658707 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.master0-tenant-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658720 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.master0-storage-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658733 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.master0-octavia-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658746 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.storage-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658766 | hotstack | 2025-10-12 16:52:11Z [hs-e966dfec0ed64013a9fb918d42588279.tenant-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658779 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.octavia-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658792 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.master0-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658804 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658817 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.master0-internal-api-port]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658830 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.storage-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658843 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.internal-api-subnet]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658861 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.tenant-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658874 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.storage-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658887 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.tenant-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658899 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658912 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658925 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.machine-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658938 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.octavia-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658950 | hotstack | 2025-10-12 16:52:12Z [hs-e966dfec0ed64013a9fb918d42588279.octavia-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.658963 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.internal-api-subnet]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658976 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.ironic-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.658989 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.internal-api-net]: DELETE_IN_PROGRESS state changed 2025-10-12 12:52:14.659002 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.storage-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.659014 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.ctlplane-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.659061 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.tenant-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.659087 | hotstack | 2025-10-12 16:52:13Z [hs-e966dfec0ed64013a9fb918d42588279.octavia-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.738792 | hotstack | 2025-10-12 16:52:14Z [hs-e966dfec0ed64013a9fb918d42588279.internal-api-net]: DELETE_COMPLETE state changed 2025-10-12 12:52:14.739045 | hotstack | 2025-10-12 16:52:14Z [hs-e966dfec0ed64013a9fb918d42588279]: DELETE_COMPLETE Stack DELETE completed successfully 2025-10-12 16:52:14.999299 | hotstack | changed 2025-10-12 16:52:15.013042 | 2025-10-12 16:52:15.013178 | TASK [Print message that stack failed to delete] 2025-10-12 16:52:15.039929 | hotstack | skipping: Conditional result was False 2025-10-12 16:52:15.051802 | 2025-10-12 16:52:15.051975 | TASK [Print message that stack deleted successfully] 2025-10-12 16:52:15.098773 | hotstack | ok: Stack deleted successfully. 2025-10-12 16:52:15.108930 | 2025-10-12 16:52:15.109050 | TASK [Delete clouds.yaml] 2025-10-12 16:52:15.564412 | hotstack | Output suppressed because no_log was given 2025-10-12 16:52:15.608241 | 2025-10-12 16:52:15.608352 | PLAY RECAP 2025-10-12 16:52:15.608406 | hotstack | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 1 ignored: 0 2025-10-12 16:52:15.608434 | 2025-10-12 16:52:15.720961 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-10-12 16:52:15.723785 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-12 16:52:16.295406 | 2025-10-12 16:52:16.295511 | PLAY [all] 2025-10-12 16:52:16.313890 | 2025-10-12 16:52:16.313963 | TASK [include_role : fetch-output] 2025-10-12 16:52:16.353063 | hotstack | ok 2025-10-12 16:52:16.370971 | 2025-10-12 16:52:16.371055 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-12 16:52:16.435713 | hotstack | skipping: Conditional result was False 2025-10-12 16:52:16.442336 | 2025-10-12 16:52:16.442403 | TASK [fetch-output : Set log path for single node] 2025-10-12 16:52:16.487226 | hotstack | ok 2025-10-12 16:52:16.498173 | 2025-10-12 16:52:16.498310 | LOOP [fetch-output : Ensure local output dirs] 2025-10-12 16:52:16.923774 | hotstack -> localhost | ok: "/var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/logs" 2025-10-12 16:52:17.183246 | hotstack -> localhost | changed: "/var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/artifacts" 2025-10-12 16:52:17.451267 | hotstack -> localhost | changed: "/var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/docs" 2025-10-12 16:52:17.471409 | 2025-10-12 16:52:17.471578 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-12 16:52:18.193229 | hotstack | changed: .d..t...... ./ 2025-10-12 16:52:18.193601 | hotstack | changed: All items complete 2025-10-12 16:52:18.193670 | 2025-10-12 16:52:18.759031 | hotstack | changed: .d..t...... ./ 2025-10-12 16:52:19.314601 | hotstack | changed: .d..t...... ./ 2025-10-12 16:52:19.349129 | 2025-10-12 16:52:19.349313 | TASK [include_role : fetch-output-openshift] 2025-10-12 16:52:19.376739 | hotstack | skipping: Conditional result was False 2025-10-12 16:52:19.388921 | 2025-10-12 16:52:19.389060 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-12 16:52:19.850326 | hotstack -> localhost | ok: Item: artifacts Runtime: 0:00:00.012970 2025-10-12 16:52:20.129960 | hotstack -> localhost | ok: Item: docs Runtime: 0:00:00.012826 2025-10-12 16:52:20.165267 | 2025-10-12 16:52:20.165382 | PLAY [all] 2025-10-12 16:52:20.179477 | 2025-10-12 16:52:20.179541 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-12 16:52:20.855416 | hotstack | changed 2025-10-12 16:52:20.901626 | 2025-10-12 16:52:20.901718 | PLAY RECAP 2025-10-12 16:52:20.901775 | hotstack | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-12 16:52:20.901813 | 2025-10-12 16:52:20.998321 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-12 16:52:21.001014 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-12 16:52:21.624262 | 2025-10-12 16:52:21.624379 | PLAY [localhost] 2025-10-12 16:52:21.642361 | 2025-10-12 16:52:21.642440 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-12 16:52:22.064270 | localhost | changed 2025-10-12 16:52:22.074031 | 2025-10-12 16:52:22.074188 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-12 16:52:22.110836 | localhost | ok 2025-10-12 16:52:22.130904 | 2025-10-12 16:52:22.131041 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-12 16:52:22.544520 | localhost | changed 2025-10-12 16:52:22.557138 | 2025-10-12 16:52:22.557284 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-12 16:52:23.351604 | localhost | changed 2025-10-12 16:52:23.357127 | 2025-10-12 16:52:23.357187 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-12 16:52:23.767445 | localhost | Identity added: /var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/tmp/ansible.19mutjy7 (/var/lib/zuul/builds/e966dfec0ed64013a9fb918d42588279/work/tmp/ansible.19mutjy7) 2025-10-12 16:52:23.767805 | localhost | ok: Runtime: 0:00:00.012136 2025-10-12 16:52:23.777072 | 2025-10-12 16:52:23.777203 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-12 16:52:24.072773 | localhost | ok: Runtime: 0:00:00.004695 2025-10-12 16:52:24.079108 | 2025-10-12 16:52:24.079195 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-12 16:52:24.139793 | localhost | changed 2025-10-12 16:52:24.146384 | 2025-10-12 16:52:24.146478 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-12 16:52:24.541691 | localhost | changed 2025-10-12 16:52:24.564074 | 2025-10-12 16:52:24.564144 | PLAY [localhost] 2025-10-12 16:52:24.580234 | 2025-10-12 16:52:24.580313 | TASK [Generate bulk log download script] 2025-10-12 16:52:24.625126 | localhost | ok 2025-10-12 16:52:24.636143 | 2025-10-12 16:52:24.636206 | TASK [local-log-download : Check API endpoint is defined] 2025-10-12 16:52:24.675264 | localhost | ok: All assertions passed 2025-10-12 16:52:24.679890 | 2025-10-12 16:52:24.679955 | TASK [local-log-download : Create download script] 2025-10-12 16:52:25.101220 | localhost -> localhost | changed 2025-10-12 16:52:25.119988 | 2025-10-12 16:52:25.120125 | TASK [Register quick-download link] 2025-10-12 16:52:25.154142 | localhost | ok 2025-10-12 16:52:25.185816 | 2025-10-12 16:52:25.185945 | PLAY [logserver.rdoproject.org] 2025-10-12 16:52:25.199225 | 2025-10-12 16:52:25.199308 | TASK [Set zuul-log-path fact] 2025-10-12 16:52:25.217439 | logserver.rdoproject.org | ok 2025-10-12 16:52:25.229397 | 2025-10-12 16:52:25.229480 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 16:52:25.266875 | logserver.rdoproject.org | ok 2025-10-12 16:52:25.273865 | 2025-10-12 16:52:25.273948 | TASK [upload-logs : Create log directories] 2025-10-12 16:52:26.212728 | logserver.rdoproject.org | changed 2025-10-12 16:52:26.219249 | 2025-10-12 16:52:26.219381 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-12 16:52:26.479523 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.008293 2025-10-12 16:52:26.484134 | 2025-10-12 16:52:26.484194 | TASK [upload-logs : Upload logs to log server] 2025-10-12 16:52:27.199663 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-12 16:52:27.202548 | 2025-10-12 16:52:27.202610 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 16:52:27.268227 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-12 16:52:27.279793 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-12 16:52:27.292369 | 2025-10-12 16:52:27.292476 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 16:52:27.338751 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-12 16:52:27.339408 | 2025-10-12 16:52:27.341746 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-12 16:52:27.350423 | 2025-10-12 16:52:27.350507 | LOOP [upload-logs : Upload console log and json output]