2025-12-05 08:59:32.934391 | Job console starting... 2025-12-05 08:59:32.947118 | Updating repositories 2025-12-05 08:59:32.974749 | Preparing job workspace 2025-12-05 08:59:38.604587 | Running Ansible setup... 2025-12-05 08:59:42.209761 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-05 08:59:42.804884 | 2025-12-05 08:59:42.805003 | PLAY [localhost] 2025-12-05 08:59:42.813782 | 2025-12-05 08:59:42.813853 | TASK [Gathering Facts] 2025-12-05 08:59:43.840402 | localhost | ok 2025-12-05 08:59:43.859150 | 2025-12-05 08:59:43.859267 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-05 08:59:44.304394 | localhost -> localhost | changed 2025-12-05 08:59:44.312897 | 2025-12-05 08:59:44.313045 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-05 08:59:45.204478 | localhost -> localhost | changed 2025-12-05 08:59:45.213208 | 2025-12-05 08:59:45.213292 | TASK [Setup log path fact] 2025-12-05 08:59:45.232758 | localhost | ok 2025-12-05 08:59:45.244576 | 2025-12-05 08:59:45.244673 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 08:59:45.274395 | localhost | ok 2025-12-05 08:59:45.282256 | 2025-12-05 08:59:45.282328 | TASK [emit-job-header : Print job information] 2025-12-05 08:59:45.324748 | # Job Information 2025-12-05 08:59:45.324970 | Ansible Version: 2.15.12 2025-12-05 08:59:45.325007 | Job: vexxhost-hotstack-sno-2-bm 2025-12-05 08:59:45.325072 | Pipeline: github-experimental-trigger 2025-12-05 08:59:45.325099 | Executor: ze01.softwarefactory-project.io 2025-12-05 08:59:45.325123 | Triggered by: https://github.com/openstack-k8s-operators/hotstack/pull/235 2025-12-05 08:59:45.325148 | Log URL (when completed): https://logserver.rdoproject.org/b92/rdoproject.org/b92c3aeb1ec84aff87e4cd07715a922e/ 2025-12-05 08:59:45.325173 | Event ID: 9e66cbd0-d1b8-11f0-80b4-47c154ea6647 2025-12-05 08:59:45.330498 | 2025-12-05 08:59:45.330586 | LOOP [emit-job-header : Print node information] 2025-12-05 08:59:45.435497 | localhost | ok: 2025-12-05 08:59:45.435802 | localhost | # Node Information 2025-12-05 08:59:45.435835 | localhost | Inventory Hostname: hotstack 2025-12-05 08:59:45.435864 | localhost | Hostname: np0005546602 2025-12-05 08:59:45.435891 | localhost | Username: zuul 2025-12-05 08:59:45.435913 | localhost | Distro: CentOS 9 2025-12-05 08:59:45.435930 | localhost | Provider: vexxhost-nodepool-tripleo 2025-12-05 08:59:45.435951 | localhost | Region: RegionOne 2025-12-05 08:59:45.435976 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2025-12-05 08:59:45.435997 | localhost | Product Name: OpenStack Nova 2025-12-05 08:59:45.436032 | localhost | Interface IP: 38.129.56.230 2025-12-05 08:59:45.479208 | 2025-12-05 08:59:45.479381 | PLAY [all] 2025-12-05 08:59:45.493075 | 2025-12-05 08:59:45.493211 | TASK [Gather network facts] 2025-12-05 08:59:46.043348 | hotstack | ok 2025-12-05 08:59:46.075819 | 2025-12-05 08:59:46.075967 | TASK [include_role : start-zuul-console] 2025-12-05 08:59:46.099762 | hotstack | ok 2025-12-05 08:59:46.115585 | 2025-12-05 08:59:46.115693 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-05 08:59:46.530856 | hotstack | ok 2025-12-05 08:59:46.551185 | 2025-12-05 08:59:46.551319 | TASK [include_role : add-build-sshkey] 2025-12-05 08:59:46.589585 | hotstack | ok 2025-12-05 08:59:46.615947 | 2025-12-05 08:59:46.616078 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-05 08:59:46.949491 | hotstack -> localhost | ok 2025-12-05 08:59:46.963821 | 2025-12-05 08:59:46.963984 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-05 08:59:47.005928 | hotstack | ok 2025-12-05 08:59:47.031170 | hotstack | included: /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-05 08:59:47.039325 | 2025-12-05 08:59:47.039411 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-05 08:59:47.700825 | hotstack -> localhost | Generating public/private rsa key pair. 2025-12-05 08:59:47.701276 | hotstack -> localhost | Your identification has been saved in /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/b92c3aeb1ec84aff87e4cd07715a922e_id_rsa. 2025-12-05 08:59:47.701348 | hotstack -> localhost | Your public key has been saved in /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/b92c3aeb1ec84aff87e4cd07715a922e_id_rsa.pub. 2025-12-05 08:59:47.701398 | hotstack -> localhost | The key fingerprint is: 2025-12-05 08:59:47.701442 | hotstack -> localhost | SHA256:4QOa1pfGyQnNg1r1OBLyd6zC64VQA1gt1Hqd8fZVQNg zuul-build-sshkey 2025-12-05 08:59:47.701485 | hotstack -> localhost | The key's randomart image is: 2025-12-05 08:59:47.701526 | hotstack -> localhost | +---[RSA 3072]----+ 2025-12-05 08:59:47.701567 | hotstack -> localhost | | +=o. . +o. | 2025-12-05 08:59:47.701609 | hotstack -> localhost | | . .+o*.+ . E .| 2025-12-05 08:59:47.701650 | hotstack -> localhost | | oX.O++ . | 2025-12-05 08:59:47.701691 | hotstack -> localhost | | .O.XoXo . | 2025-12-05 08:59:47.701731 | hotstack -> localhost | | *.+ S. . . | 2025-12-05 08:59:47.701770 | hotstack -> localhost | | . . * . . | 2025-12-05 08:59:47.701808 | hotstack -> localhost | | o . | 2025-12-05 08:59:47.701846 | hotstack -> localhost | | . . | 2025-12-05 08:59:47.701885 | hotstack -> localhost | | . | 2025-12-05 08:59:47.701922 | hotstack -> localhost | +----[SHA256]-----+ 2025-12-05 08:59:47.702009 | hotstack -> localhost | ok: Runtime: 0:00:00.192501 2025-12-05 08:59:47.716068 | 2025-12-05 08:59:47.716259 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-05 08:59:47.758540 | hotstack | ok 2025-12-05 08:59:47.780681 | hotstack | included: /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-05 08:59:47.793759 | 2025-12-05 08:59:47.793902 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-05 08:59:47.820503 | hotstack | skipping: Conditional result was False 2025-12-05 08:59:47.830472 | 2025-12-05 08:59:47.830587 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-05 08:59:48.280927 | hotstack | changed 2025-12-05 08:59:48.288246 | 2025-12-05 08:59:48.288368 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-05 08:59:48.558464 | hotstack | ok 2025-12-05 08:59:48.566326 | 2025-12-05 08:59:48.566419 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-05 08:59:49.565754 | hotstack | changed 2025-12-05 08:59:49.578103 | 2025-12-05 08:59:49.578260 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-05 08:59:50.539952 | hotstack | changed 2025-12-05 08:59:50.552465 | 2025-12-05 08:59:50.552602 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-05 08:59:50.582155 | hotstack | skipping: Conditional result was False 2025-12-05 08:59:50.596727 | 2025-12-05 08:59:50.596883 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-05 08:59:51.036888 | hotstack -> localhost | changed 2025-12-05 08:59:51.061990 | 2025-12-05 08:59:51.062232 | TASK [add-build-sshkey : Add back temp key] 2025-12-05 08:59:51.396856 | hotstack -> localhost | Identity added: /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/b92c3aeb1ec84aff87e4cd07715a922e_id_rsa (zuul-build-sshkey) 2025-12-05 08:59:51.397130 | hotstack -> localhost | ok: Runtime: 0:00:00.009693 2025-12-05 08:59:51.403555 | 2025-12-05 08:59:51.403652 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-05 08:59:51.810522 | hotstack | ok 2025-12-05 08:59:51.859604 | 2025-12-05 08:59:51.859758 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-05 08:59:51.895572 | hotstack | skipping: Conditional result was False 2025-12-05 08:59:51.909247 | 2025-12-05 08:59:51.909356 | TASK [include_role : validate-host] 2025-12-05 08:59:51.940817 | hotstack | ok 2025-12-05 08:59:51.967534 | 2025-12-05 08:59:51.967642 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-05 08:59:52.009801 | hotstack | ok 2025-12-05 08:59:52.016375 | 2025-12-05 08:59:52.016457 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-05 08:59:52.285152 | hotstack -> localhost | ok 2025-12-05 08:59:52.293663 | 2025-12-05 08:59:52.293755 | TASK [validate-host : Collect information about the host] 2025-12-05 08:59:53.113807 | hotstack | ok 2025-12-05 08:59:53.134150 | 2025-12-05 08:59:53.134311 | TASK [validate-host : Sanitize hostname] 2025-12-05 08:59:53.224516 | hotstack | ok 2025-12-05 08:59:53.237304 | 2025-12-05 08:59:53.237468 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-05 08:59:53.817844 | hotstack -> localhost | changed 2025-12-05 08:59:53.826275 | 2025-12-05 08:59:53.826401 | TASK [validate-host : Collect information about zuul worker] 2025-12-05 08:59:54.292723 | hotstack | ok 2025-12-05 08:59:54.303953 | 2025-12-05 08:59:54.304136 | TASK [validate-host : Write out all zuul information for each host] 2025-12-05 08:59:54.863769 | hotstack -> localhost | changed 2025-12-05 08:59:54.882208 | 2025-12-05 08:59:54.882300 | TASK [include_role : prepare-workspace-openshift] 2025-12-05 08:59:54.897791 | hotstack | skipping: Conditional result was False 2025-12-05 08:59:54.905646 | 2025-12-05 08:59:54.905727 | TASK [include_role : remove-zuul-sshkey] 2025-12-05 08:59:54.931263 | hotstack | skipping: Conditional result was False 2025-12-05 08:59:54.938674 | 2025-12-05 08:59:54.938760 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-05 08:59:55.236321 | hotstack | ok: "logs" 2025-12-05 08:59:55.236664 | hotstack | ok: All items complete 2025-12-05 08:59:55.236701 | 2025-12-05 08:59:55.507564 | hotstack | ok: "artifacts" 2025-12-05 08:59:55.749661 | hotstack | ok: "docs" 2025-12-05 08:59:55.758528 | 2025-12-05 08:59:55.758642 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-05 08:59:56.023431 | hotstack | changed: "logs" 2025-12-05 08:59:56.272425 | hotstack | changed: "artifacts" 2025-12-05 08:59:56.534520 | hotstack | changed: "docs" 2025-12-05 08:59:56.568587 | 2025-12-05 08:59:56.568722 | PLAY RECAP 2025-12-05 08:59:56.568783 | hotstack | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-05 08:59:56.568820 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-05 08:59:56.568847 | 2025-12-05 08:59:56.684303 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-05 08:59:56.689985 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-12-05 08:59:57.329726 | 2025-12-05 08:59:57.329836 | PLAY [Create necessary files to deploy hotstack scenario] 2025-12-05 08:59:57.351968 | 2025-12-05 08:59:57.352086 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-05 08:59:57.818689 | hotstack | ok 2025-12-05 08:59:57.825732 | 2025-12-05 08:59:57.825860 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-05 09:00:00.364971 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:00.379992 | 2025-12-05 09:00:00.380217 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-12-05 09:00:00.841405 | hotstack | changed: 2025-12-05 09:00:00.841644 | hotstack | { 2025-12-05 09:00:00.841692 | 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-05 09:00:00.841725 | hotstack | } 2025-12-05 09:00:00.867658 | 2025-12-05 09:00:00.867768 | TASK [Assert cloud name and cloud secret] 2025-12-05 09:00:00.933744 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:00.941521 | 2025-12-05 09:00:00.941629 | TASK [Ensure openstack release repo is installed] 2025-12-05 09:00:04.430461 | hotstack | changed 2025-12-05 09:00:04.443103 | 2025-12-05 09:00:04.443254 | TASK [Install openstack client packages] 2025-12-05 09:00:19.955431 | hotstack | changed 2025-12-05 09:00:19.967122 | 2025-12-05 09:00:19.967249 | TASK [Ensure HotStack work dir] 2025-12-05 09:00:20.321654 | hotstack | changed 2025-12-05 09:00:20.328849 | 2025-12-05 09:00:20.328932 | LOOP [Ensure etc directories] 2025-12-05 09:00:20.627723 | hotstack | changed: "/etc/openstack" 2025-12-05 09:00:20.628167 | hotstack | changed: All items complete 2025-12-05 09:00:20.628227 | 2025-12-05 09:00:20.864195 | hotstack | changed: "/etc/hotstack" 2025-12-05 09:00:20.884183 | 2025-12-05 09:00:20.884384 | TASK [Ensure .ssh dir exists] 2025-12-05 09:00:21.965283 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:21.978383 | 2025-12-05 09:00:21.978520 | TASK [Ensure ssh keypair exists] 2025-12-05 09:00:32.551579 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:32.559433 | 2025-12-05 09:00:32.559541 | TASK [Generate CA cert file] 2025-12-05 09:00:32.605753 | hotstack | skipping: Conditional result was False 2025-12-05 09:00:32.614246 | 2025-12-05 09:00:32.614331 | TASK [Update CA certs] 2025-12-05 09:00:33.155333 | hotstack | skipping: Conditional result was False 2025-12-05 09:00:33.168671 | 2025-12-05 09:00:33.168825 | TASK [Set _auth_type fact] 2025-12-05 09:00:33.238915 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:33.249609 | 2025-12-05 09:00:33.249749 | TASK [Write clouds.yaml - user/password] 2025-12-05 09:00:34.335305 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:34.342504 | 2025-12-05 09:00:34.342678 | TASK [Create application credential for sushy-emulator] 2025-12-05 09:00:36.388441 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:36.401380 | 2025-12-05 09:00:36.401539 | TASK [Read application credential from file] 2025-12-05 09:00:36.800422 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:36.814874 | 2025-12-05 09:00:36.815132 | TASK [Delete temporary application credential file] 2025-12-05 09:00:37.070372 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:37.080788 | 2025-12-05 09:00:37.080912 | TASK [Assert application credential id and secret] 2025-12-05 09:00:37.169289 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:37.181169 | 2025-12-05 09:00:37.181296 | TASK [Write new clouds.yaml with application credentials] 2025-12-05 09:00:37.984471 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:37.994974 | 2025-12-05 09:00:37.995131 | TASK [Write hotstack cloud-secret.yaml] 2025-12-05 09:00:38.783145 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:38.788969 | 2025-12-05 09:00:38.789046 | TASK [Write clouds.yaml with application credentials] 2025-12-05 09:00:38.883969 | 2025-12-05 09:00:38.884153 | TASK [Write hotstack cloud-secret.yaml] 2025-12-05 09:00:38.937075 | 2025-12-05 09:00:38.937228 | PLAY RECAP 2025-12-05 09:00:38.937289 | hotstack | ok: 18 changed: 11 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-05 09:00:38.937316 | 2025-12-05 09:00:39.049729 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-12-05 09:00:39.056199 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-12-05 09:00:39.665202 | 2025-12-05 09:00:39.665402 | PLAY [Create hotstack scenario] 2025-12-05 09:00:39.687919 | 2025-12-05 09:00:39.688082 | TASK [Assert scenario is defined] 2025-12-05 09:00:39.769144 | hotstack | ok: All assertions passed 2025-12-05 09:00:39.774329 | 2025-12-05 09:00:39.774400 | TASK [Fetch bootstrap vars from remote to zuul executor] 2025-12-05 09:00:40.259855 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:40.271458 | 2025-12-05 09:00:40.271603 | TASK [Load bootstrap vars with template resolution] 2025-12-05 09:00:40.317462 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:40.324696 | 2025-12-05 09:00:40.324781 | TASK [Fetch automation vars from remote to zuul executor] 2025-12-05 09:00:40.656357 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:40.671817 | 2025-12-05 09:00:40.671952 | TASK [Load automation vars with template resolution] 2025-12-05 09:00:40.762351 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:40.775303 | 2025-12-05 09:00:40.775435 | TASK [Slurp zuul-build-sshkey from file] 2025-12-05 09:00:41.161292 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:41.173969 | 2025-12-05 09:00:41.174137 | TASK [Set up infrastructure (Heat stack)] 2025-12-05 09:00:41.204864 | hotstack | Output suppressed because no_log was given 2025-12-05 09:00:41.259917 | 2025-12-05 09:00:41.260120 | TASK [dataplane_ssh_keys : Ensure Dataplane ssh keypair exists] 2025-12-05 09:00:41.951118 | hotstack | changed 2025-12-05 09:00:41.963211 | 2025-12-05 09:00:41.963341 | TASK [dataplane_ssh_keys : Ensure Nova migration ssh keypair exists] 2025-12-05 09:00:42.359907 | hotstack | changed 2025-12-05 09:00:42.372550 | 2025-12-05 09:00:42.372691 | TASK [dataplane_ssh_keys : Set SSH public key facts] 2025-12-05 09:00:42.423523 | hotstack | ok 2025-12-05 09:00:42.437198 | 2025-12-05 09:00:42.437346 | TASK [dataplane_ssh_keys : Store SSH public key facts in file] 2025-12-05 09:00:43.310506 | hotstack | changed 2025-12-05 09:00:43.335459 | 2025-12-05 09:00:43.335641 | TASK [heat_stack : Assert config is defined] 2025-12-05 09:00:43.430063 | hotstack | ok: All assertions passed 2025-12-05 09:00:43.441848 | 2025-12-05 09:00:43.442000 | TASK [heat_stack : Get latest snapset and update stack parameters] 2025-12-05 09:00:43.490890 | hotstack | skipping: Conditional result was False 2025-12-05 09:00:43.506118 | 2025-12-05 09:00:43.506271 | TASK [heat_stack : Debug latest snapset information] 2025-12-05 09:00:43.554488 | hotstack | skipping: Conditional result was False 2025-12-05 09:00:43.568427 | 2025-12-05 09:00:43.568591 | TASK [heat_stack : Create stack] 2025-12-05 09:02:56.614083 | hotstack | changed 2025-12-05 09:02:56.631909 | 2025-12-05 09:02:56.632081 | TASK [heat_stack : Wait for stack to complete] 2025-12-05 09:02:58.433933 | hotstack | ok 2025-12-05 09:02:58.443788 | 2025-12-05 09:02:58.443912 | TASK [heat_stack : Debug - stack_info] 2025-12-05 09:02:58.488400 | hotstack | ok: {'changed': False, 'stacks': [{'added': None, 'capabilities': None, 'created_at': '2025-12-05T09:00:48Z', 'description': '', 'deleted': None, 'deleted_at': None, 'environment': None, 'environment_files': None, 'files': None, 'files_container': None, 'is_rollback_disabled': None, 'links': [{'href': 'https://orchestration.rdo.mtl2.vexxhost.net/v1/4b633c451ac74233be3721a3635275e5/stacks/hs-b92c3aeb1ec84aff87e4cd07715a922e/c667b398-3cb2-4c6c-b447-e72cde58b8e1', 'rel': 'self'}], 'name': 'hs-b92c3aeb1ec84aff87e4cd07715a922e', 'notification_topics': None, 'outputs': None, 'owner_id': 'tripleo-ovb', 'parameters': None, 'parent_id': None, 'replaced': None, 'status': 'CREATE_FAILED', 'status_reason': 'Resource CREATE failed: ResourceInError: resources.master0: Went to status ERROR due to "Message: No valid host was found. There are not enough hosts available., Code: 500"', 'tags': None, 'template': None, 'template_description': None, 'template_url': None, 'timeout_mins': None, 'unchanged': None, 'updated': None, 'updated_at': None, 'user_project_id': '1d98a16095b1416abaa3a3984e8791d6', 'id': 'c667b398-3cb2-4c6c-b447-e72cde58b8e1'}], 'failed': False, 'attempts': 1} 2025-12-05 09:02:58.497486 | 2025-12-05 09:02:58.497769 | TASK [heat_stack : Stop if stack not complete] 2025-12-05 09:02:58.548238 | hotstack | ERROR 2025-12-05 09:02:58.548643 | hotstack | { 2025-12-05 09:02:58.548749 | hotstack | "msg": "Failing - stack create not complete in time, or failed" 2025-12-05 09:02:58.548800 | hotstack | } failure 2025-12-05 09:02:58.551721 | 2025-12-05 09:02:58.551820 | PLAY RECAP 2025-12-05 09:02:58.551906 | hotstack | ok: 14 changed: 6 unreachable: 0 failed: 1 skipped: 2 rescued: 0 ignored: 0 2025-12-05 09:02:58.551952 | 2025-12-05 09:02:58.679756 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-12-05 09:02:58.686956 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-12-05 09:02:59.299033 | 2025-12-05 09:02:59.299157 | PLAY [Collect hotstack logs and clean up environment] 2025-12-05 09:02:59.332573 | 2025-12-05 09:02:59.332704 | TASK [Fetch stack outputs from remote to zuul executor] 2025-12-05 09:03:00.030202 | hotstack | Output suppressed because no_log was given 2025-12-05 09:03:00.035684 | 2025-12-05 09:03:00.035802 | TASK [Print message that log collection failed] 2025-12-05 09:03:00.068099 | hotstack | ok: WARNING: Log collection failed and may be incomplete. Continue with cleanup ... 2025-12-05 09:03:00.075005 | 2025-12-05 09:03:00.075152 | TASK [Set _auth_type fact] 2025-12-05 09:03:00.139185 | hotstack | Output suppressed because no_log was given 2025-12-05 09:03:00.145111 | 2025-12-05 09:03:00.145207 | TASK [Write clouds.yaml] 2025-12-05 09:03:01.259553 | hotstack | Output suppressed because no_log was given 2025-12-05 09:03:01.271241 | 2025-12-05 09:03:01.271373 | TASK [Delete application credentials] 2025-12-05 09:03:03.319359 | hotstack | changed 2025-12-05 09:03:03.332808 | 2025-12-05 09:03:03.332992 | TASK [Print message that application credential failed to delete] 2025-12-05 09:03:03.362191 | hotstack | skipping: Conditional result was False 2025-12-05 09:03:03.376612 | 2025-12-05 09:03:03.376761 | TASK [Print message that application credential deleted successfully] 2025-12-05 09:03:03.429450 | hotstack | ok: Application credential deleted successfully. 2025-12-05 09:03:03.442454 | 2025-12-05 09:03:03.442555 | TASK [Write clouds.yaml with application credentials] 2025-12-05 09:03:03.476331 | 2025-12-05 09:03:03.476531 | TASK [Delete the heat stack] 2025-12-05 04:03:35.891347 | hotstack | 2025-12-05 09:03:05Z [hs-b92c3aeb1ec84aff87e4cd07715a922e]: DELETE_IN_PROGRESS Stack DELETE started 2025-12-05 04:03:35.891488 | hotstack | 2025-12-05 09:03:05Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891505 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891515 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol0]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891523 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol1]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891530 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-lvms-vol0]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891537 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol2]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891545 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891551 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-trunk0]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891557 | hotstack | 2025-12-05 09:03:06Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-ironic-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891563 | hotstack | 2025-12-05 09:03:07Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891569 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol1]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891575 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol0]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891581 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-cinder-vol2]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891587 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-ironic-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891593 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-lvms-vol0]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891599 | hotstack | 2025-12-05 09:03:08Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-floating-ip]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891605 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-trunk0]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891611 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-ctlplane-trunk-parent-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891617 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-tenant-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891623 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-internal-api-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891629 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-storage-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891635 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-net-router-interface]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891641 | hotstack | 2025-12-05 09:03:09Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic0]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891682 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-tenant-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891689 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-floating-ip]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891695 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-internal-api-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891701 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-net-router-interface]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891707 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-ctlplane-trunk-parent-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891724 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-storage-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891731 | hotstack | 2025-12-05 09:03:10Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic1]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891737 | hotstack | 2025-12-05 09:03:11Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-net-router-interface]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891745 | hotstack | 2025-12-05 09:03:11Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891751 | hotstack | 2025-12-05 09:03:12Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-net-router-interface]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891757 | hotstack | 2025-12-05 09:03:12Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.router]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.891763 | hotstack | 2025-12-05 09:03:14Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.router]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.891776 | hotstack | 2025-12-05 09:03:15Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic0]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892302 | hotstack | 2025-12-05 09:03:15Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic0-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892319 | hotstack | 2025-12-05 09:03:16Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic0-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892328 | hotstack | 2025-12-05 09:03:17Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic1]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892339 | hotstack | 2025-12-05 09:03:17Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic1-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892347 | hotstack | 2025-12-05 09:03:18Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic1-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892359 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892365 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-init]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892371 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.storage-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892377 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892383 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892389 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-init]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892395 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.internal-api-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892401 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.tenant-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892407 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-write-files]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892413 | hotstack | 2025-12-05 09:03:30Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-runcmd]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892421 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller_users]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892429 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-write-files]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892435 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-runcmd]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892441 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller_users]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892447 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-machine-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.892453 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.storage-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892459 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892471 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.internal-api-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.892493 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967460 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967537 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.storage-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967545 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.internal-api-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967574 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967591 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.master0-machine-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967598 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.extra-dhcp-opts-value]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967713 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.extra-dhcp-opts-value]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967724 | hotstack | 2025-12-05 09:03:31Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-machine-port]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967730 | hotstack | 2025-12-05 09:03:32Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.tenant-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967738 | hotstack | 2025-12-05 09:03:32Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.storage-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967746 | hotstack | 2025-12-05 09:03:32Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.tenant-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967754 | hotstack | 2025-12-05 09:03:32Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.controller-machine-port]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967762 | hotstack | 2025-12-05 09:03:32Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-subnet]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967770 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ironic-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967776 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.ctlplane-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967782 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.internal-api-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967788 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-subnet]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967794 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.tenant-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967800 | hotstack | 2025-12-05 09:03:33Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-net]: DELETE_IN_PROGRESS state changed 2025-12-05 04:03:35.967807 | hotstack | 2025-12-05 09:03:34Z [hs-b92c3aeb1ec84aff87e4cd07715a922e.machine-net]: DELETE_COMPLETE state changed 2025-12-05 04:03:35.967813 | hotstack | 2025-12-05 09:03:34Z [hs-b92c3aeb1ec84aff87e4cd07715a922e]: DELETE_COMPLETE Stack DELETE completed successfully 2025-12-05 09:03:36.522872 | hotstack | changed 2025-12-05 09:03:36.536723 | 2025-12-05 09:03:36.536863 | TASK [Print message that stack failed to delete] 2025-12-05 09:03:36.565463 | hotstack | skipping: Conditional result was False 2025-12-05 09:03:36.578481 | 2025-12-05 09:03:36.578649 | TASK [Print message that stack deleted successfully] 2025-12-05 09:03:36.614387 | hotstack | ok: Stack deleted successfully. 2025-12-05 09:03:36.619130 | 2025-12-05 09:03:36.619190 | TASK [Delete clouds.yaml] 2025-12-05 09:03:37.004262 | hotstack | Output suppressed because no_log was given 2025-12-05 09:03:37.040698 | 2025-12-05 09:03:37.040821 | PLAY RECAP 2025-12-05 09:03:37.040877 | hotstack | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 3 rescued: 1 ignored: 0 2025-12-05 09:03:37.040905 | 2025-12-05 09:03:37.146984 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-12-05 09:03:37.156313 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-05 09:03:37.728894 | 2025-12-05 09:03:37.729000 | PLAY [all] 2025-12-05 09:03:37.747557 | 2025-12-05 09:03:37.747633 | TASK [include_role : fetch-output] 2025-12-05 09:03:37.797122 | hotstack | ok 2025-12-05 09:03:37.813568 | 2025-12-05 09:03:37.813643 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-05 09:03:37.879848 | hotstack | skipping: Conditional result was False 2025-12-05 09:03:37.892870 | 2025-12-05 09:03:37.893040 | TASK [fetch-output : Set log path for single node] 2025-12-05 09:03:37.941113 | hotstack | ok 2025-12-05 09:03:37.952050 | 2025-12-05 09:03:37.952191 | LOOP [fetch-output : Ensure local output dirs] 2025-12-05 09:03:38.393118 | hotstack -> localhost | ok: "/var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/logs" 2025-12-05 09:03:38.617908 | hotstack -> localhost | changed: "/var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/artifacts" 2025-12-05 09:03:38.856787 | hotstack -> localhost | changed: "/var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/docs" 2025-12-05 09:03:38.893520 | 2025-12-05 09:03:38.893817 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-05 09:03:39.648994 | hotstack | changed: .d..t...... ./ 2025-12-05 09:03:39.649361 | hotstack | changed: All items complete 2025-12-05 09:03:39.649423 | 2025-12-05 09:03:40.211873 | hotstack | changed: .d..t...... ./ 2025-12-05 09:03:40.745283 | hotstack | changed: .d..t...... ./ 2025-12-05 09:03:40.770854 | 2025-12-05 09:03:40.771086 | TASK [include_role : fetch-output-openshift] 2025-12-05 09:03:40.798337 | hotstack | skipping: Conditional result was False 2025-12-05 09:03:40.812528 | 2025-12-05 09:03:40.812676 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-05 09:03:41.337358 | hotstack -> localhost | ok: Item: artifacts Runtime: 0:00:00.013226 2025-12-05 09:03:41.610045 | hotstack -> localhost | ok: Item: docs Runtime: 0:00:00.010742 2025-12-05 09:03:41.641909 | 2025-12-05 09:03:41.642058 | PLAY [all] 2025-12-05 09:03:41.656965 | 2025-12-05 09:03:41.657069 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-05 09:03:42.204580 | hotstack | changed 2025-12-05 09:03:42.251915 | 2025-12-05 09:03:42.252000 | PLAY RECAP 2025-12-05 09:03:42.252088 | hotstack | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-12-05 09:03:42.252123 | 2025-12-05 09:03:42.361768 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-05 09:03:42.366255 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-12-05 09:03:43.012928 | 2025-12-05 09:03:43.013120 | PLAY [localhost] 2025-12-05 09:03:43.032060 | 2025-12-05 09:03:43.032147 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-05 09:03:43.459085 | localhost | changed 2025-12-05 09:03:43.465777 | 2025-12-05 09:03:43.465880 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-05 09:03:43.486446 | localhost | ok 2025-12-05 09:03:43.494301 | 2025-12-05 09:03:43.494365 | TASK [add-fileserver : Create SSH private key tempfile] 2025-12-05 09:03:43.888585 | localhost | changed 2025-12-05 09:03:43.894398 | 2025-12-05 09:03:43.894495 | TASK [add-fileserver : Create SSH private key from secret] 2025-12-05 09:03:44.687071 | localhost | changed 2025-12-05 09:03:44.692087 | 2025-12-05 09:03:44.692154 | TASK [add-fileserver : Add fileserver ssh key] 2025-12-05 09:03:45.212262 | localhost | Identity added: /var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/tmp/ansible.hob4583u (/var/lib/zuul/builds/b92c3aeb1ec84aff87e4cd07715a922e/work/tmp/ansible.hob4583u) 2025-12-05 09:03:45.212483 | localhost | ok: Runtime: 0:00:00.013589 2025-12-05 09:03:45.218416 | 2025-12-05 09:03:45.218506 | TASK [add-fileserver : Remove SSH private key from disk] 2025-12-05 09:03:45.587527 | localhost | ok: Runtime: 0:00:00.009264 2025-12-05 09:03:45.598972 | 2025-12-05 09:03:45.599148 | TASK [add-fileserver : Add fileserver to inventory] 2025-12-05 09:03:45.686273 | localhost | changed 2025-12-05 09:03:45.695611 | 2025-12-05 09:03:45.695752 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-12-05 09:03:46.229658 | localhost | changed 2025-12-05 09:03:46.259715 | 2025-12-05 09:03:46.259822 | PLAY [localhost] 2025-12-05 09:03:46.300090 | 2025-12-05 09:03:46.300183 | TASK [Generate bulk log download script] 2025-12-05 09:03:46.328419 | localhost | ok 2025-12-05 09:03:46.340315 | 2025-12-05 09:03:46.340382 | TASK [local-log-download : Check API endpoint is defined] 2025-12-05 09:03:46.385698 | localhost | ok: All assertions passed 2025-12-05 09:03:46.390636 | 2025-12-05 09:03:46.390701 | TASK [local-log-download : Create download script] 2025-12-05 09:03:46.897068 | localhost -> localhost | changed 2025-12-05 09:03:46.906697 | 2025-12-05 09:03:46.906776 | TASK [Register quick-download link] 2025-12-05 09:03:46.931536 | localhost | ok 2025-12-05 09:03:46.946497 | 2025-12-05 09:03:46.946557 | PLAY [logserver.rdoproject.org] 2025-12-05 09:03:46.955992 | 2025-12-05 09:03:46.956092 | TASK [Set zuul-log-path fact] 2025-12-05 09:03:46.972235 | logserver.rdoproject.org | ok 2025-12-05 09:03:46.981106 | 2025-12-05 09:03:46.981172 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-05 09:03:47.008609 | logserver.rdoproject.org | ok 2025-12-05 09:03:47.013779 | 2025-12-05 09:03:47.013907 | TASK [upload-logs : Create log directories] 2025-12-05 09:03:47.847979 | logserver.rdoproject.org | changed 2025-12-05 09:03:47.851377 | 2025-12-05 09:03:47.851441 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-05 09:03:48.171915 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005365 2025-12-05 09:03:48.176723 | 2025-12-05 09:03:48.176786 | TASK [upload-logs : Upload logs to log server] 2025-12-05 09:03:48.874147 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-12-05 09:03:48.880742 | 2025-12-05 09:03:48.880879 | LOOP [upload-logs : Compress console log and json output] 2025-12-05 09:03:48.927188 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 09:03:48.935294 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 09:03:48.945425 | 2025-12-05 09:03:48.945517 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-05 09:03:48.984609 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 09:03:48.984832 | 2025-12-05 09:03:48.987715 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-05 09:03:48.994107 | 2025-12-05 09:03:48.994176 | LOOP [upload-logs : Upload console log and json output]